aic-P35-DS3L aic # /usr/sbin/easycwmpd -b -f 2016-12-01 18:02:25 [easycwmp] NOTICE - external script init config_init_local(55):: easycwmp.@local[0].interface=enp4s0 config_init_local(65):: easycwmp.@local[0].port=7547 config_init_local(83):: easycwmp.@local[0].ubus_socket=/var/run/ubus.sock config_init_local(77):: easycwmp.@local[0].password=easycwmp config_init_local(94):: easycwmp.@local[0].logging_level=3 config_init_local(71):: easycwmp.@local[0].username=easycwmp config_init_acs(159):: easycwmp.@acs[0].url=http://192.168.1.8:8080/tr069 config_init_acs(165):: easycwmp.@acs[0].username=admin config_init_acs(171):: easycwmp.@acs[0].password=xaps config_init_acs(183):: easycwmp.@acs[0].periodic_interval=87267 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute update_value_change 2016-12-01 18:02:25 [easycwmp] NOTICE - daemon started 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute inform device_id 2016-12-01 18:02:25 [easycwmp] NOTICE - external script exit 2016-12-01 18:02:25 [easycwmp] NOTICE - add event '1 BOOT' 2016-12-01 18:02:25 [easycwmp] NOTICE - interface enp4s0 has ip 192.168.1.8 +++ HTTP SERVER CONFIGURATION +++ ip: '192.168.1.8' port: '7547' --- HTTP SERVER CONFIGURATION --- 2016-12-01 18:02:25 [easycwmp] NOTICE - http server initialized 2016-12-01 18:02:25 [easycwmp] NOTICE - entering main loop 2016-12-01 18:02:25 [easycwmp] NOTICE - start session +++ HTTP CLIENT CONFIGURATION +++ http_client_init(50):: url: http://192.168.1.8:8080/tr069 http_client_init(56):: ssl_verify: SSL certificate validation disabled. --- HTTP CLIENT CONFIGURATION --- 2016-12-01 18:02:25 [easycwmp] NOTICE - configured acs url http://192.168.1.8:8080/tr069 2016-12-01 18:02:25 [easycwmp] NOTICE - external script init 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute inform parameter 2016-12-01 18:02:25 [easycwmp] NOTICE - send Inform +++ SEND HTTP REQUEST +++ 1 nanopulse2 TEST2 nanopulse2_device FFFFFF2354346 1 BOOT 1 2016-12-01T18:02:25+03:00 0 Device.DeviceInfo.HardwareVersion example2_hw_version Device.DeviceInfo.Manufacturer nanopulse2 Device.DeviceInfo.ManufacturerOUI TEST2 Device.DeviceInfo.ProductClass nanopulse2_device Device.DeviceInfo.ProvisioningCode Device.DeviceInfo.SerialNumber FFFFFF2354346 Device.DeviceInfo.SoftwareVersion example2_sw_version Device.DeviceInfo.SpecVersion 1.0 Device.ManagementServer.ConnectionRequestURL http://192.168.1.8:7547/ Device.ManagementServer.ParameterKey 8d9740897fae4359048a5890e0ea26ec --- SEND HTTP REQUEST --- * Trying 192.168.1.8... * Connected to 192.168.1.8 (192.168.1.8) port 8080 (#0) > POST /tr069 HTTP/1.1 Host: 192.168.1.8:8080 User-Agent: easycwmp Content-Type: text/xml; charset="utf-8" SOAPAction: Content-Length: 2778 Expect: 100-continue < HTTP/1.1 100 Continue * We are completely uploaded and fine < HTTP/1.1 401 Unauthorized < Server: Apache-Coyote/1.1 * Added cookie JSESSIONID="DAC6646A57162AD2EF0CEA463B82AD2F" for domain 192.168.1.8, path /tr069/, expire 0 < Set-Cookie: JSESSIONID=DAC6646A57162AD2EF0CEA463B82AD2F; Path=/tr069/; HttpOnly < WWW-Authenticate: Basic realm="xaps" < Content-Type: text/html;charset=utf-8 < Content-Language: en < Content-Length: 969 < Date: Thu, 01 Dec 2016 15:02:25 GMT < Connection: close < * Closing connection 0 * Issue another request to this URL: 'http://192.168.1.8:8080/tr069' * Hostname 192.168.1.8 was found in DNS cache * Trying 192.168.1.8... * Connected to 192.168.1.8 (192.168.1.8) port 8080 (#1) * Server auth using Basic with user 'admin' > POST /tr069 HTTP/1.1 Host: 192.168.1.8:8080 Authorization: Basic YWRtaW46eGFwcw== Cookie: JSESSIONID=DAC6646A57162AD2EF0CEA463B82AD2F User-Agent: easycwmp Content-Type: text/xml; charset="utf-8" Content-Length: 2778 Expect: 100-continue < HTTP/1.1 100 Continue * We are completely uploaded and fine < HTTP/1.1 200 OK < Server: Apache-Coyote/1.1 < SOAPAction: < Content-Type: text/xml;charset=ISO-8859-1 < Content-Length: 491 < Date: Thu, 01 Dec 2016 15:02:25 GMT < * Connection #1 to host 192.168.1.8 left intact +++ RECEIVED HTTP RESPONSE +++ 1 1 --- RECEIVED HTTP RESPONSE --- 2016-12-01 18:02:25 [easycwmp] NOTICE - receive InformResponse from the ACS 2016-12-01 18:02:25 [easycwmp] NOTICE - send empty message to the ACS +++ SEND EMPTY HTTP REQUEST +++ * Found bundle for host 192.168.1.8: 0x1d754f0 [can pipeline] * Re-using existing connection! (#1) with host 192.168.1.8 * Connected to 192.168.1.8 (192.168.1.8) port 8080 (#1) * Server auth using Basic with user 'admin' > POST /tr069 HTTP/1.1 Host: 192.168.1.8:8080 Authorization: Basic YWRtaW46eGFwcw== Cookie: JSESSIONID=DAC6646A57162AD2EF0CEA463B82AD2F User-Agent: easycwmp Content-Type: text/xml; charset="utf-8" Content-Length: 0 < HTTP/1.1 200 OK < Server: Apache-Coyote/1.1 < SOAPAction: < Content-Type: text/xml;charset=ISO-8859-1 < Content-Length: 1229 < Date: Thu, 01 Dec 2016 15:02:25 GMT < * Connection #1 to host 192.168.1.8 left intact +++ RECEIVED HTTP RESPONSE +++ OWERA-1480604545603 Device.DeviceInfo.SerialNumber Device.DeviceInfo.SoftwareVersion Device.DeviceInfo.UpTime Device.DeviceInfo.VendorConfigFile. Device.ManagementServer.ConnectionRequestPassword Device.ManagementServer.ConnectionRequestURL Device.ManagementServer.ConnectionRequestUsername Device.ManagementServer.Password Device.ManagementServer.PeriodicInformEnable Device.ManagementServer.PeriodicInformInterval Device.ManagementServer.PeriodicInformTime --- RECEIVED HTTP RESPONSE --- 2016-12-01 18:02:25 [easycwmp] NOTICE - received GetParameterValues method from the ACS 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.DeviceInfo.SerialNumber 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.DeviceInfo.SoftwareVersion 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.DeviceInfo.UpTime 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.DeviceInfo.VendorConfigFile. 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.ManagementServer.ConnectionRequestPassword 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.ManagementServer.ConnectionRequestURL 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.ManagementServer.ConnectionRequestUsername 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.ManagementServer.Password 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.ManagementServer.PeriodicInformEnable 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.ManagementServer.PeriodicInformInterval 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute get value Device.ManagementServer.PeriodicInformTime 2016-12-01 18:02:25 [easycwmp] NOTICE - send GetParameterValuesResponse to the ACS +++ SEND HTTP REQUEST +++ OWERA-1480604545603 Device.DeviceInfo.SerialNumber FFFFFF2354346 Device.DeviceInfo.SoftwareVersion example2_sw_version Device.DeviceInfo.UpTime 15760 Device.ManagementServer.ConnectionRequestPassword Device.ManagementServer.ConnectionRequestURL http://192.168.1.8:7547/ Device.ManagementServer.ConnectionRequestUsername easycwmp Device.ManagementServer.Password Device.ManagementServer.PeriodicInformEnable Device.ManagementServer.PeriodicInformInterval 87267 Device.ManagementServer.PeriodicInformTime --- SEND HTTP REQUEST --- * Found bundle for host 192.168.1.8: 0x1d754f0 [can pipeline] * Re-using existing connection! (#1) with host 192.168.1.8 * Connected to 192.168.1.8 (192.168.1.8) port 8080 (#1) * Server auth using Basic with user 'admin' > POST /tr069 HTTP/1.1 Host: 192.168.1.8:8080 Authorization: Basic YWRtaW46eGFwcw== Cookie: JSESSIONID=DAC6646A57162AD2EF0CEA463B82AD2F User-Agent: easycwmp Content-Type: text/xml; charset="utf-8" SOAPAction: Content-Length: 2359 Expect: 100-continue < HTTP/1.1 100 Continue * We are completely uploaded and fine < HTTP/1.1 200 OK < Server: Apache-Coyote/1.1 < SOAPAction: < Content-Type: text/xml;charset=ISO-8859-1 < Content-Length: 983 < Date: Thu, 01 Dec 2016 15:02:25 GMT < * Connection #1 to host 192.168.1.8 left intact +++ RECEIVED HTTP RESPONSE +++ OWERA-1480604545727 Device.ManagementServer.ConnectionRequestPassword easycwmp Device.ManagementServer.PeriodicInformInterval 75657 8d9740897fae4359048a5890e0ea26ec --- RECEIVED HTTP RESPONSE --- 2016-12-01 18:02:25 [easycwmp] NOTICE - received SetParameterValues method from the ACS 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute set value Device.ManagementServer.ConnectionRequestPassword easycwmp 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute set value Device.ManagementServer.PeriodicInformInterval 75657 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute apply value 8d9740897fae4359048a5890e0ea26ec 2016-12-01 18:02:25 [easycwmp] NOTICE - send SetParameterValuesResponse to the ACS +++ SEND HTTP REQUEST +++ OWERA-1480604545727 1 --- SEND HTTP REQUEST --- * Found bundle for host 192.168.1.8: 0x1d754f0 [can pipeline] * Re-using existing connection! (#1) with host 192.168.1.8 * Connected to 192.168.1.8 (192.168.1.8) port 8080 (#1) * Server auth using Basic with user 'admin' > POST /tr069 HTTP/1.1 Host: 192.168.1.8:8080 Authorization: Basic YWRtaW46eGFwcw== Cookie: JSESSIONID=DAC6646A57162AD2EF0CEA463B82AD2F User-Agent: easycwmp Content-Type: text/xml; charset="utf-8" SOAPAction: Content-Length: 600 * upload completely sent off: 600 out of 600 bytes < HTTP/1.1 204 No Content < Server: Apache-Coyote/1.1 < Connection: close < Date: Thu, 01 Dec 2016 15:02:25 GMT < * Closing connection 1 +++ RECEIVED EMPTY HTTP RESPONSE +++ 2016-12-01 18:02:25 [easycwmp] NOTICE - receive empty message from the ACS 2016-12-01 18:02:25 [easycwmp] NOTICE - end session: configuration reload config_init_local(55):: easycwmp.@local[0].interface=enp4s0 config_init_local(65):: easycwmp.@local[0].port=7547 config_init_local(83):: easycwmp.@local[0].ubus_socket=/var/run/ubus.sock config_init_local(77):: easycwmp.@local[0].password=easycwmp config_init_local(94):: easycwmp.@local[0].logging_level=3 config_init_local(71):: easycwmp.@local[0].username=easycwmp config_init_acs(159):: easycwmp.@acs[0].url=http://192.168.1.8:8080/tr069 config_init_acs(165):: easycwmp.@acs[0].username=admin config_init_acs(171):: easycwmp.@acs[0].password=xaps config_init_acs(183):: easycwmp.@acs[0].periodic_interval=75657 2016-12-01 18:02:25 [easycwmp] NOTICE - external: execute update_value_change 2016-12-01 18:02:26 [easycwmp] NOTICE - external: execute apply service 2016-12-01 18:02:26 [easycwmp] NOTICE - external script exit 2016-12-01 18:02:26 [easycwmp] NOTICE - end session success +++ RECEIVED HTTP REQUEST +++ http_digest_auth_fail_response(335):: http_digest_auth_fail_response: header: Digest realm="realm@easycwmp",qop="auth",nonce="a0be4795680aa38aa208fb27d6a7075000003d98",opaque="328458fab28345ae87ab3210a8513b14eff452a2"--- RECEIVED HTTP REQUEST --- +++ HTTP SERVER CONNECTION FAILED +++ +++ RECEIVED HTTP REQUEST +++ http_digest_auth_fail_response(335):: http_digest_auth_fail_response: header: Digest realm="realm@easycwmp",qop="auth",nonce="3cfb2e1604c2c96d117f85921c04728a00003d99",opaque="328458fab28345ae87ab3210a8513b14eff452a2"--- RECEIVED HTTP REQUEST --- +++ HTTP SERVER CONNECTION FAILED +++ +++ RECEIVED HTTP REQUEST +++ http_digest_auth_fail_response(335):: http_digest_auth_fail_response: header: Digest realm="realm@easycwmp",qop="auth",nonce="66c63187f730a5abc50e92e51f1e5ab700003d9a",opaque="328458fab28345ae87ab3210a8513b14eff452a2"--- RECEIVED HTTP REQUEST ---