[Spce-user] R: Log Error
Alessandro Romano - Rp engineering
alessandro.romano at rpeng.it
Tue May 6 13:45:14 EDT 2014
Thanks for the reply!
there is a way to identify this contact ? or to view the register message ?
BR
-----Messaggio originale-----
Da: Daniel Grotti [mailto:dgrotti at sipwise.com]
Inviato: martedì 6 maggio 2014 19.15
A: Alessandro Romano - Rp engineering
Cc: spce-user at lists.sipwise.com
Oggetto: Re: [Spce-user] Log Error
I think it is related to a particular contact inside Register message.
Daniel
On 6 May 2014 19:04, Alessandro Romano - Rp engineering <alessandro.romano at rpeng.it> wrote:
>
> Hi Daniel,
> it appear randomly.
>
> i've attached other logs.
>
> BR
>
> May 6 18:52:44 31-7-144-140 proxy[4165]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voip.positivonet.it:5060 ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 18:53:23 31-7-144-140 proxy[4168]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358108 at voip.positivonet.it
> T=sip:0899358108 at voip.positivonet.it IP=91.214.73.242:5060
> (127.0.0.1:5060) ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:53:23 31-7-144-140 proxy[4168]: NOTICE: <script>:
> Authentication failed, stale nonce - R=sip:voip.positivonet.it
> ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:53:23 31-7-144-140 proxy[4161]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358108 at voip.positivonet.it
> T=sip:0899358108 at voip.positivonet.it IP=91.214.73.242:5060
> (127.0.0.1:5060) ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:53:23 31-7-144-140 proxy[4161]: ERROR: <core>
> [lvalue.c:356]: lval_pvar_assign(): non existing right pvar May 6
> 18:53:23 31-7-144-140 proxy[4161]: ERROR: <core> [lvalue.c:416]:
> lval_assign(): assignment failed at pos: (198,25-198,50) May 6
> 18:53:23 31-7-144-140 proxy[4161]: NOTICE: <script>: Contacts
> successfully updated, expires in 300s - R=sip:voip.positivonet.it
> ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:54:47 31-7-144-140 proxy[4161]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358060 at voip.positivonet.it
> T=sip:0899358060 at voip.positivonet.it IP=31.7.147.23:5060
> (127.0.0.1:5060) ID=gmJnzrJUUke5hxnnX7yTd0R4pOllaNYu
> May 6 18:54:47 31-7-144-140 proxy[4161]: NOTICE: <script>:
> Authentication failed, no credentials - R=sip:voip.positivonet.it
> ID=gmJnzrJUUke5hxnnX7yTd0R4pOllaNYu
> May 6 18:54:47 31-7-144-140 proxy[4165]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358060 at voip.positivonet.it
> T=sip:0899358060 at voip.positivonet.it IP=31.7.147.23:5060
> (127.0.0.1:5060) ID=gmJnzrJUUke5hxnnX7yTd0R4pOllaNYu
> May 6 18:54:47 31-7-144-140 proxy[4165]: ERROR: <core>
> [parser/parse_param.c:512]: parse_param2(): parse_params(): Invalid
> character, ; expected May 6 18:54:47 31-7-144-140 proxy[4165]: ERROR:
> <core> [lvalue.c:356]: lval_pvar_assign(): non existing right pvar May
> 6 18:54:47 31-7-144-140 proxy[4165]: ERROR: <core> [lvalue.c:416]:
> lval_assign(): assignment failed at pos: (198,25-198,50) May 6
> 18:54:47 31-7-144-140 proxy[4165]: NOTICE: <script>: Contacts
> successfully updated, expires in 300s - R=sip:voip.positivonet.it
> ID=gmJnzrJUUke5hxnnX7yTd0R4pOllaNYu
> May 6 18:55:01 31-7-144-140 proxy[4164]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358195 at voip.positivonet.it
> T=sip:0899358195 at voip.positivonet.it IP=91.214.72.41:60108
> (127.0.0.1:5060) ID=feaa68530719-q2x7dl99fbnq May 6 18:55:01
> 31-7-144-140 proxy[4164]: NOTICE: <script>: Authentication failed, no
> credentials - R=sip:voip.positivonet.it ID=feaa68530719-q2x7dl99fbnq
> May 6 18:55:01 31-7-144-140 proxy[4170]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358195 at voip.positivonet.it
> T=sip:0899358195 at voip.positivonet.it IP=91.214.72.41:60108
> (127.0.0.1:5060) ID=feaa68530719-q2x7dl99fbnq May 6 18:55:01
> 31-7-144-140 proxy[4170]: NOTICE: <script>: Contacts successfully
> updated, expires in 3600s - R=sip:voip.positivonet.it
> ID=feaa68530719-q2x7dl99fbnq May 6 18:55:03 31-7-144-140 proxy[4163]:
> NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358199 at voip.positivonet.it
> T=sip:0899358199 at voip.positivonet.it IP=31.7.150.127:5060
> (127.0.0.1:5060) ID=b010c356-93186469 at 192.168.1.100
> May 6 18:55:03 31-7-144-140 proxy[4163]: NOTICE: <script>:
> Authentication failed, stale nonce - R=sip:voip.positivonet.it
> ID=b010c356-93186469 at 192.168.1.100
> May 6 18:55:03 31-7-144-140 proxy[4168]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358199 at voip.positivonet.it
> T=sip:0899358199 at voip.positivonet.it IP=31.7.150.127:5060
> (127.0.0.1:5060) ID=b010c356-93186469 at 192.168.1.100
> May 6 18:55:03 31-7-144-140 proxy[4168]: ERROR: <core>
> [parser/parse_param.c:512]: parse_param2(): parse_params(): Invalid
> character, ; expected May 6 18:55:03 31-7-144-140 proxy[4168]: ERROR:
> <core> [lvalue.c:356]: lval_pvar_assign(): non existing right pvar May
> 6 18:55:03 31-7-144-140 proxy[4168]: ERROR: <core> [lvalue.c:416]:
> lval_assign(): assignment failed at pos: (198,25-198,50) May 6
> 18:55:03 31-7-144-140 proxy[4168]: NOTICE: <script>: Contacts
> successfully updated, expires in 180s - R=sip:voip.positivonet.it
> ID=b010c356-93186469 at 192.168.1.100
> May 6 18:55:26 31-7-144-140 proxy[4164]: NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it:5060 F=sip:0899358192 at voip.positivonet.it:5060 T=sip:0899358192 at voip.positivonet.it:5060 IP=151.12.1.70:5060 (127.0.0.1:5060) ID=ZDU3NTBiMDdhZjg5ZjQ3YTBhZTUwMWQ5OGMxMTUyN2M.
> May 6 18:55:26 31-7-144-140 proxy[4164]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voip.positivonet.it:5060 ID=ZDU3NTBiMDdhZjg5ZjQ3YTBhZTUwMWQ5OGMxMTUyN2M.
> May 6 18:55:27 31-7-144-140 proxy[4170]: NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it:5060 F=sip:0899358193 at voip.positivonet.it:5060 T=sip:0899358193 at voip.positivonet.it:5060 IP=151.12.1.70:5060 (127.0.0.1:5060) ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 18:55:27 31-7-144-140 proxy[4170]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voip.positivonet.it:5060 ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 18:56:20 31-7-144-140 proxy[4168]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358108 at voip.positivonet.it
> T=sip:0899358108 at voip.positivonet.it IP=91.214.73.242:5060
> (127.0.0.1:5060) ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:56:20 31-7-144-140 proxy[4168]: ERROR: <core>
> [parser/parse_param.c:512]: parse_param2(): parse_params(): Invalid
> character, ; expected May 6 18:56:20 31-7-144-140 proxy[4168]: ERROR:
> <core> [lvalue.c:356]: lval_pvar_assign(): non existing right pvar May
> 6 18:56:20 31-7-144-140 proxy[4168]: ERROR: <core> [lvalue.c:416]:
> lval_assign(): assignment failed at pos: (198,25-198,50) May 6
> 18:56:20 31-7-144-140 proxy[4168]: NOTICE: <script>: Contacts
> successfully updated, expires in 180s - R=sip:voip.positivonet.it
> ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:56:26 31-7-144-140 proxy[4165]: NOTICE: <script>: New
> request - M=SUBSCRIBE R=sip:127.0.0.1:5062
> F=sip:0899358190 at voip.positivonet.it
> T=sip:0899358190 at voip.positivonet.it IP=91.214.72.41:45250
> (127.0.0.1:5060) ID=MTgwM2ZkOWZmMjJmMGRjZGQ0NDMwYzNhOThiYzlhOWY
> May 6 18:56:26 31-7-144-140 proxy[4165]: NOTICE: <script>: Handling
> subscribe request for event 'message-summary' - R=sip:127.0.0.1:5062
> ID=MTgwM2ZkOWZmMjJmMGRjZGQ0NDMwYzNhOThiYzlhOWY
> May 6 18:58:09 31-7-144-140 proxy[4164]: NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it:5060 F=sip:0899358192 at voip.positivonet.it:5060 T=sip:0899358192 at voip.positivonet.it:5060 IP=151.12.1.70:5060 (127.0.0.1:5060) ID=ZDU3NTBiMDdhZjg5ZjQ3YTBhZTUwMWQ5OGMxMTUyN2M.
> May 6 18:58:09 31-7-144-140 proxy[4164]: NOTICE: <script>: Authentication failed, stale nonce - R=sip:voip.positivonet.it:5060 ID=ZDU3NTBiMDdhZjg5ZjQ3YTBhZTUwMWQ5OGMxMTUyN2M.
> May 6 18:58:09 31-7-144-140 proxy[4170]: NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it:5060 F=sip:0899358192 at voip.positivonet.it:5060 T=sip:0899358192 at voip.positivonet.it:5060 IP=151.12.1.70:5060 (127.0.0.1:5060) ID=ZDU3NTBiMDdhZjg5ZjQ3YTBhZTUwMWQ5OGMxMTUyN2M.
> May 6 18:58:09 31-7-144-140 proxy[4170]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voip.positivonet.it:5060 ID=ZDU3NTBiMDdhZjg5ZjQ3YTBhZTUwMWQ5OGMxMTUyN2M.
> May 6 18:58:09 31-7-144-140 proxy[4163]: NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it:5060 F=sip:0899358193 at voip.positivonet.it:5060 T=sip:0899358193 at voip.positivonet.it:5060 IP=151.12.1.70:5060 (127.0.0.1:5060) ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 18:58:09 31-7-144-140 proxy[4163]: NOTICE: <script>: Authentication failed, stale nonce - R=sip:voip.positivonet.it:5060 ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 18:58:09 31-7-144-140 proxy[4168]: NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it:5060 F=sip:0899358193 at voip.positivonet.it:5060 T=sip:0899358193 at voip.positivonet.it:5060 IP=151.12.1.70:5060 (127.0.0.1:5060) ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 18:58:09 31-7-144-140 proxy[4168]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voip.positivonet.it:5060 ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 18:58:21 31-7-144-140 proxy[4171]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358196 at voip.positivonet.it
> T=sip:0899358196 at voip.positivonet.it IP=31.7.145.184:5060
> (127.0.0.1:5060) ID=9670c161-3167f90e at 192.168.1.100
> May 6 18:58:21 31-7-144-140 proxy[4171]: NOTICE: <script>:
> Authentication failed, stale nonce - R=sip:voip.positivonet.it
> ID=9670c161-3167f90e at 192.168.1.100
> May 6 18:58:21 31-7-144-140 proxy[4162]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358196 at voip.positivonet.it
> T=sip:0899358196 at voip.positivonet.it IP=31.7.145.184:5060
> (127.0.0.1:5060) ID=9670c161-3167f90e at 192.168.1.100
> May 6 18:58:21 31-7-144-140 proxy[4162]: ERROR: <core>
> [parser/parse_param.c:512]: parse_param2(): parse_params(): Invalid
> character, ; expected May 6 18:58:21 31-7-144-140 proxy[4162]: ERROR:
> <core> [lvalue.c:356]: lval_pvar_assign(): non existing right pvar May
> 6 18:58:21 31-7-144-140 proxy[4162]: ERROR: <core> [lvalue.c:416]:
> lval_assign(): assignment failed at pos: (198,25-198,50) May 6
> 18:58:21 31-7-144-140 proxy[4162]: NOTICE: <script>: Contacts
> successfully updated, expires in 180s - R=sip:voip.positivonet.it
> ID=9670c161-3167f90e at 192.168.1.100
> May 6 18:59:17 31-7-144-140 proxy[4163]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358108 at voip.positivonet.it
> T=sip:0899358108 at voip.positivonet.it IP=91.214.73.242:5060
> (127.0.0.1:5060) ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:59:17 31-7-144-140 proxy[4163]: NOTICE: <script>:
> Authentication failed, stale nonce - R=sip:voip.positivonet.it
> ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:59:17 31-7-144-140 proxy[4168]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358108 at voip.positivonet.it
> T=sip:0899358108 at voip.positivonet.it IP=91.214.73.242:5060
> (127.0.0.1:5060) ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:59:17 31-7-144-140 proxy[4168]: ERROR: <core>
> [parser/parse_param.c:512]: parse_param2(): parse_params(): Invalid
> character, ; expected May 6 18:59:17 31-7-144-140 proxy[4168]: ERROR:
> <core> [lvalue.c:356]: lval_pvar_assign(): non existing right pvar May
> 6 18:59:17 31-7-144-140 proxy[4168]: ERROR: <core> [lvalue.c:416]:
> lval_assign(): assignment failed at pos: (198,25-198,50) May 6
> 18:59:17 31-7-144-140 proxy[4168]: NOTICE: <script>: Contacts
> successfully updated, expires in 180s - R=sip:voip.positivonet.it
> ID=9c77f273-25332b0c at 91.214.73.242
> May 6 18:59:41 31-7-144-140 proxy[4162]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358060 at voip.positivonet.it
> T=sip:0899358060 at voip.positivonet.it IP=31.7.147.23:5060
> (127.0.0.1:5060) ID=gmJnzrJUUke5hxnnX7yTd0R4pOllaNYu
> May 6 18:59:41 31-7-144-140 proxy[4162]: NOTICE: <script>:
> Authentication failed, no credentials - R=sip:voip.positivonet.it
> ID=gmJnzrJUUke5hxnnX7yTd0R4pOllaNYu
> May 6 18:59:41 31-7-144-140 proxy[4164]: NOTICE: <script>: New
> request - M=REGISTER R=sip:voip.positivonet.it
> F=sip:0899358060 at voip.positivonet.it
> T=sip:0899358060 at voip.positivonet.it IP=31.7.147.23:5060
> (127.0.0.1:5060) ID=gmJnzrJUUke5hxnnX7yTd0R4pOllaNYu
> May 6 18:59:41 31-7-144-140 proxy[4164]: ERROR: <core>
> [parser/parse_param.c:512]: parse_param2(): parse_params(): Invalid
> character, ; expected May 6 18:59:41 31-7-144-140 proxy[4164]: ERROR:
> <core> [lvalue.c:356]: lval_pvar_assign(): non existing right pvar May
> 6 18:59:41 31-7-144-140 proxy[4164]: ERROR: <core> [lvalue.c:416]:
> lval_assign(): assignment failed at pos: (198,25-198,50) May 6
> 18:59:41 31-7-144-140 proxy[4164]: NOTICE: <script>: Contacts
> successfully updated, expires in 300s - R=sip:voip.positivonet.it
> ID=gmJnzrJUUke5hxnnX7yTd0R4pOllaNYu
> May 6 19:00:51 31-7-144-140 proxy[4165]: NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it:5060 F=sip:0899358192 at voip.positivonet.it:5060 T=sip:0899358192 at voip.positivonet.it:5060 IP=151.12.1.70:5060 (127.0.0.1:5060) ID=ZDU3NTBiMDdhZjg5ZjQ3YTBhZTUwMWQ5OGMxMTUyN2M.
> May 6 19:00:51 31-7-144-140 proxy[4165]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voip.positivonet.it:5060 ID=ZDU3NTBiMDdhZjg5ZjQ3YTBhZTUwMWQ5OGMxMTUyN2M.
> May 6 19:00:51 31-7-144-140 proxy[4171]: NOTICE: <script>: New request - M=REGISTER R=sip:voip.positivonet.it:5060 F=sip:0899358193 at voip.positivonet.it:5060 T=sip:0899358193 at voip.positivonet.it:5060 IP=151.12.1.70:5060 (127.0.0.1:5060) ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 19:00:51 31-7-144-140 proxy[4171]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voip.positivonet.it:5060 ID=ODMzNDkwYjk4MGYyMTdjYzM4MzAzZTQwZmNmMjVjYmU.
> May 6 19:00:56 31-7-144-140 proxy[4164]: NOTICE: <script>: New
> request - M=SUBSCRIBE R=sip:127.0.0.1:5062
> F=sip:0899358190 at voip.positivonet.it
> T=sip:0899358190 at voip.positivonet.it IP=91.214.72.41:45250
> (127.0.0.1:5060) ID=MTgwM2ZkOWZmMjJmMGRjZGQ0NDMwYzNhOThiYzlhOWY
> May 6 19:00:56 31-7-144-140 proxy[4164]: NOTICE: <script>: Handling
> subscribe request for event 'message-summary' - R=sip:127.0.0.1:5062
> ID=MTgwM2ZkOWZmMjJmMGRjZGQ0NDMwYzNhOThiYzlhOWY
>
> -----Messaggio originale-----
> Da: Daniel Grotti [mailto:dgrotti at sipwise.com]
> Inviato: martedì 6 maggio 2014 18.48
> A: Alessandro Romano - Rp engineering
> Cc: spce-user at lists.sipwise.com
> Oggetto: Re: [Spce-user] Log Error
>
> Hi Alessandro,
> I think this is a cosmetic issue.
> Does it appear during Registration or what?
> Do you have the full log?
>
> Daniel
>
> On 6 May 2014 18:23, Alessandro Romano - Rp engineering <alessandro.romano at rpeng.it> wrote:
> >
> > Dear All,
> >
> > we have currently this error on the logs
> >
> >
> >
> > May 6 18:20:55 31-7-144-140 proxy[4171]: ERROR: <core>
> > [parser/parse_param.c:512]: parse_param2(): parse_params(): Invalid
> > character, ; expected
> >
> > May 6 18:20:55 31-7-144-140 proxy[4171]: ERROR: <core>
> > [lvalue.c:356]: lval_pvar_assign(): non existing right pvar
> >
> > May 6 18:20:55 31-7-144-140 proxy[4171]: ERROR: <core>
> > [lvalue.c:416]: lval_assign(): assignment failed at pos:
> > (198,25-198,50)
> >
> >
> >
> > What does it mean ?
> >
> >
> >
> > BR
> >
> > Alessandro
>
> _______________________________________________
> Spce-user mailing list
> Spce-user at lists.sipwise.com
> http://lists.sipwise.com/listinfo/spce-user
More information about the Spce-user
mailing list