| View Issue Details [ Jump to Notes ] | [ Issue History ] [ Print ] |
| ID | Project | Category | View Status | Date Submitted | Last Update |
| 0000396 | easycwmp | [All Projects] Help | public | 2019-11-29 04:01 | 2020-08-27 10:44 |
|
| Reporter | andy1019 | |
| Assigned To | | |
| Priority | urgent | Severity | major | Reproducibility | always |
| Status | new | Resolution | open | |
| Platform | easycwmp and genieACS(Ubuntu18) | OS | | OS Version | |
|
| Summary | 0000396: Easycwmp cannot connect GenieACS |
| Description | [Easycwmp setup]
config local
option enable ‘1’
option interface eth0
option port 7547
option ubus_socket /var/run/ubus.sock
option date_format %FT%T%z
option username easycwmp
option password easycwmp
option provisioning_code ‘’
#basic authentication = ‘Basic’, Digest authentication = ‘Digest’, Default value = ‘Digest’
option authentication ‘Digest’
#Logging levels: Critic=0, Warning=1, Notice=2, Info=3, Debug=4
option logging_level ‘3’
config acs
option url http://192.168.2.100:7547 [^]
option parameter_key ‘1’
option periodic_enable ‘true’
option periodic_interval ‘100’
option periodic_time ‘0001-01-01T00:00:00Z’
After I issued "easycwmpd -f -b", and tried to connect ACS, the logs show,
* Connection #0 to host 192.168.2.100 left intact
+++ RECEIVED HTTP RESPONSE +++
<?xml version="1.0" encoding="UTF-8"?>
<soap-env:Envelope xmlns:soap-enc="http://schemas.xmlsoap.org/soap/encoding/" [^] xmlns:soap-env="http://schemas.xmlsoap.org/soap/envelope/" [^] xmlns:xsd="http://www.w3.org/2001/XMLSchema" [^] xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" [^] xmlns:cwmp="urn:dslforum-org:cwmp-1-2"><soap-env:Header><cwmp:ID soap-env:mustUnderstand="1">1</cwmp:ID></soap-env:Header><soap-env:Body><cwmp:InformResponse><MaxEnvelopes>1</MaxEnvelopes></cwmp:InformResponse></soap-env:Body></soap-env:Envelope>
--- RECEIVED HTTP RESPONSE ---
2019-11-29 10:15:48 [easycwmp] NOTICE - receive InformResponse from the ACS
2019-11-29 10:15:48 [easycwmp] NOTICE - send empty message to the ACS
+++ SEND EMPTY HTTP REQUEST +++
* Found bundle for host 192.168.2.100: 0xd831df0
* Re-using existing connection! (#0) with host 192.168.2.100
* Connected to 192.168.2.100 (192.168.2.100) port 7547 (#0)
> POST / HTTP/1.1
Host: 192.168.2.100:7547
User-Agent: easycwmp
Content-Type: text/xml; charset="utf-8"
Content-Length: 0
* The requested URL returned error: 400 Bad Request
* Closing connection 0
2019-11-29 10:15:50 [easycwmp] NOTICE - LibCurl Error: The requested URL returned error: 400 Bad Request
Please share your information, Thanks. |
| Tags | No tags attached. |
|
| Attached Files |  easycwmp_log.txt [^] (7,186 bytes) 2019-11-29 04:01 [Show Content] [Hide Content]/ # easycwmpd -f -b
2019-11-29 10:15:47 [easycwmp] NOTICE - external script init
config_init_local(59):: easycwmp.@local[0].interface=eth0
config_init_local(69):: easycwmp.@local[0].port=7547
config_init_local(87):: easycwmp.@local[0].ubus_socket=/var/run/ubus.sock
config_init_local(75):: easycwmp.@local[0].username=easycwmp
config_init_local(81):: easycwmp.@local[0].password=easycwmp
config_init_local(98):: easycwmp.@local[0].logging_level=4
config_init_acs(174):: easycwmp.@acs[0].url=http://192.168.2.100:7547
config_init_acs(180):: easycwmp.@acs[0].username=easycwmp
config_init_acs(186):: easycwmp.@acs[0].password=easycwmp
config_init_acs(192):: easycwmp.@acs[0].periodic_enable=0
config_init_acs(198):: easycwmp.@acs[0].periodic_interval=100
config_init_acs(205):: easycwmp.@acs[0].periodic_time=0001-01-01T00:00:00Z
2019-11-29 10:15:47 [easycwmp] NOTICE - external: execute update_value_change
2019-11-29 10:15:47 [easycwmp] NOTICE - daemon started
2019-11-29 10:15:47 [easycwmp] NOTICE - external: execute inform device_id
2019-11-29 10:15:47 [easycwmp] NOTICE - external script exit
2019-11-29 10:15:47 [easycwmp] NOTICE - add event '1 BOOT'
+++ HTTP SERVER CONFIGURATION +++
NOT BOUND TO IP
port: '7547'
--- HTTP SERVER CONFIGURATION ---
2019-11-29 10:15:47 [easycwmp] NOTICE - http server initialized
2019-11-29 10:15:47 [easycwmp] NOTICE - entering main loop
2019-11-29 10:15:47 [easycwmp] NOTICE - start session
+++ HTTP CLIENT CONFIGURATION +++
http_client_init(51):: url: http://192.168.2.100:7547
http_client_init(57):: ssl_verify: SSL certificate validation disabled.
--- HTTP CLIENT CONFIGURATION ---
2019-11-29 10:15:47 [easycwmp] NOTICE - configured acs url http://192.168.2.100:7547
2019-11-29 10:15:47 [easycwmp] NOTICE - external script init
2019-11-29 10:15:47 [easycwmp] NOTICE - external: execute inform parameter
2019-11-29 10:15:47 [easycwmp] NOTICE - send Inform
+++ SEND HTTP REQUEST +++
<?xml version="1.0" encoding="UTF-8" standalone="no"?>
<soap_env:Envelope
xmlns:soap_env="http://schemas.xmlsoap.org/soap/envelope/"
xmlns:soap_enc="http://schemas.xmlsoap.org/soap/encoding/"
xmlns:xsd="http://www.w3.org/2001/XMLSchema"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xmlns:cwmp="urn:dslforum-org:cwmp-1-2">
<soap_env:Header>
<cwmp:ID soap_env:mustUnderstand="1">1</cwmp:ID>
</soap_env:Header>
<soap_env:Body>
<cwmp:Inform>
<DeviceId>
<Manufacturer>myeasycwmp</Manufacturer>
<OUI>FFFFFF</OUI>
<ProductClass>myeasycwmp</ProductClass>
<SerialNumber>FFFFFF123456</SerialNumber>
</DeviceId>
<Event soap_enc:arrayType="cwmp:EventStruct[1]">
<EventStruct>
<EventCode>1 BOOT</EventCode>
<CommandKey />
</EventStruct>
</Event>
<MaxEnvelopes>1</MaxEnvelopes>
<CurrentTime>2019-11-29T10:15:47+08:00</CurrentTime>
<RetryCount>0</RetryCount>
<ParameterList soap_enc:arrayType="cwmp:ParameterValueStruct[10]">
<ParameterValueStruct>
<Name>Device.DeviceInfo.SpecVersion</Name>
<Value xsi:type="xsd:string">1.0</Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.DeviceInfo.ProvisioningCode</Name>
<Value xsi:type="xsd:string"></Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.DeviceInfo.Manufacturer</Name>
<Value xsi:type="xsd:string">myeasycwmp</Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.DeviceInfo.ManufacturerOUI</Name>
<Value xsi:type="xsd:string">FFFFFF</Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.DeviceInfo.ProductClass</Name>
<Value xsi:type="xsd:string">myeasycwmp</Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.DeviceInfo.SerialNumber</Name>
<Value xsi:type="xsd:string">FFFFFF123456</Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.DeviceInfo.HardwareVersion</Name>
<Value xsi:type="xsd:string">example_hw_version</Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.DeviceInfo.SoftwareVersion</Name>
<Value xsi:type="xsd:string">example_sw_version</Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.ManagementServer.ConnectionRequestURL</Name>
<Value xsi:type="xsd:string"></Value>
</ParameterValueStruct>
<ParameterValueStruct>
<Name>Device.ManagementServer.ParameterKey</Name>
<Value xsi:type="xsd:string">1</Value>
</ParameterValueStruct>
</ParameterList>
</cwmp:Inform>
</soap_env:Body>
</soap_env:Envelope>
--- SEND HTTP REQUEST ---
* Rebuilt URL to: http://192.168.2.100:7547/
* Trying 192.168.2.100...
* Connected to 192.168.2.100 (192.168.2.100) port 7547 (#0)
> POST / HTTP/1.1
Host: 192.168.2.100:7547
User-Agent: easycwmp
Content-Type: text/xml; charset="utf-8"
SOAPAction:
Content-Length: 2707
Expect: 100-continue
< HTTP/1.1 100 Continue
* We are completely uploaded and fine
< HTTP/1.1 200 OK
< Server: GenieACS/1.1.3
< SOAPServer: GenieACS/1.1.3
< Content-Type: text/xml; charset="utf-8"
< Set-Cookie: session=cc0eecdee564cbd7
< Content-Length: 522
< Date: Fri, 29 Nov 2019 02:15:48 GMT
< Connection: keep-alive
<
* Connection #0 to host 192.168.2.100 left intact
+++ RECEIVED HTTP RESPONSE +++
<?xml version="1.0" encoding="UTF-8"?>
<soap-env:Envelope xmlns:soap-enc="http://schemas.xmlsoap.org/soap/encoding/" xmlns:soap-env="http://schemas.xmlsoap.org/soap/envelope/" xmlns:xsd="http://www.w3.org/2001/XMLSchema" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:cwmp="urn:dslforum-org:cwmp-1-2"><soap-env:Header><cwmp:ID soap-env:mustUnderstand="1">1</cwmp:ID></soap-env:Header><soap-env:Body><cwmp:InformResponse><MaxEnvelopes>1</MaxEnvelopes></cwmp:InformResponse></soap-env:Body></soap-env:Envelope>
--- RECEIVED HTTP RESPONSE ---
2019-11-29 10:15:48 [easycwmp] NOTICE - receive InformResponse from the ACS
2019-11-29 10:15:48 [easycwmp] NOTICE - send empty message to the ACS
+++ SEND EMPTY HTTP REQUEST +++
* Found bundle for host 192.168.2.100: 0xd831df0
* Re-using existing connection! (#0) with host 192.168.2.100
* Connected to 192.168.2.100 (192.168.2.100) port 7547 (#0)
> POST / HTTP/1.1
Host: 192.168.2.100:7547
User-Agent: easycwmp
Content-Type: text/xml; charset="utf-8"
Content-Length: 0
* The requested URL returned error: 400 Bad Request
* Closing connection 0
2019-11-29 10:15:50 [easycwmp] NOTICE - LibCurl Error: The requested URL returned error: 400 Bad Request
2019-11-29 10:15:50 [easycwmp] NOTICE - sending http message failed
cwmp_handle_messages(352): sending http message failed
cwmp_inform(316): handling xml message failed
2019-11-29 10:15:50 [easycwmp] NOTICE - external: execute apply service
2019-11-29 10:15:50 [easycwmp] NOTICE - external script exit
2019-11-29 10:15:50 [easycwmp] NOTICE - end session failed
2019-11-29 10:15:50 [easycwmp] NOTICE - retry session in 7 sec, RetryCount = 1
^C2019-11-29 10:15:56 [easycwmp] NOTICE - exiting
/ #
 packet.pcap [^] (15,375 bytes) 2019-11-29 07:29 |
|
Relationships 
Relationships