Incrementing interfaces

Tue Oct 10 15:35:19 EDT 2017

This looks like an issue on the CPE itself. Its trying to acquire a lock
add the interface and times out after 60 seconds. Reboot the CPE and try
again.

On Tue, Oct 10, 2017 at 11:31 AM, Margerita <polanski.michal.mail at gmail.com>
wrote:

> Ok,
>
> I thought it will be easier to just see what Genie sends to CPE.
> Here is part of log captured from CPE where AddObj and 9005 is visible:
>
> tr69c:57.262:do_response:549:=====>ENTER.  data->pc=0x581714
> tr69c:57.262:cmsTmr_cancel:264:canceled event timer_response, count=1
> tr69c:57.262:proto_ParseResponse:1376:proto_ParseResponse(protocol="HTTP/1.1",
> status=200 message="OK")
> tr69c:57.264:postComplete:990:=====>ENTER
> tr69c:57.264:cmsTmr_cancel:260:no events to cancel (func=0x40be28
> data=0x4444d4)
> tr69c:57.264:postComplete:1000:Connection = keep-alive
> tr69c:57.264:readResponse:791:calling readLengthMsg for Download with
> content_length=609
> tr69c:57.265:readLengthMsg:565:soapBuf bufCnt=609 readLth=609
> tr69c:57.265:proto_Skip:1529:proto_Skip() read all from fd and ignore
> tr69c:57.265:proto_Skip:1556:proto_Skip() done.ret=1
> tr69c:57.265:xmlWrite:116: ---- nxml_write(): len 609
> tr69c:57.266:xmlWrite:119: ---- skip <?xml header
> tr69c:57.266:xmlTagBegin:233:tag=soap-env:Envelope lth=17 xmllevel=0
> tr69c:57.266:fEnvelope:1028:name=soap-env:Envelope, ttype=1, value=(null)
> tr69c:57.266:fEnvelope:1031:TAGBEGIN ------
> tr69c:57.266:xmlTagBegin:233:tag=soap-env:Header lth=15 xmllevel=1
> tr69c:57.267:xmlTagBegin:233:tag=cwmp:ID lth=7 xmllevel=2
> tr69c:57.267:fIDValue:1016:name=cwmp:ID, ttype=1, value=(null)
> tr69c:57.267:xmlAttr:339:xmlAttr attr=soap-env:mustUnderstand found at
> level 3
> tr69c:57.267:xmlValue:396:xmlValue attr=mustUnderstand value=1 found at
> level 3
> tr69c:57.267:fIDValue:1016:name=ID, ttype=3, value=15f07bb155c108
> tr69c:57.268:xmlData:445:xmlDATA tag=ID data=15f07bb155c108 found at
> level 3
> tr69c:57.268:fIDValue:1016:name=cwmp:ID, ttype=2, value=(null)
> tr69c:57.268:xmlTagEnd:293:xmlTagEnd tag=cwmp:ID found at level 2
> tr69c:57.268:xmlTagEnd:293:xmlTagEnd tag=soap-env:Header found at level 1
> tr69c:57.268:xmlTagBegin:233:tag=soap-env:Body lth=13 xmllevel=1
> tr69c:57.269:fBody:982:name=soap-env:Body, ttype=1, value=(null)
> tr69c:57.269:xmlTagBegin:233:tag=cwmp:AddObject lth=14 xmllevel=2
> tr69c:57.269:fAddObject:669:name=cwmp:AddObject, ttype=1, value=(null)
> tr69c:57.269:xmlTagBegin:233:tag=ObjectName lth=10 xmllevel=3
> tr69c:57.269:fObjectName:660:name=ObjectName, ttype=1, value=(null)
> tr69c:57.270:fObjectName:660:name=ObjectName, ttype=3,
> value=InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.
> WANIPConnection.1.
> tr69c:57.270:xmlData:445:xmlDATA tag=ObjectName
> data=InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.1.
> found at level 4
> tr69c:57.270:fObjectName:660:name=ObjectName, ttype=2, value=(null)
> tr69c:57.270:xmlTagEnd:293:xmlTagEnd tag=ObjectName found at level 3
> tr69c:57.270:xmlTagBegin:233:tag=ParameterKey lth=12 xmllevel=3
> tr69c:57.271:fSetParameterKey:749:name=ParameterKey, ttype=1, value=(null)
> tr69c:57.271:xmlTagEnd:300:xmlTagEnd shortform tag=ParameterKey xmllevel=3
> tr69c:57.271:fSetParameterKey:749:name=, ttype=2, value=(null)
> tr69c:57.271:fAddObject:669:name=cwmp:AddObject, ttype=2, value=(null)
> tr69c:57.271:xmlTagEnd:293:xmlTagEnd tag=cwmp:AddObject found at level 2
> tr69c:57.272:fBody:982:name=soap-env:Body, ttype=2, value=(null)
> tr69c:57.272:xmlTagEnd:293:xmlTagEnd tag=soap-env:Body found at level 1
> tr69c:57.272:fEnvelope:1028:name=soap-env:Envelope, ttype=2, value=(null)
> tr69c:57.272:fEnvelope:1043:TAGEND -----
> tr69c:57.272:xmlTagEnd:293:xmlTagEnd tag=soap-env:Envelope found at level
> 0
> tr69c:57.272:runRPC:3048:=====>ENTER: rcpMethod=7
> tr69c:57.273:cmsLck_acquireLockWithTimeoutTraced:95:acquired lock.
> callerFuncName runRPC; timeout 6000 milliseconds
> tr69c:57.273:writeSoapFault:713:=====>ENTER
> tr69c:57.274:sendToAcs:1371:=====>ENTER
> tr69c:57.274:wget_ClearPostHdrs:941:=====>ENTER
> tr69c:57.274:wget_AddPostHdr:933:=====>ENTER
> tr69c:57.274:updateAuthorizationHdr:422:=====>ENTER
> tr69c:57.274:wget_PostData:845:=====>ENTER
> tr69c:57.274:do_send_request:499:=====>ENTER. keepConn=1 status=0
> tr69c:57.275:proto_SendRequest:1092:proto_SendRequest(POST / HTTP/1.1)
> tr69c:57.275:stopListener:170:removed listener on fd=6
> tr69c:57.276:setListenerType:235:Adding listener on fd=6 type=read
> handle=0x581b14
> tr69c:57.276:cmsTmr_set:205:added event timer_response, expires in
> 60000ms (at 117.276), func=0x414680 data=0x581b14 count=2
> tr69c:57.277:doAddObject:2222:Fault 9005
> tr69c:57.277:cmsLck_releaseLockTraced:140:lock hold time=4ms, acquiring
> lock callerFuncName runRPC; releasing lock callerFuncName runRPC;
> tr69c:57.277:runRPC:3301:=====>EXIT, rpcStatus=0
>
> br
>
> --
> Michal
>
> W dniu 2017-10-10 o 20:40, Dan Morphis pisze:
>
> THe wireshark/tcpdump logs aren't want you want to check. You want to
> check the syslog on the CPE itself.
>
> -dan
>
> On Tue, Oct 10, 2017 at 10:27 AM, Margerita <polanski.michal.mail at gmail.
> com> wrote:
>
>> Hi,
>>
>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.*",
>> null, {path: 1}); or path: 2 or path: 3 works OK and creates 1 or 2 or 3
>> interfaces.
>> Problem occures later, I checked with tcpdump and it looks, that Genie
>> sends:
>>
>> InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANI
>> PConnection.1.
>> instead of
>> InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANI
>> PConnection.1.Name
>>
>> and empty parameter/value.
>>
>> Attached screenshot from wireshark - response for this was 9005
>>
>> br,
>>
>> W dniu 2017-10-10 o 18:57, Dan Morphis pisze:
>>
>> What do the logs on the CPE have in them?
>>
>> On Tue, Oct 10, 2017 at 1:23 AM, Margerita <polanski.michal.mail at gmail.co
>> m> wrote:
>>
>>> Thanks Dan,
>>>
>>> I got your idea here, but I can't get it to work this way. I got 9005
>>> error even with smallest configuration like this:
>>>
>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.*",
>>> null, {path: 1});
>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WA
>>> NIPConnection.*.[Name:Routed]", {path:1}, {path: 1});
>>>
>>> any ideas?
>>>
>>> --
>>> Michal
>>>
>>> W dniu 2017-10-05 o 18:54, Dan Morphis pisze:
>>>
>>> Try this :)
>>>
>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.*",
>>> null, {path: 2}); //Tell genie we want two interfaces
>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WA
>>> NIPConnection.*.[ConnectionType:IP_Routed,Name:Routed,Enable:true]",
>>> {path: 1}, {path: 1});
>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WA
>>> NIPConnection.*.[ConnectionType:IP_Bridged,Name:Bridged,Enable:true]",
>>> {path: 1}, {path: 1});
>>>
>>> That will create two interfaces. If there are more interfaces than that,
>>> they will be deleted. If there are less than 2, then interfaces will be
>>> added until the count is 2. Then it will set the parameters to whats in the
>>> brackets.
>>>
>>> -dan
>>>
>>> On Thu, Oct 5, 2017 at 4:33 AM, Margerita <polanski.michal.mail at gmail.co
>>> m> wrote:
>>>
>>>> Hi,
>>>>
>>>> I would like to create two interfaces using Provision:
>>>>
>>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.*",
>>>> null, {path: 1});
>>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WA
>>>> NIPConnection.*.ConnectionType", null, {value: "IP_Routed"});
>>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.*",
>>>> null, {path: 1});
>>>> declare ("InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WA
>>>> NIPConnection.*.ConnectionType", null, {value: "IP_Bridged"});
>>>>
>>>> and want to achieve the following effect:
>>>>
>>>> InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANI
>>>> PConnection.1
>>>> InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.1.ConnectionType
>>>> IP_Routed
>>>> InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANI
>>>> PConnection.2
>>>> InternetGatewayDevice.WANDevice.1.WANConnectionDevice.1.WANIPConnection.2.ConnectionType
>>>> IP_Bridged
>>>>
>>>> but whatever I put in path values, I always finish with only one
>>>> interface or with two interfaces but both 'IP_Bridged'.
>>>> What is the correct method for achieving my goal?
>>>>
>>>> --
>>>> Michal
>>>> _______________________________________________
>>>> Users mailing list
>>>> Users at lists.genieacs.com
>>>> http://lists.genieacs.com/mailman/listinfo/users
>>>>
>>>
>>>
>>>
>>> _______________________________________________
>>> Users mailing listUsers at lists.genieacs.comhttp://lists.genieacs.com/mailman/listinfo/users
>>>
>>>
>>>
>>> _______________________________________________
>>> Users mailing list
>>> Users at lists.genieacs.com
>>> http://lists.genieacs.com/mailman/listinfo/users
>>>
>>>
>>
>>
>> _______________________________________________
>> Users mailing listUsers at lists.genieacs.comhttp://lists.genieacs.com/mailman/listinfo/users
>>
>>
>>
>> _______________________________________________
>> Users mailing list
>> Users at lists.genieacs.com
>> http://lists.genieacs.com/mailman/listinfo/users
>>
>>
>
>
> _______________________________________________
> Users mailing listUsers at lists.genieacs.comhttp://lists.genieacs.com/mailman/listinfo/users
>
>
>
> _______________________________________________
> Users mailing list
> Users at lists.genieacs.com
> http://lists.genieacs.com/mailman/listinfo/users
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.genieacs.com/pipermail/users/attachments/20171010/342c49e2/attachment-0001.html>