Type error in logger.js

[Dan Morphis]

It is reproducible. It happens after a provision script runs and a fault
occurs on the device.

$ grep "TypeError" genieacs-cwmp.log -B2
2017-05-03T22:47:58.109Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="Provisioning" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-03T22:47:58.109Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="UpgradeCheck" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-03T22:47:58.285Z [ERROR] Uncaught exception;
exceptionName="TypeError" exceptionMessage="Cannot read property
'connection' of undefined" exceptionStack="TypeError: Cannot read property
'connection' of undefined\n    at flatten
(/usr/lib64/node_modules/genieacs/lib/logger.js:138:63)\n    at
formatSimple (/usr/lib64/node_modules/genieacs/lib/logger.js:209:3)\n    at
accessLog (/usr/lib64/node_modules/genieacs/lib/logger.js:289:27)\n    at
Object.accessInfo (/usr/lib64/node_modules/genieacs/lib/logger.js:296:3)\n
   at sendAcsRequest
(/usr/lib64/node_modules/genieacs/lib/cwmp.js:631:10)\n    at
/usr/lib64/node_modules/genieacs/lib/cwmp.js:415:16\n    at rpcRequest
(/usr/lib64/node_modules/genieacs/lib/session.js:988:12)\n    at
/usr/lib64/node_modules/genieacs/lib/session.js:819:14\n    at clear
(/usr/lib64/node_modules/genieacs/lib/session.js:1604:12)\n    at
rpcRequest (/usr/lib64/node_modules/genieacs/lib/session.js:814:12)"
--
2017-05-03T22:58:55.117Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="Provisioning" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-03T22:58:55.117Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="UpgradeCheck" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-03T22:58:55.325Z [ERROR] Uncaught exception;
exceptionName="TypeError" exceptionMessage="Cannot read property
'connection' of undefined" exceptionStack="TypeError: Cannot read property
'connection' of undefined\n    at flatten
(/usr/lib64/node_modules/genieacs/lib/logger.js:138:63)\n    at
formatSimple (/usr/lib64/node_modules/genieacs/lib/logger.js:209:3)\n    at
accessLog (/usr/lib64/node_modules/genieacs/lib/logger.js:289:27)\n    at
Object.accessInfo (/usr/lib64/node_modules/genieacs/lib/logger.js:296:3)\n
   at sendAcsRequest
(/usr/lib64/node_modules/genieacs/lib/cwmp.js:631:10)\n    at
/usr/lib64/node_modules/genieacs/lib/cwmp.js:415:16\n    at rpcRequest
(/usr/lib64/node_modules/genieacs/lib/session.js:988:12)\n    at
/usr/lib64/node_modules/genieacs/lib/session.js:819:14\n    at clear
(/usr/lib64/node_modules/genieacs/lib/session.js:1604:12)\n    at
rpcRequest (/usr/lib64/node_modules/genieacs/lib/session.js:814:12)"
--
2017-05-03T23:05:58.956Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="Provisioning" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-03T23:05:58.957Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="UpgradeCheck" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-03T23:05:59.140Z [ERROR] Uncaught exception;
exceptionName="TypeError" exceptionMessage="Cannot read property
'connection' of undefined" exceptionStack="TypeError: Cannot read property
'connection' of undefined\n    at flatten
(/usr/lib64/node_modules/genieacs/lib/logger.js:138:63)\n    at
formatSimple (/usr/lib64/node_modules/genieacs/lib/logger.js:209:3)\n    at
accessLog (/usr/lib64/node_modules/genieacs/lib/logger.js:289:27)\n    at
Object.accessInfo (/usr/lib64/node_modules/genieacs/lib/logger.js:296:3)\n
   at sendAcsRequest
(/usr/lib64/node_modules/genieacs/lib/cwmp.js:631:10)\n    at
/usr/lib64/node_modules/genieacs/lib/cwmp.js:415:16\n    at rpcRequest
(/usr/lib64/node_modules/genieacs/lib/session.js:988:12)\n    at
/usr/lib64/node_modules/genieacs/lib/session.js:819:14\n    at clear
(/usr/lib64/node_modules/genieacs/lib/session.js:1604:12)\n    at
rpcRequest (/usr/lib64/node_modules/genieacs/lib/session.js:814:12)"
--
2017-05-03T23:09:45.984Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="Provisioning" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-03T23:09:45.984Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="UpgradeCheck" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-03T23:09:46.172Z [ERROR] Uncaught exception;
exceptionName="TypeError" exceptionMessage="Cannot read property
'connection' of undefined" exceptionStack="TypeError: Cannot read property
'connection' of undefined\n    at flatten
(/usr/lib64/node_modules/genieacs/lib/logger.js:138:63)\n    at
formatSimple (/usr/lib64/node_modules/genieacs/lib/logger.js:209:3)\n    at
accessLog (/usr/lib64/node_modules/genieacs/lib/logger.js:289:27)\n    at
Object.accessInfo (/usr/lib64/node_modules/genieacs/lib/logger.js:296:3)\n
   at sendAcsRequest
(/usr/lib64/node_modules/genieacs/lib/cwmp.js:631:10)\n    at
/usr/lib64/node_modules/genieacs/lib/cwmp.js:415:16\n    at rpcRequest
(/usr/lib64/node_modules/genieacs/lib/session.js:988:12)\n    at
/usr/lib64/node_modules/genieacs/lib/session.js:819:14\n    at clear
(/usr/lib64/node_modules/genieacs/lib/session.js:1604:12)\n    at
rpcRequest (/usr/lib64/node_modules/genieacs/lib/session.js:814:12)"
--
2017-05-04T16:50:33.445Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="Provisioning" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-04T16:50:33.445Z [ERROR] 172.27.240.101
00236a-SR552n-SR552NA084%2D0003269: Channel has faulted;
channel="UpgradeCheck" retries=0 faultCode="cwmp.9002"
faultMessage="Internal Error"
2017-05-04T16:50:33.618Z [ERROR] Uncaught exception;
exceptionName="TypeError" exceptionMessage="Cannot read property
'connection' of undefined" exceptionStack="TypeError: Cannot read property
'connection' of undefined\n    at flatten
(/usr/lib64/node_modules/genieacs/lib/logger.js:138:63)\n    at
formatSimple (/usr/lib64/node_modules/genieacs/lib/logger.js:209:3)\n    at
accessLog (/usr/lib64/node_modules/genieacs/lib/logger.js:289:27)\n    at
Object.accessInfo (/usr/lib64/node_modules/genieacs/lib/logger.js:296:3)\n
   at sendAcsRequest
(/usr/lib64/node_modules/genieacs/lib/cwmp.js:631:10)\n    at
/usr/lib64/node_modules/genieacs/lib/cwmp.js:415:16\n    at rpcRequest
(/usr/lib64/node_modules/genieacs/lib/session.js:988:12)\n    at
/usr/lib64/node_modules/genieacs/lib/session.js:819:14\n    at clear
(/usr/lib64/node_modules/genieacs/lib/session.js:1604:12)\n    at
rpcRequest (/usr/lib64/node_modules/genieacs/lib/session.js:814:12)"
--
2017-05-04T17:03:16.880Z [WARN] 172.27.240.20
00236a-96318REF-SR360NA0A4%2D0003196: CPE fault; acsRequestId="1714636915"
cpeFaultCode="Server" cpeFaultString="CWMP fault"
2017-05-04T17:03:17.113Z [INFO] 172.27.240.20
00236a-96318REF-SR360NA0A4%2D0003196: Script: Firmware_Upgrade - Config
files; previous="360_defaults_2017_apr_12.conf"
newFile="360_defaults_2017_apr_12.conf"
2017-05-04T17:03:17.179Z [ERROR] Uncaught exception;
exceptionName="TypeError" exceptionMessage="Cannot read property
'connection' of undefined" exceptionStack="TypeError: Cannot read property
'connection' of undefined\n    at
/usr/lib64/node_modules/genieacs/lib/cwmp.js:551:60\n    at
/usr/lib64/node_modules/genieacs/lib/session.js:1980:14\n    at
/usr/lib64/node_modules/genieacs/lib/db.js:697:12\n    at handleCallback
(/usr/lib64/node_modules/genieacs/node_modules/mongodb/lib/utils.js:120:56)\n
   at
/usr/lib64/node_modules/genieacs/node_modules/mongodb/lib/collection.js:1062:5\n
   at
/usr/lib64/node_modules/genieacs/node_modules/mongodb-core/lib/connection/pool.js:461:18\n
   at _combinedTickCallback (internal/process/next_tick.js:73:7)\n    at
process._tickCallback (internal/process/next_tick.js:104:9)"

On Fri, May 5, 2017 at 1:38 PM, Zaid Abdulla <zaid at genieacs.com> wrote:

> On Wed, 2017-05-03 at 15:04 -0800, Dan Morphis wrote:
> > Faulty line:
> > details.remoteAddress =
> > details.sessionContext.httpRequest.connection.remoteAddress;
> >
> > Uncaught exception; exceptionName="TypeError
> > Cannot read property 'connection' of undefined"
> > TypeError: Cannot read property 'connection' of undefined
> >     at flatten
> > (/usr/lib64/node_modules/genieacs/lib/logger.js:138:63)
> >     at formatSimple
> > (/usr/lib64/node_modules/genieacs/lib/logger.js:209:3)
> >     at accessLog
> > (/usr/lib64/node_modules/genieacs/lib/logger.js:289:27)
> >     at Object.accessInfo
> > (/usr/lib64/node_modules/genieacs/lib/logger.js:296:3)
> >     at sendAcsRequest
> > (/usr/lib64/node_modules/genieacs/lib/cwmp.js:631:10)
> >     at /usr/lib64/node_modules/genieacs/lib/cwmp.js:415:16
> >     at rpcRequest
> > (/usr/lib64/node_modules/genieacs/lib/session.js:988:12)
> >     at /usr/lib64/node_modules/genieacs/lib/session.js:819:14
> >     at clear
> > (/usr/lib64/node_modules/genieacs/lib/session.js:1604:12)
> >     at rpcRequest
> > (/usr/lib64/node_modules/genieacs/lib/session.js:814:12)
>
> Couldn't figure out why this might be happening. Any clues? Can you
> reproduce it?
>
> --
> Zaid Abdulla <zaid at genieacs.com>
> _______________________________________________
> 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/20170508/3637e415/attachment-0001.html>