Ticket #446: messages4

File messages4, 27.8 KB (added by roman_zhur, 8 days ago)
Line 
1Jan 14 10:36:28 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: CAS event, ts=254, flags=0000, data=7
2Jan 14 10:36:28 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Dialtone: CAS event, ts=254, flags=0000, data=7
3Jan 14 10:36:30 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Dialtone: DTMF detected, ts=254, flags=0000, data=0
4Jan 14 10:36:30 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Dialing: Tone completed, ts=254, flags=0000, data=3
5Jan 14 10:36:30 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Dialing: Tone detected, ts=254, flags=0000, data=255
6Jan 14 10:36:30 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Dialing: DTMF detected, ts=254, flags=0000, data=2
7Jan 14 10:36:30 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Dialing: Tone detected, ts=254, flags=0000, data=255
8Jan 14 10:36:31 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Dialing: DTMF detected, ts=254, flags=0000, data=2
9Jan 14 10:36:31 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Dialing: Tone detected, ts=254, flags=0000, data=255
10Jan 14 10:36:33 sip_ua[454]: fxs.cpp:275: ts 254: dialing 022
11Jan 14 10:36:33 sip_ua[454]: user_agent.cpp:3892: --> ua_dial_out() <sip:disp@192.168.0.121> -> sip:022@192.168.0.121...
12Jan 14 10:36:33 sip_ua[510]: repro.cpp:644: doSessionAccounting(): Session Created 'branch=z9hG4bK848988066'
13Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 2 (New call received!): cid=2, did=3, tid=2, rid=0, sid=0, nid=0
14Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2272: INVITE received: sip:022@127.0.0.1:6060;transport=udp (Call-ID: 867130226@(null))
15Jan 14 10:36:33 sip_ua[454]: pps.cpp:97: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0001, data=2
16Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Calling: Incoming call, ts=-1, flags=0001, data=2
17Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=255, state=Idle: Incoming call, ts=-1, flags=0001, data=2
18Jan 14 10:36:33 sip_ua[454]: conference.cpp:96: ---> ConferenceFocus: Incoming call, ts=-1, flags=0001, data=2
19Jan 14 10:36:33 sip_ua[454]: virtualChannel.cpp:217: ---> VirtualChannelManager: Incoming call, ts=-1, flags=0001, data=2
20Jan 14 10:36:33 sip_ua[454]: pps.cpp:97: ---> ts=2, state=Idle: Incoming call, ts=-1, flags=0002, data=2
21Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Calling: Incoming call, ts=-1, flags=0002, data=2
22Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=255, state=Idle: Incoming call, ts=-1, flags=0002, data=2
23Jan 14 10:36:33 sip_ua[454]: conference.cpp:96: ---> ConferenceFocus: Incoming call, ts=-1, flags=0002, data=2
24Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 5 (Call is being processed!): cid=1, did=0, tid=1, rid=0, sid=0, nid=0
25Jan 14 10:36:33 sip_ua[454]: conference.cpp:135: --> 1002: 0x48d210
26Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1002]: Incoming call, ts=1002, flags=0006, data=2
27Jan 14 10:36:33 sip_ua[454]: conference.cpp:552: --> checkpoint 2: '22@192.168.0.121'
28Jan 14 10:36:33 sip_ua[454]: conference.cpp:556: --> checkpoint 3a: 1002
29Jan 14 10:36:33 sip_ua[454]: conference.cpp:557: --> checkpoint 3b: 0x48d210
30Jan 14 10:36:33 sip_ua[454]: conference.cpp:558: --> checkpoint 3c: 0x48d210
31Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1003]: REFER received, ts=1003, flags=0000, data=0
32Jan 14 10:36:33 sip_ua[454]: user_agent.cpp:4329: Call 2 routed to TS 1002
33Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1003]: Call ID replaced, ts=1003, flags=0000, data=0
34Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1002]: RTP parameters, ts=1002, flags=0000, data=2
35Jan 14 10:36:33 sip_ua[454]: conference.cpp:653: ---> StaticConferenceFocus: Participant status changed, ts=2000, flags=0000, data=1002
36Jan 14 10:36:33 sip_ua[454]: conference.cpp:285: ---> ConferenceFocus: Participant status changed, ts=2000, flags=0000, data=1002
37Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7299: --> ts 1002: 192.168.0.121[12004] --> 192.168.0.121[10508]
38Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7300: --> ts 1002: codec PCMA, VAD is on, red=0
39Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7301: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
40Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7359: ts 1002: calling createConnection()
41Jan 14 10:36:33 sip_ua[510]: repro.cpp:644: doSessionAccounting(): Session Created 'branch=z9hG4bK1203592024'
42Jan 14 10:36:33 sip_ua[510]: repro.cpp:868: doSessionAccounting(): Session Established 'branch=z9hG4bK848988066'
43Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 5 (Call is being processed!): cid=4, did=0, tid=3, rid=0, sid=0, nid=0
44Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7403: routing 192.168.0.121 to 192.168.0.121 (lo)
45Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7415: getMac(192.168.0.121): 02:ad:c5:00:02:c5
46Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7425: ts 1002: RTP destination is 02:ad:c5:00:02:c5
47Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7145: ts 1002: stopping RTP stream
48Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7145: ts 1002: stopping RTP stream
49Jan 14 10:36:33 sip_ua[510]: repro.cpp:958: doSessionAccounting(): Session Redirected
50Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 8 (Call is redirected!): cid=4, did=0, tid=3, rid=0, sid=0, nid=0
51Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7124: ts 1002: starting RTP stream
52Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Calling: RTP parameters, ts=254, flags=0000, data=1
53Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7299: --> ts 254: 192.168.0.121[10508] --> 192.168.0.121[12004]
54Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7300: --> ts 254: codec PCMA, VAD is on, red=0
55Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7301: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
56Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7359: ts 254: calling createConnection()
57Jan 14 10:36:33 sip_ua[510]: repro.cpp:644: doSessionAccounting(): Session Created 'branch=z9hG4bK1570660921'
58Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7403: routing 192.168.0.121 to 192.168.0.121 (lo)
59Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7415: getMac(192.168.0.121): 02:ad:c5:00:02:c5
60Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7425: ts 254: RTP destination is 02:ad:c5:00:02:c5
61Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7145: ts 254: stopping RTP stream
62Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7145: ts 254: stopping RTP stream
63Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7124: ts 254: starting RTP stream
64Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Calling: Call answered, ts=254, flags=0000, data=1
65Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1002]: RTP parameters, ts=1002, flags=0000, data=2
66Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7299: --> ts 1002: 192.168.0.121[12004] --> 192.168.0.121[10508]
67Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7300: --> ts 1002: codec PCMA, VAD is on, red=0
68Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7301: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
69Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7403: routing 192.168.0.121 to 192.168.0.121 (lo)
70Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7415: getMac(192.168.0.121): 02:ad:c5:00:02:c5
71Jan 14 10:36:33 sip_ua[454]: comcerto.cpp:7425: ts 1002: RTP destination is 02:ad:c5:00:02:c5
72Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1002]: ACK received, ts=1002, flags=0000, data=2
73Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1003]: Call redirected, ts=1003, flags=0000, data=4
74Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Connected: CAS event, ts=254, flags=0000, data=7
75Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Connected: Statistics received, ts=254, flags=0000, data=0
76Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Connected: Statistics received, ts=254, flags=0000, data=0
77Jan 14 10:36:33 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Connected: RTP monitor, ts=254, flags=0000, data=1
78Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 5 (Call is being processed!): cid=4, did=0, tid=4, rid=0, sid=0, nid=0
79Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 6 (Remote phone is ringing!): cid=4, did=6, tid=4, rid=0, sid=0, nid=0
80Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2499: ---> ringing with status code 180
81Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1003]: Remote is ringing, ts=1003, flags=0000, data=4
82Jan 14 10:36:33 sip_ua[454]: conference.cpp:653: ---> StaticConferenceFocus: Participant status changed, ts=2000, flags=0000, data=1003
83Jan 14 10:36:33 sip_ua[454]: conference.cpp:285: ---> ConferenceFocus: Participant status changed, ts=2000, flags=0000, data=1003
84Jan 14 10:36:33 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 16 (2xx received for request!): cid=4, did=6, tid=5, rid=0, sid=0, nid=0
85Jan 14 10:36:33 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1003]: Message answered 2xx, ts=1003, flags=0000, data=4
86Jan 14 10:36:34 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Connected: RTP monitor, ts=254, flags=0000, data=0
87Jan 14 10:36:38 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Connected: Statistics received, ts=254, flags=0000, data=0
88Jan 14 10:36:38 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Connected: Statistics received, ts=254, flags=0000, data=0
89Jan 14 10:36:40 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Connected: CAS event, ts=254, flags=0000, data=15
90Jan 14 10:36:40 sip_ua[454]: comcerto.cpp:7145: ts 254: stopping RTP stream
91Jan 14 10:36:40 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: Call disconnected, ts=254, flags=0000, data=1
92Jan 14 10:36:40 sip_ua[510]: repro.cpp:778: doSessionAccounting(): Session Ended 'branch=z9hG4bK338354031'
93Jan 14 10:36:40 sip_ua[510]: repro.cpp:796: --> duration=7, [FS01]tel:disp@192.168.0.121: ---> []tel:022@192.168.0.121:
94Jan 14 10:36:40 sip_ua[510]: repro.cpp:1057: --> CDR: {"answer":1736850993,"duration":7,"hangup":1736851000,"org-host":"192.168.0.121","org-scheme":"tel","org-type":"FS01","org-user":"disp","to-host":"192.168.0.121","to-scheme":"tel","to-user":"022","
95Jan 14 10:36:40 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 14 (New request received!): cid=2, did=3, tid=7, rid=0, sid=0, nid=0
96Jan 14 10:36:40 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 21 (Bye Received!): cid=2, did=3, tid=7, rid=0, sid=0, nid=0
97Jan 14 10:36:40 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1002]: Call disconnected, ts=1002, flags=0000, data=2
98Jan 14 10:36:40 sip_ua[454]: comcerto.cpp:7145: ts 1002: stopping RTP stream
99Jan 14 10:36:40 sip_ua[454]: conference.cpp:653: ---> StaticConferenceFocus: Participant left the conference, ts=2000, flags=0000, data=1002
100Jan 14 10:36:40 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 16 (2xx received for request!): cid=1, did=-1, tid=6, rid=0, sid=0, nid=0
101Jan 14 10:36:40 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: Message answered 2xx, ts=254, flags=0000, data=1
102Jan 14 10:36:44 sip_ua[510]: repro.cpp:868: doSessionAccounting(): Session Established 'branch=z9hG4bK1570660921'
103Jan 14 10:36:44 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 7 (Remote phone has answered!): cid=4, did=6, tid=4, rid=0, sid=0, nid=0
104Jan 14 10:36:44 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1003]: RTP parameters, ts=1003, flags=0000, data=4
105Jan 14 10:36:44 sip_ua[454]: conference.cpp:653: ---> StaticConferenceFocus: Participant status changed, ts=2000, flags=0000, data=1003
106Jan 14 10:36:44 sip_ua[454]: conference.cpp:285: ---> ConferenceFocus: Participant status changed, ts=2000, flags=0000, data=1003
107Jan 14 10:36:44 sip_ua[454]: comcerto.cpp:7299: --> ts 1003: 192.168.0.121[12006] --> 192.168.0.133[10002]
108Jan 14 10:36:44 sip_ua[454]: comcerto.cpp:7300: --> ts 1003: codec PCMA, VAD is on, red=0
109Jan 14 10:36:44 sip_ua[454]: comcerto.cpp:7301: --> audio pt: 8/8, event pt: 101/101, VBD pt: 98/98
110Jan 14 10:36:44 sip_ua[454]: comcerto.cpp:7359: ts 1003: calling createConnection()
111Jan 14 10:36:44 sip_ua[454]: comcerto.cpp:7403: routing 192.168.0.133 to 192.168.0.133 (eth0)
112Jan 14 10:36:44 sip_ua[454]: comcerto.cpp:7415: getMac(192.168.0.133): 02:ad:c3:00:00:06
113Jan 14 10:36:44 sip_ua[454]: comcerto.cpp:7425: ts 1001: RTP destination is 02:ad:c3:00:00:06
114Jan 14 10:36:44 sip_ua[454]: comcerto.cpp:7124: ts 1001: starting RTP stream
115Jan 14 10:36:44 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1001]: Call answered, ts=1003, flags=0000, data=4
116Jan 14 10:36:44 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: Statistics received, ts=254, flags=0000, data=0
117Jan 14 10:36:44 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: Statistics received, ts=254, flags=0000, data=0
118Jan 14 10:36:45 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 22 (Call Context is released!): cid=1, did=0, tid=0, rid=0, sid=0, nid=0
119Jan 14 10:36:45 sip_ua[510]: repro.cpp:778: doSessionAccounting(): Session Ended 'branch=z9hG4bK-524287-1---780003237e120e02'
120Jan 14 10:36:45 sip_ua[510]: repro.cpp:796: --> duration=1, [Conf]tel:00@192.168.0.121: ---> [FXS]sip:op1@192.168.0.133:
121Jan 14 10:36:45 sip_ua[510]: repro.cpp:1057: --> CDR: {"answer":1736851004,"duration":1,"hangup":1736851005,"org-host":"192.168.0.121","org-scheme":"tel","org-type":"Conf","org-user":"00","to-host":"192.168.0.133","to-scheme":"sip","to-type":"FXS","to
122Jan 14 10:36:45 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 14 (New request received!): cid=4, did=6, tid=8, rid=0, sid=0, nid=0
123Jan 14 10:36:45 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 21 (Bye Received!): cid=4, did=6, tid=8, rid=0, sid=0, nid=0
124Jan 14 10:36:45 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1001]: Call disconnected, ts=1003, flags=0000, data=4
125Jan 14 10:36:45 sip_ua[454]: comcerto.cpp:7145: ts 1001: stopping RTP stream
126Jan 14 10:36:45 sip_ua[454]: conference.cpp:653: ---> StaticConferenceFocus: Participant left the conference, ts=2000, flags=0000, data=1001
127Jan 14 10:36:48 sip_ua[454]: pps.cpp:97: ---> ts=2, state=Idle: DTMF detected, ts=2, flags=0000, data=0
128Jan 14 10:36:48 sip_ua[454]: pps.cpp:37: ts 2: dialing 00
129Jan 14 10:36:48 sip_ua[454]: user_agent.cpp:3892: --> ua_dial_out() -> sip:00@192.168.0.121...
130Jan 14 10:36:48 sip_ua[510]: repro.cpp:644: doSessionAccounting(): Session Created 'branch=z9hG4bK649684022'
131Jan 14 10:36:48 sip_ua[478]: user_agent.cpp:2134: ---> transport 0: SIP event 2 (New call received!): cid=8, did=9, tid=10, rid=0, sid=0, nid=0
132Jan 14 10:36:48 sip_ua[478]: user_agent.cpp:2272: INVITE received: sip:00@127.0.0.1:6060;transport=udp (Call-ID: 926968479@(null))
133Jan 14 10:36:48 sip_ua[454]: pps.cpp:97: ---> ts=2, state=Calling: Incoming call, ts=-1, flags=0001, data=8
134Jan 14 10:36:48 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: Incoming call, ts=-1, flags=0001, data=8
135Jan 14 10:36:48 sip_ua[454]: fxs.cpp:434: ---> ts=255, state=Idle: Incoming call, ts=-1, flags=0001, data=8
136Jan 14 10:36:48 sip_ua[454]: conference.cpp:96: ---> ConferenceFocus: Incoming call, ts=-1, flags=0001, data=8
137Jan 14 10:36:48 sip_ua[454]: conference.cpp:135: --> 1001: 0x4fc280
138Jan 14 10:36:48 sip_ua[454]: conference.cpp:748: ---> ConferenceParticipant[1001]: Incoming call, ts=1001, flags=0005, data=8
139Jan 14 10:36:48 sip_ua[454]: conference.cpp:552: --> checkpoint 2: 'disp@192.168.0.121'
140Jan 14 10:36:48 sip_ua[454]: conference.cpp:556: --> checkpoint 3a: 1001
141Jan 14 10:36:48 sip_ua[454]: conference.cpp:557: --> checkpoint 3b: 0x4fc280
142Jan 14 10:36:48 sip_ua[454]: conference.cpp:558: --> checkpoint 3c: 0x4fc280
143Jan 14 10:36:48 sip_ua[454]: conference.cpp:556: --> checkpoint 3a: 1003
144Jan 14 10:36:48 sip_ua[454]: conference.cpp:557: --> checkpoint 3b: (nil)
145Jan 14 10:36:48 sip_ua[454]: conference.cpp:558: --> checkpoint 3c: 0x480e88
146Jan 14 10:36:48 kernel: comcerto_wdt: closed unexpectedly. WDT will not stop!
147Jan 1 00:00:13 syslogd started: BusyBox v1.18.5
148Jan 1 00:00:13 kernel: klogd started: BusyBox v1.18.5 (2024-08-18 17:59:54 YEKT)
149Jan 1 00:00:14 kernel: Linux version 2.6.22.19-4.07.0-candidate1-c300evm (alx@alx) (gcc version 5.3.0 (GCC) ) #1 Fri Mar 18 16:22:33 YEKT 2022
150Jan 1 00:00:14 kernel: CPU: ARMv6-compatible processor [4117b361] revision 1 (ARMv6TEJ), cr=00c5387f
151Jan 1 00:00:14 kernel: Machine: Comcerto 300 (x570)
152Jan 1 00:00:14 kernel: Memory policy: ECC disabled, Data cache writeback
153Jan 1 00:00:14 kernel: On node 0 totalpages: 28416
154Jan 1 00:00:14 kernel: DMA zone: 222 pages used for memmap
155Jan 1 00:00:14 kernel: DMA zone: 0 pages reserved
156Jan 1 00:00:14 kernel: DMA zone: 28194 pages, LIFO batch:7
157Jan 1 00:00:14 kernel: Normal zone: 0 pages used for memmap
158Jan 1 00:00:14 kernel: CPU0: D VIPT write-back cache
159Jan 1 00:00:14 kernel: Time: timer3 clocksource has been installed.
160Jan 1 00:00:14 kernel: Switched to high resolution mode on CPU 0
161Jan 1 00:00:14 kernel: IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
162Jan 1 00:00:14 kernel: TCP established hash table entries: 4096 (order: 3, 32768 bytes)
163Jan 1 00:00:14 kernel: TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
164Jan 1 00:00:14 kernel: TCP: Hash tables configured (established 4096 bind 4096)
165Jan 1 00:00:14 kernel: TCP reno registered
166Jan 1 00:00:14 kernel: msp-driver: version 0.1
167Jan 1 00:00:14 kernel: JFFS2 version 2.2. (NAND) © 2001-2006 Red Hat, Inc.
168Jan 1 00:00:14 kernel: io scheduler noop registered
169Jan 1 00:00:14 kernel: io scheduler deadline registered (default)
170Jan 1 00:00:15 sysinit: brctl: SIOCGIFBR: Package not installed
171Jan 1 00:00:16 sysinit: sh: bad number
172Jan 1 00:00:16 sysinit: sh: bad number
173Jan 1 00:00:16 sysinit: sh: bad number
174Jan 1 00:00:16 sysinit: sh: bad number
175Jan 1 00:00:16 sysinit: sh: bad number
176Jan 1 00:00:16 sysinit: sh: bad number
177Jan 1 00:00:16 sysinit: sh: bad number
178Jan 1 00:00:16 sysinit: sh: bad number
179Jan 1 00:00:16 dnsmasq[376]: started, version 2.89 cachesize 150
180Jan 1 00:00:16 dnsmasq[376]: compile time options: IPv6 GNU-getopt no-DBus no-UBus no-i18n no-IDN DHCP DHCPv6 no-Lua TFTP no-conntrack no-ipset no-nftset no-auth no-cryptohash no-DNSSEC loop-detect no-inotify dumpfile
181Jan 1 00:00:16 dnsmasq[376]: using only locally-known addresses for lan
182Jan 1 00:00:16 dnsmasq[376]: no servers found in /tmp/resolv.conf.auto, will retry
183Jan 1 00:00:16 dnsmasq[376]: read /etc/hosts - 1 names
184Jan 1 00:00:17 kernel: NET: Registered protocol family 27
185Jan 1 00:00:18 dropbear[427]: Failed loading /etc/dropbear/dropbear_dss_host_key
186Jan 1 00:00:18 dropbear[428]: Running in background
187Jan 1 00:00:20 sysinit: sh: bad number
188Jan 1 00:00:20 sysinit: sh: bad number
189Jan 1 00:00:20 sysinit: sh: bad number
190Jan 1 00:00:20 sysinit: sh: bad number
191Jan 1 00:00:20 sysinit: sh: bad number
192Jan 1 00:00:20 sysinit: sh: bad number
193Jan 1 00:00:20 sysinit: sh: bad number
194Jan 1 00:00:20 sysinit: sh: bad number
195Jan 1 00:00:20 sysinit: dnsmasq: failed to create listening socket for port 53: Address already in use
196Jan 1 00:00:20 dnsmasq[443]: failed to create listening socket for port 53: Address already in use
197Jan 1 00:00:20 dnsmasq[443]: FAILED to start up
198Jan 1 00:00:21 sysinit: starting SIP UA daemon: sip_ua...net.unix.max_dgram_qlen = 2048
199Jan 1 00:00:21 sysinit: done.
200Jan 1 00:00:22 sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_checksum' is an unknown key
201Jan 1 00:00:22 sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_max' is an unknown key
202Jan 1 00:00:22 sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_tcp_timeout_established' is an unknown key
203Jan 1 00:00:22 sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_udp_timeout' is an unknown key
204Jan 1 00:00:22 sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_udp_timeout_stream' is an unknown key
205Jan 1 00:00:26 kernel: eth1: no IPv6 routers present
206Jan 1 00:00:30 sip_ua[454]: sip_ua.cpp:554: starting sip_ua
207Jan 1 00:00:30 sip_ua[454]: sip_ua.cpp:555: main thread PID is 454
208Jan 1 00:00:30 sip_ua[454]: fw-env.cpp:52: Fw_env: /dev/mtd5: partition size is 65536
209Jan 1 00:00:30 sip_ua[454]: fw-env.cpp:76: Fw_env: /dev/mtd5: CRC32: readed: d211d87d, computed: 917a9d83
210Jan 1 00:00:30 sip_ua[454]: fw-env.cpp:137: Fw_env: cannot open /dev/mtd6: No such file or directory
211Jan 1 00:00:30 sip_ua[454]: fw-env.cpp:52: Fw_env: /dev/mtd5: partition size is 65536
212Jan 1 00:00:30 sip_ua[454]: fw-env.cpp:76: Fw_env: /dev/mtd5: CRC32: readed: d211d87d, computed: d211d87d
213Jan 1 00:00:30 sip_ua[454]: sip_ua.cpp:570: serial number: G04454
214Jan 1 00:00:30 sip_ua[454]: sip_ua.cpp:586: Waiting for jffs2 scan finish and CPU idle time > 90%...
215Jan 1 00:00:30 kernel: JFFS2 notice: (253) check_node_data: wrong data CRC in data node at 0x03f37000: read 0xe6f33735, calculated 0xe0ce4b0.
216Jan 1 00:00:31 sip_ua[454]: sip_ua.cpp:595: CPU idle 0%
217Jan 1 00:00:32 sip_ua[454]: sip_ua.cpp:595: CPU idle 0%
218Jan 1 00:00:33 sip_ua[454]: sip_ua.cpp:595: CPU idle 95%
219Jan 1 00:00:33 sip_ua[454]: scheduler.cpp:77: Initializing scheduling API
220Jan 1 00:00:33 sip_ua[454]: scheduler.cpp:107: Created schedule main scheduler
221Jan 1 00:00:33 sip_ua[454]: comcerto.cpp:5105: ==> SFKEYS: 0460 0305 bfec fef7
222Jan 1 00:00:33 sip_ua[454]: comcerto.cpp:5491: Comcerto C300 device: M82359 Rev.A
223Jan 1 00:00:33 sip_ua[454]: comcerto.cpp:5492: Comcerto C300 firmware version: v11_26_03_08_SS_04
224Jan 1 00:00:33 sip_ua[454]: comcerto.cpp:5493: Comcerto C300 SPU version: C64V_7_10_13
225Jan 1 00:00:33 sip_ua[454]: comcerto.cpp:5494: Device initialized successfully
226Jan 1 00:00:33 sip_ua[454]: comcerto.cpp:5501: TDM initialized successfully
227Jan 1 00:00:33 sip_ua[454]: comcerto.cpp:5384: Device mac address: 02:ad:c5:00:02:c5
228Jan 1 00:00:33 sip_ua[454]: comcerto.cpp:5521: Channels available: 160 (G.711 20ms)
229Jan 1 00:00:34 sip_ua[458]: regSyncAgent.cpp:460: loading regDataBase from /lib/sip_ua/regDataBase.xml...
230Jan 1 00:00:34 sip_ua[458]: regSyncAgent.cpp:489: file timestamp is 1736845274 sec in the future
231Jan 14 09:01:48 sip_ua[458]: regSyncAgent.cpp:525: 2 object(s) loaded
232Jan 14 09:01:48 sip_ua[454]: repro.cpp:1544: --> skipping secure transport: no cert file
233Jan 14 09:01:48 sip_ua[454]: repro.cpp:1544: --> skipping secure transport: no cert file
234Jan 14 09:01:50 sip_ua[454]: poller.cpp:3404: firmware revision: 52
235Jan 14 09:01:50 sip_ua[477]: poller.cpp:2786: Configuring FPGA...
236Jan 14 09:01:50 sip_ua[477]: poller.cpp:2795: FPGA configured successfully
237Jan 14 09:01:50 sip_ua[477]: poller.cpp:2839: mofule 1: FS01 found
238Jan 14 09:01:50 sip_ua[477]: poller.cpp:2867: mofule 2: FS01 found
239Jan 14 09:01:50 sip_ua[477]: poller.cpp:2895: board address is 1
240Jan 14 09:01:50 sip_ua[454]: mediaProxy.cpp:31: --> MediaProxy::start()
241Jan 14 09:01:51 sip_ua[477]: poller.cpp:2513: switching to CRC32 mode
242Jan 14 09:01:51 sip_ua[477]: poller.cpp:890: ===> command globalconf received
243Jan 14 09:01:51 dnsmasq[376]: reading /tmp/resolv.conf.auto
244Jan 14 09:01:51 dnsmasq[376]: using nameserver 8.8.8.8#53
245Jan 14 09:01:51 dnsmasq[376]: using only locally-known addresses for lan
246Jan 14 09:01:51 sip_ua[477]: comcerto.cpp:2217: !!!!! function IP_ADDRESS_v6 (0x0310): error CNF_ERROR_IP_ADDRESS_BAD_IP_ADDRESS (0x0b03):
247Jan 14 09:01:51 sip_ua[477]: comcerto.cpp:2218: Invalid IP Address
248Jan 14 09:01:51 sip_ua[477]: comcerto.cpp:5282: comcerto_set_ip6() failed (result=-2819)
249Jan 14 09:01:51 sip_ua[477]: poller.cpp:1431: downloading sound files from http://192.168.1.104/files/ve-01/sounds...
250Jan 14 09:01:51 sip_ua[454]: sip_ua.cpp:875: IP change 127.0.0.1 --> 192.168.0.121 detected
251Jan 14 10:38:18 sip_ua[477]: poller.cpp:2429: duplicate request 179 (332 ms)
252Jan 14 10:38:18 sip_ua[477]: poller.cpp:2429: duplicate request 181 (342 ms)
253Jan 14 10:38:19 sip_ua[477]: fs01.cpp:136: module 1: FS01 created at base address 0x0400
254Jan 14 10:38:19 sip_ua[477]: poller.cpp:2429: duplicate request 183 (0 ms)
255Jan 14 10:38:19 sip_ua[477]: poller.cpp:2429: duplicate request 182 (273 ms)
256Jan 14 10:38:19 sip_ua[477]: fs01.cpp:333: module 1 [FS01]: cofidec Si3210 Revision E detected
257Jan 14 10:38:19 sip_ua[477]: fs01.cpp:136: module 2: FS01 created at base address 0x0500
258Jan 14 10:38:19 sip_ua[477]: poller.cpp:890: ===> command sslapply received
259Jan 14 10:38:19 sip_ua[477]: poller.cpp:890: ===> command userlist received
260Jan 14 10:38:20 sip_ua[454]: repro.cpp:1544: --> skipping secure transport: no cert file
261Jan 14 10:38:20 sip_ua[454]: repro.cpp:1544: --> skipping secure transport: no cert file
262Jan 14 10:38:20 sip_ua[458]: regSyncAgent.cpp:842: connected to repro
263Jan 14 10:38:20 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: Channel settings, ts=254, flags=0000, data=0
264Jan 14 10:38:20 sip_ua[454]: pps.cpp:97: ---> ts=2, state=Idle: Channel settings, ts=2, flags=0000, data=0
265Jan 14 10:38:20 sip_ua[454]: fxs.cpp:434: ---> ts=255, state=Idle: Channel settings, ts=255, flags=0000, data=0
266Jan 14 10:38:20 sip_ua[454]: pps.cpp:97: ---> ts=2, state=Idle: IP address changed, ts=-1, flags=0001, data=1
267Jan 14 10:38:20 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: IP address changed, ts=-1, flags=0001, data=1
268Jan 14 10:38:20 sip_ua[454]: fxs.cpp:434: ---> ts=255, state=Idle: IP address changed, ts=-1, flags=0001, data=1
269Jan 14 10:38:20 sip_ua[454]: pps.cpp:97: ---> ts=2, state=Idle: IP address changed, ts=-1, flags=0002, data=1
270Jan 14 10:38:20 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: IP address changed, ts=-1, flags=0002, data=1
271Jan 14 10:38:20 sip_ua[454]: fxs.cpp:434: ---> ts=255, state=Idle: IP address changed, ts=-1, flags=0002, data=1
272Jan 14 10:38:21 sip_ua[477]: repro.cpp:1958: User directory updated
273Jan 14 10:38:21 sip_ua[477]: poller.cpp:2429: duplicate request 187 (2 ms)
274Jan 14 10:38:21 sip_ua[477]: poller.cpp:2429: duplicate request 187 (6 ms)
275Jan 14 10:38:21 sip_ua[477]: poller.cpp:890: ===> command ctime received
276Jan 14 10:38:21 sip_ua[477]: poller.cpp:890: ===> command callgroups received
277Jan 14 10:38:21 sip_ua[477]: poller.cpp:890: ===> command routes received
278Jan 14 10:38:21 sip_ua[477]: poller.cpp:890: ===> command conferences received
279Jan 14 10:38:21 sip_ua[454]: pps.cpp:97: ---> ts=2, state=Idle: Channel settings, ts=-1, flags=0001, data=0
280Jan 14 10:38:21 sip_ua[454]: fxs.cpp:434: ---> ts=254, state=Idle: Channel settings, ts=-1, flags=0001, data=0
281Jan 14 10:38:21 sip_ua[454]: fxs.cpp:434: ---> ts=255, state=Idle: Channel settings, ts=-1, flags=0001, data=0
282Jan 14 10:38:21 sip_ua[454]: virtualChannel.cpp:130: ---> VirtualChannelManager: conference '00' created
283Jan 14 10:38:21 sip_ua[454]: virtualChannel.cpp:139: ---> VirtualChannelManager: conference '00' found
284Jan 14 10:38:21 sip_ua[454]: conference.cpp:653: ---> StaticConferenceFocus: Channel settings, ts=2000, flags=0000, data=0
285Jan 14 10:38:21 sip_ua[454]: conference.cpp:285: ---> ConferenceFocus: Channel settings, ts=2000, flags=0000, data=0
286Jan 14 10:38:21 sip_ua[477]: poller.cpp:890: ===> command registrations received
287Jan 14 10:38:21 sip_ua[477]: poller.cpp:1149: --> registrations updated.
288Jan 14 10:38:21 sip_ua[477]: fs01.cpp:333: module 2 [FS01]: cofidec Si3210 Revision E detected
289Jan 14 10:38:21 sip_ua[477]: fs01.cpp:376: module 1 [FS01]: DC-DC ON
290Jan 14 10:38:21 sip_ua[477]: fs01.cpp:390: module 1 [FS01]: DC-DC calibration started...
291Jan 14 10:38:21 sip_ua[477]: fs01.cpp:427: module 1 [FS01]: SLIC calibration started...
292Jan 14 10:38:22 sip_ua[477]: fs01.cpp:376: module 2 [FS01]: DC-DC ON
293Jan 14 10:38:22 sip_ua[477]: poller.cpp:3273: download complete
294Jan 14 10:38:22 sip_ua[477]: fs01.cpp:390: module 2 [FS01]: DC-DC calibration started...
295Jan 14 10:38:22 sip_ua[477]: fs01.cpp:427: module 2 [FS01]: SLIC calibration started...
296Jan 14 10:38:25 sip_ua[477]: fs01.cpp:541: module 1 [FS01]: SLIC calibration 2 started...
297Jan 14 10:38:25 sip_ua[477]: fs01.cpp:626: module 1 [FS01]: init complete
298Jan 14 10:38:25 sip_ua[477]: fs01.cpp:541: module 2 [FS01]: SLIC calibration 2 started...
299Jan 14 10:38:26 sip_ua[477]: fs01.cpp:626: module 2 [FS01]: init complete
300Jan 14 10:38:27 kernel: eth2: no IPv6 routers present
301Jan 14 10:42:31 dropbear[519]: Child connection from 192.168.0.142:51314
302Jan 14 10:42:32 dropbear[519]: Pubkey auth succeeded for 'root' with ssh-rsa key SHA256:8i65UsekgFf6uAr6cmxT7M+qcX1JHrmsBe6AQj5aJ9c from 192.168.0.142:51314