easycwmp Log
root@yjkwon-VirtualBox:~/tmp# rm /tmp/yj.log ; easycwmpd -f -b
2016-09-07 21:14:32 [easycwmp] NOTICE - add event '0 BOOTSTRAP'
2016-09-07 21:14:32 [easycwmp] NOTICE - add event '1 BOOT'
2016-09-07 21:14:32 [easycwmp] NOTICE - add event '2 PERIODIC'
2016-09-07 21:14:32 [easycwmp] NOTICE - external script init
config_init_local(55):: easycwmp.@local[0].interface=eth0
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(71):: easycwmp.@local[0].username=easycwmp
config_init_local(77):: easycwmp.@local[0].password=easycwmp
config_init_local(94):: easycwmp.@local[0].logging_level=3
config_init_acs(159):: easycwmp.@acs[0].url=http://192.168.3.145:80/web
config_init_acs(165):: easycwmp.@acs[0].username=admin
config_init_acs(171):: easycwmp.@acs[0].password=xaps
config_init_acs(177):: easycwmp.@acs[0].periodic_enable=1
config_init_acs(183):: easycwmp.@acs[0].periodic_interval=100
config_init_acs(190):: easycwmp.@acs[0].periodic_time=0001-01-01T00:00:00Z
2016-09-07 21:14:32 [easycwmp] NOTICE - init periodic inform: reference time = -62135627272, interval = 100
2016-09-07 21:14:32 [easycwmp] NOTICE - external: execute update_value_change
2016-09-07 21:14:32 [easycwmp] NOTICE - daemon started
2016-09-07 21:14:32 [easycwmp] NOTICE - external: execute inform device_id
2016-09-07 21:14:32 [easycwmp] NOTICE - external script exit
2016-09-07 21:14:32 [easycwmp] NOTICE - add event '1 BOOT'
2016-09-07 21:14:32 [easycwmp] NOTICE - interface eth0 has ip 192.168.2.145
main(320): ubus initialization failed
+++ HTTP SERVER CONFIGURATION +++
ip: '192.168.2.145'
port: '7547'
--- HTTP SERVER CONFIGURATION ---
2016-09-07 21:14:32 [easycwmp] NOTICE - http server initialized
2016-09-07 21:14:32 [easycwmp] NOTICE - entering main loop
2016-09-07 21:14:32 [easycwmp] NOTICE - start session
+++ HTTP CLIENT CONFIGURATION +++
http_client_init(50):: url: http://192.168.3.145:80/web
http_client_init(56):: ssl_verify: SSL certificate validation disabled.
--- HTTP CLIENT CONFIGURATION ---
2016-09-07 21:14:32 [easycwmp] NOTICE - configured acs url http://192.168.3.145:80/web
2016-09-07 21:14:32 [easycwmp] NOTICE - external script init
2016-09-07 21:14:32 [easycwmp] NOTICE - external: execute inform parameter
2016-09-07 21:14:32 [easycwmp] NOTICE - send Inform
+++ SEND HTTP REQUEST +++
1
easycwmp
easycwmp
easycwmp
FFFFFF123456
0 BOOTSTRAP
1 BOOT
2 PERIODIC
1
2016-09-07T21:14:32+09:00
0
InternetGatewayDevice.DeviceInfo.HardwareVersion
example_hw_version
InternetGatewayDevice.DeviceInfo.Manufacturer
easycwmp
InternetGatewayDevice.DeviceInfo.ManufacturerOUI
easycwmp
InternetGatewayDevice.DeviceInfo.ProductClass
easycwmp
InternetGatewayDevice.DeviceInfo.ProvisioningCode
1234567890
InternetGatewayDevice.DeviceInfo.SerialNumber
FFFFFF123456
InternetGatewayDevice.DeviceInfo.SoftwareVersion
example_sw_version
InternetGatewayDevice.DeviceInfo.SpecVersion
1.0
InternetGatewayDevice.ManagementServer.ConnectionRequestURL
http://192.168.2.145:7547/
InternetGatewayDevice.ManagementServer.ParameterKey
InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.1.ExternalIPAddress
192.168.2.145
--- SEND HTTP REQUEST ---
* Hostname was NOT found in DNS cache
* Trying 192.168.3.145...
* Connected to 192.168.3.145 (192.168.3.145) port 80 (#0)
> POST /web HTTP/1.1
Host: 192.168.3.145
User-Agent: easycwmp
Content-Type: text/xml; charset="utf-8"
SOAPAction:
Content-Length: 3314
Expect: 100-continue
< HTTP/1.1 100 Continue
< HTTP/1.1 302 Found
* Server Apache-Coyote/1.1 is not blacklisted
< Server: Apache-Coyote/1.1
< Location: http://192.168.3.145/web/
< Content-Length: 0
< Date: Wed, 07 Sep 2016 12:14:32 GMT
* HTTP error before end of send, stop sending
<
* Closing connection 0
+++ HTTP CLIENT CONFIGURATION +++
http_client_init(50):: url: http://192.168.3.145/web/
http_client_init(56):: ssl_verify: SSL certificate validation disabled.
--- HTTP CLIENT CONFIGURATION ---
2016-09-07 21:14:32 [easycwmp] NOTICE - configured acs url http://192.168.3.145/web/
+++ SEND HTTP REQUEST +++
1
easycwmp
easycwmp
easycwmp
FFFFFF123456
0 BOOTSTRAP
1 BOOT
2 PERIODIC
1
2016-09-07T21:14:32+09:00
0
InternetGatewayDevice.DeviceInfo.HardwareVersion
example_hw_version
InternetGatewayDevice.DeviceInfo.Manufacturer
easycwmp
InternetGatewayDevice.DeviceInfo.ManufacturerOUI
easycwmp
InternetGatewayDevice.DeviceInfo.ProductClass
easycwmp
InternetGatewayDevice.DeviceInfo.ProvisioningCode
1234567890
InternetGatewayDevice.DeviceInfo.SerialNumber
FFFFFF123456
InternetGatewayDevice.DeviceInfo.SoftwareVersion
example_sw_version
InternetGatewayDevice.DeviceInfo.SpecVersion
1.0
InternetGatewayDevice.ManagementServer.ConnectionRequestURL
http://192.168.2.145:7547/
InternetGatewayDevice.ManagementServer.ParameterKey
InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.1.ExternalIPAddress
192.168.2.145
--- SEND HTTP REQUEST ---
* Hostname was NOT found in DNS cache
* Trying 192.168.3.145...
* Connected to 192.168.3.145 (192.168.3.145) port 80 (#1)
> POST /web/ HTTP/1.1
Host: 192.168.3.145
User-Agent: easycwmp
Content-Type: text/xml; charset="utf-8"
SOAPAction:
Content-Length: 3314
Expect: 100-continue
< HTTP/1.1 100 Continue
< HTTP/1.1 302 Found
* Server Apache-Coyote/1.1 is not blacklisted
< Server: Apache-Coyote/1.1
* Added cookie JSESSIONID="D6DB809F396BE31E58957FB5B330A362" for domain 192.168.3.145, path /, expire 0
< Set-Cookie: JSESSIONID=D6DB809F396BE31E58957FB5B330A362; Path=/
< Location: http://192.168.3.145/web/login
< Content-Length: 0
< Date: Wed, 07 Sep 2016 12:14:32 GMT
* HTTP error before end of send, stop sending
<
* Closing connection 1
+++ HTTP CLIENT CONFIGURATION +++
http_client_init(50):: url: http://192.168.3.145/web/login
http_client_init(56):: ssl_verify: SSL certificate validation disabled.
--- HTTP CLIENT CONFIGURATION ---
2016-09-07 21:14:32 [easycwmp] NOTICE - configured acs url http://192.168.3.145/web/login
+++ SEND HTTP REQUEST +++
1
easycwmp
easycwmp
easycwmp
FFFFFF123456
0 BOOTSTRAP
1 BOOT
2 PERIODIC
1
2016-09-07T21:14:32+09:00
0
InternetGatewayDevice.DeviceInfo.HardwareVersion
example_hw_version
InternetGatewayDevice.DeviceInfo.Manufacturer
easycwmp
InternetGatewayDevice.DeviceInfo.ManufacturerOUI
easycwmp
InternetGatewayDevice.DeviceInfo.ProductClass
easycwmp
InternetGatewayDevice.DeviceInfo.ProvisioningCode
1234567890
InternetGatewayDevice.DeviceInfo.SerialNumber
FFFFFF123456
InternetGatewayDevice.DeviceInfo.SoftwareVersion
example_sw_version
InternetGatewayDevice.DeviceInfo.SpecVersion
1.0
InternetGatewayDevice.ManagementServer.ConnectionRequestURL
http://192.168.2.145:7547/
InternetGatewayDevice.ManagementServer.ParameterKey
InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.1.ExternalIPAddress
192.168.2.145
--- SEND HTTP REQUEST ---
* Hostname was NOT found in DNS cache
* Trying 192.168.3.145...
* Connected to 192.168.3.145 (192.168.3.145) port 80 (#2)
> POST /web/login HTTP/1.1
Host: 192.168.3.145
User-Agent: easycwmp
Content-Type: text/xml; charset="utf-8"
SOAPAction:
Content-Length: 3314
Expect: 100-continue
< HTTP/1.1 100 Continue
< HTTP/1.1 200 OK
* Server Apache-Coyote/1.1 is not blacklisted
< Server: Apache-Coyote/1.1
* Added cookie JSESSIONID="C9B2C1AE3EFA5DC6C7CC1E07BD35718B" for domain 192.168.3.145, path /, expire 0
< Set-Cookie: JSESSIONID=C9B2C1AE3EFA5DC6C7CC1E07BD35718B; Path=/
< Content-Type: text/html;charset=utf-8
< Transfer-Encoding: chunked
< Date: Wed, 07 Sep 2016 12:14:32 GMT
<
* Connection #2 to host 192.168.3.145 left intact
+++ RECEIVED HTTP RESPONSE +++
FreeACS Web Web | login
--- RECEIVED HTTP RESPONSE ---
mxml: Mismatched close tag under parent !
rpc_inform(229): parse Inform xml message from ACS failed
2016-09-07 21:14:32 [easycwmp] NOTICE - sending Inform failed
2016-09-07 21:14:32 [easycwmp] NOTICE - external: execute apply service
2016-09-07 21:14:32 [easycwmp] NOTICE - external script exit
2016-09-07 21:14:32 [easycwmp] NOTICE - end session failed
2016-09-07 21:14:32 [easycwmp] NOTICE - retry session in 7 sec, RetryCount = 1
^C2016-09-07 21:14:34 [easycwmp] NOTICE - exiting