Sniffed 'module.update' time=1121605729000000 thread=014B2ED8 data=00000000 retval='(null)'
  param['module'] = 'h323'
  param['routed'] = '0'
  param['routing'] = '0'
  param['total'] = '8'
  param['chans'] = '0'
  6:55.647	      Transactor:2fd478	    gkserver.cxx(2817)	B-Entry	==> H323GatekeeperListener::OnReceiveAdmissionRequest
  6:55.648	      Transactor:2fd478	    gkserver.cxx(2775)	B-Entry	====> H323GatekeeperListener::OnAdmission
  6:55.663	      Transactor:2fd478	    gkserver.cxx(3627)	B-Entry	======> H323GatekeeperServer::OnAdmission
  6:55.664	      Transactor:2fd478	    gkserver.cxx(1392)	B-Entry	========> H323GatekeeperCall::OnAdmission
Sniffed 'call.route' time=1121605749281250 thread=00000000 data=00000000 retval='(null)'
  param['called'] = '1001'
  6:55.665	      Transactor:2fd478	    gkserver.cxx(1392)	B-Exit	<======== H323GatekeeperCall::OnAdmission
  6:55.665	      Transactor:2fd478	    gkserver.cxx(3627)	B-Exit	<====== H323GatekeeperServer::OnAdmission
  6:55.665	      Transactor:2fd478	    gkserver.cxx(2775)	B-Exit	<==== H323GatekeeperListener::OnAdmission
  6:55.666	      Transactor:2fd478	    gkserver.cxx(621)	B-Entry	====> H323GatekeeperRequest::WritePDU
  6:55.666	      Transactor:2fd478	    gkserver.cxx(621)	B-Exit	<==== H323GatekeeperRequest::WritePDU
  6:55.667	      Transactor:2fd478	    gkserver.cxx(2817)	B-Exit	<== H323GatekeeperListener::OnReceiveAdmissionRequest
  6:55.766	      Transactor:2fd478	    gkserver.cxx(2817)	B-Entry	==> H323GatekeeperListener::OnReceiveAdmissionRequest
  6:55.768	      Transactor:2fd478	    gkserver.cxx(2775)	B-Entry	====> H323GatekeeperListener::OnAdmission
  6:55.768	Sniffed 'chan.startup' time=1121605749390625 thread=014B2ED8 data=00000000 retval='(null)'
  param['id'] = 'h323/9'
  param['module'] = 'h323'
  param['status'] = 'incoming'
  param['address'] = 'ip$10.41.212.222:4008'
      Transactor:2fd478	    gkserver.cxx(3627)	B-Entry	======> H323GatekeeperServer::OnAdmission
  6:55.768	      Transactor:2fd478	    gkserver.cxx(1392)	B-Entry	========> H323GatekeeperCall::OnAdmission
  6:55.769	      Transactor:2fd478	    gkserver.cxx(1392)	B-Exit	<======== H323GatekeeperCall::OnAdmission
  6:55.769	Sniffed 'call.cdr' time=1121605749390625 thread=014B2ED8 data=00000000 retval='(null)'
  param['operation'] = 'initialize'
  param['time'] = '1121605749'
  param['chan'] = 'h323/9'
  param['address'] = 'ip$10.41.212.222:4008'
  param['direction'] = 'incoming'
  param['billid'] = ''
  param['caller'] = ''
  param['called'] = ''
  param['duration'] = '0'
  param['billtime'] = '0'
  param['ringtime'] = '0'
  param['status'] = 'incoming'
  param['reason'] = ''
      Transactor:2fd478	    gkserver.cxx(3627)	B-Exit	<====== H323GatekeeperServer::OnAdmission
  6:55.769	      Transactor:2fd478	    gkserver.cxx(2775)	B-Exit	<==== H323GatekeeperListener::OnAdmission
  6:55.769	      Transactor:2fd478	    gkserver.cxx(621)	B-Entry	====> H323GatekeeperRequest::WritePDU
  6:55.772	      Transactor:2fd478	    gkserver.cxx(621)	B-Exit	<==== H323GatekeeperRequest::WritePDU
  6:55.772	      Transactor:2fd478	    gkserver.cxx(2817)	B-Exit	<== H323GatekeeperListener::OnReceiveAdmissionRequest
Sniffed 'call.route' time=1121605749390625 thread=014C8390 data=015081B0 retval='(null)'
  param['id'] = 'h323/9'
  param['module'] = 'h323'
  param['status'] = 'incoming'
  param['address'] = 'ip$10.41.212.222:4008'
  param['context'] = 'default'
  param['callername'] = '1002 [10.41.212.222]'
  param['caller'] = '1002'
  param['called'] = 'yate'
Sniffed 'call.cdr' time=1121605749390625 thread=014B2ED8 data=00000000 retval='(null)'
  param['operation'] = 'update'
  param['time'] = '1121605749'
  param['chan'] = 'h323/9'
  param['address'] = 'ip$10.41.212.222:4008'
  param['direction'] = 'incoming'
  param['billid'] = ''
  param['caller'] = '1002'
  param['called'] = 'yate'
  param['duration'] = '0'
  param['billtime'] = '0'
  param['ringtime'] = '0'
  param['status'] = 'incoming'
  param['reason'] = ''
Sniffed 'chan.hangup' time=1121605749390625 thread=014B2ED8 data=00000000 retval='(null)'
  param['id'] = 'h323/9'
  param['module'] = 'h323'
  param['status'] = 'rejected'
  param['address'] = 'ip$10.41.212.222:4008'
  param['reason'] = 'Normal cleanup'
Sniffed 'call.cdr' time=1121605749406250 thread=014B2ED8 data=00000000 retval='(null)'
  param['operation'] = 'finalize'
  param['time'] = '1121605749'
  param['chan'] = 'h323/9'
  param['address'] = 'ip$10.41.212.222:4008'
  param['direction'] = 'incoming'
  param['billid'] = ''
  param['caller'] = '1002'
  param['called'] = 'yate'
  param['duration'] = '0'
  param['billtime'] = '0'
  param['ringtime'] = '0'
  param['status'] = 'rejected'
  param['reason'] = 'Normal cleanup'
  6:55.888	      Transactor:2fd478	    gkserver.cxx(2899)	B-Entry	==> H323GatekeeperListener::OnReceiveDisengageRequest
  6:55.890	      Transactor:2fd478	    gkserver.cxx(2881)	B-Entry	====> H323GatekeeperListener::OnDisengage
  6:55.890	      Transactor:2fd478	    gkserver.cxx(3693)	B-Entry	======> H323GatekeeperServer::OnDisengage
  6:55.890	      Transactor:2fd478	    gkserver.cxx(1630)	B-Entry	========> H323GatekeeperCall::OnDisengage
  6:55.891	      Transactor:2fd478	    gkserver.cxx(1630)	B-Exit	<======== H323GatekeeperCall::OnDisengage
  6:55.891	      Transactor:2fd478	    gkserver.cxx(3693)	B-Exit	<====== H323GatekeeperServer::OnDisengage
  6:55.891	      Transactor:2fd478	    gkserver.cxx(2881)	B-Exit	<==== H323GatekeeperListener::OnDisengage
  6:55.891	      Transactor:2fd478	    gkserver.cxx(621)	B-Entry	====> H323GatekeeperRequest::WritePDU
  6:55.893	      Transactor:2fd478	    gkserver.cxx(621)	B-Exit	<==== H323GatekeeperRequest::WritePDU
  6:55.894	      Transactor:2fd478	    gkserver.cxx(2899)	B-Exit	<== H323GatekeeperListener::OnReceiveDisengageRequest
  6:55.896	      Transactor:2fd478	    gkserver.cxx(2899)	B-Entry	==> H323GatekeeperListener::OnReceiveDisengageRequest
  6:55.897	      Transactor:2fd478	    gkserver.cxx(2881)	B-Entry	====> H323GatekeeperListener::OnDisengage
  6:55.898	      Transactor:2fd478	    gkserver.cxx(3693)	B-Entry	======> H323GatekeeperServer::OnDisengage
  6:55.898	      Transactor:2fd478	    gkserver.cxx(1630)	B-Entry	========> H323GatekeeperCall::OnDisengage
  6:55.899	      Transactor:2fd478	    gkserver.cxx(1630)	B-Exit	<======== H323GatekeeperCall::OnDisengage
  6:55.899	      Transactor:2fd478	    gkserver.cxx(3693)	B-Exit	<====== H323GatekeeperServer::OnDisengage
  6:55.899	      Transactor:2fd478	    gkserver.cxx(2881)	B-Exit	<==== H323GatekeeperListener::OnDisengage
  6:55.899	      Transactor:2fd478	    gkserver.cxx(621)	B-Entry	====> H323GatekeeperRequest::WritePDU
  6:55.900	      Transactor:2fd478	    gkserver.cxx(621)	B-Exit	<==== H323GatekeeperRequest::WritePDU
  6:55.900	      Transactor:2fd478	    gkserver.cxx(2899)	B-Exit	<== H323GatekeeperListener::OnReceiveDisengageRequest