Jul 3 00:14:31 hs_voip: ping Retry Timer result=0 Jul 3 00:14:31 hs_voip: UA receive Ping Jul 3 00:14:34 hs_voip: select >=0 Jul 3 00:14:34 hs_voip: voipSipPingStop3SecDeepSleepFd entery Jul 3 00:14:34 hs_voip: SIP:FD_ISSET->voipSipPingStop3SecDeepSleepFd=22,read: 0x1 Jul 3 00:14:34 hs_voip: !!!voipSipPingStop3SecDeepSleepFd receive timeout event Jul 3 00:14:34 hs_voip: hwtimer_stop and free voipSipPingStop3SecDeepSleepFd Jul 3 00:14:34 hs_voip: start dpmDeepsleepNormal Jul 3 00:14:34 hs_voip: voipRegisterStop3SecDeepSleepFd=0,voipRegisterFd=7,voipSipNhmStop3SecDeepSleepFd=0,voipSipNhmFd=8,voipSipPingStop3SecDeepSleepFd=0,voipSipPingFd=9,maxFd=9,httpTimerFd=0 Jul 2 22:15:02 kernel: ===| Jul 2 22:15:02 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:15:02 kernel: [AudioIdleBody],event=19 Jul 2 22:15:02 kernel: [AudioIdleExit] Jul 2 22:15:02 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:02 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:02 kernel: AIC28: disable 4096 Jul 2 22:15:02 kernel: [AudioSleepStateEntry] Jul 2 22:15:02 kernel: AIC28:Reset DSP Jul 2 22:15:02 kernel: [AudioSleepStateExit] Jul 2 22:15:02 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:02 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:02 kernel: AIC28: enable 4096 Jul 2 22:15:02 kernel: [AudioIdleEntry] Jul 2 22:15:02 kernel: Restarting tasks... done Jul 2 22:15:10 kernel: ===============| Jul 2 22:15:10 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:15:10 kernel: [AudioIdleBody],event=19 Jul 2 22:15:10 kernel: [AudioIdleExit] Jul 2 22:15:10 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:10 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:10 kernel: AIC28: disable 4096 Jul 2 22:15:10 kernel: [AudioSleepStateEntry] Jul 2 22:15:10 kernel: AIC28:Reset DSP Jul 2 22:15:10 kernel: [AudioSleepStateExit] Jul 2 22:15:10 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:10 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:10 kernel: AIC28: enable 4096 Jul 2 22:15:10 kernel: [AudioIdleEntry] Jul 2 22:15:10 kernel: Restarting tasks... done Jul 2 22:15:22 kernel: ==============| Jul 2 22:15:22 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:15:22 kernel: [AudioIdleBody],event=19 Jul 2 22:15:22 kernel: [AudioIdleExit] Jul 2 22:15:22 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:22 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:22 kernel: AIC28: disable 4096 Jul 2 22:15:22 kernel: [AudioSleepStateEntry] Jul 2 22:15:22 kernel: AIC28:Reset DSP Jul 2 22:15:22 kernel: [AudioSleepStateExit] Jul 2 22:15:22 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:22 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:22 kernel: AIC28: enable 4096 Jul 2 22:15:22 kernel: [AudioIdleEntry] Jul 2 22:15:22 kernel: Restarting tasks... done Jul 3 00:15:25 hs_voip: select >=0 Jul 3 00:15:25 hs_voip: voipSipPingFd entery Jul 3 00:15:25 hs_voip: SIP:FD_ISSET->voipSipPingFd=9,read: 0x1 Jul 3 00:15:25 hs_voip: !!!receive timeout event Jul 3 00:15:25 hs_voip: SIP:FD_ISSET->voipSipPingFd=9,read: 0x1 Jul 3 00:15:25 hs_voip: start dpmDeepsleepPause Jul 3 00:15:25 hs_voip: get voipSipPingStop3SecDeepSleepFd=:22 Jul 3 00:15:25 hs_voip: voipRegisterStop3SecDeepSleepFd=0,voipRegisterFd=7,voipSipNhmStop3SecDeepSleepFd=0,voipSipNhmFd=8,voipSipPingStop3SecDeepSleepFd=22,voipSipPingFd=9,maxFd=22,httpTimerFd=0 Jul 3 00:15:26 hs_voip: HS_VOIP_CCM_PING_REQUEST_TIMER_VALUE voipSipPingFd=9 - timer=55000 wncPingTimer=55 Jul 3 00:15:26 hs_voip: ping Retry Timer result=0 Jul 3 00:15:26 hs_voip: UA receive Ping Jul 3 00:15:28 hs_voip: select >=0 Jul 3 00:15:28 hs_voip: voipSipPingStop3SecDeepSleepFd entery Jul 3 00:15:28 hs_voip: SIP:FD_ISSET->voipSipPingStop3SecDeepSleepFd=22,read: 0x1 Jul 3 00:15:28 hs_voip: !!!voipSipPingStop3SecDeepSleepFd receive timeout event Jul 3 00:15:28 hs_voip: hwtimer_stop and free voipSipPingStop3SecDeepSleepFd Jul 3 00:15:28 hs_voip: start dpmDeepsleepNormal Jul 3 00:15:28 hs_voip: voipRegisterStop3SecDeepSleepFd=0,voipRegisterFd=7,voipSipNhmStop3SecDeepSleepFd=0,voipSipNhmFd=8,voipSipPingStop3SecDeepSleepFd=0,voipSipPingFd=9,maxFd=9,httpTimerFd=0 Jul 2 22:15:31 login[597]: root login on `pts/1' Jul 2 22:15:40 kernel: ===============| Jul 2 22:15:40 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:15:40 kernel: [AudioIdleBody],event=19 Jul 2 22:15:40 kernel: [AudioIdleExit] Jul 2 22:15:40 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:40 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:40 kernel: AIC28: disable 4096 Jul 2 22:15:40 kernel: [AudioSleepStateEntry] Jul 2 22:15:40 kernel: AIC28:Reset DSP Jul 2 22:15:40 kernel: [AudioSleepStateExit] Jul 2 22:15:40 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:40 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:40 kernel: AIC28: enable 4096 Jul 2 22:15:40 kernel: [AudioIdleEntry] Jul 2 22:15:40 kernel: Restarting tasks... done Jul 2 22:15:58 kernel: ===============| Jul 2 22:15:58 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:15:58 kernel: [AudioIdleBody],event=19 Jul 2 22:15:58 kernel: [AudioIdleExit] Jul 2 22:15:58 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:58 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:58 kernel: AIC28: disable 4096 Jul 2 22:15:58 kernel: [AudioSleepStateEntry] Jul 2 22:15:58 kernel: AIC28:Reset DSP Jul 2 22:15:58 kernel: [AudioSleepStateExit] Jul 2 22:15:58 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:15:58 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:15:58 kernel: AIC28: enable 4096 Jul 2 22:15:58 kernel: [AudioIdleEntry] Jul 2 22:15:58 kernel: Restarting tasks... done Jul 2 22:15:59 ota_total: Use wifi intrface. Jul 2 22:15:59 ota_total: Initial Wait Time = 1 seconds Periodic Interval = 1 Jul 2 22:15:59 ota_total: load the counter from file... Jul 2 22:15:59 ota_total: File not found: /root/ota/image/usb_counter.txt Jul 2 22:15:59 ota_total: No Test URL Jul 2 22:15:59 ota_total: SW version == W3_04NM00_20070112_14. Jul 2 22:15:59 ota_total: SW date == 2007/04/19. Jul 2 22:16:00 ota_total: IP Address was already assigned. Jul 2 22:16:00 ota_total: no need to update files... Jul 2 22:16:00 ota_total: message is /usr/ota_total/qpe_ota_msg.sh 5 Jul 2 22:16:01 ota_total: File /root/drivers/mac.txt MAC is 00 01 24 48 23 A1. Jul 2 22:16:01 ota_total: util::getMAC == enter. Jul 2 22:16:01 ota_total: --------MAC == 0001244823A1. Jul 2 22:16:01 ota_total: SW version == W3_04NM00_20070112_14. Jul 2 22:16:01 ota_total: SW date == 2007/04/19. Jul 2 22:16:01 ota_total: HW version == TWIN128M. Jul 2 22:16:01 ota_total: tffsa total is 23068672 bytes Jul 2 22:16:01 ota_total: tffsa total is 22 MB Jul 2 22:16:01 ota_total: Infomation partition size is :23068672 bytes Jul 2 22:16:01 ota_total: /root/Documents/ mount to /dev/tffsc2 Jul 2 22:16:01 ota_total: usb total is 49711104 bytes Jul 2 22:16:01 ota_total: usb ramain is 38879232 bytes Jul 2 22:16:01 ota_total: Usb storage remain size is :38879232 bytes Jul 2 22:16:01 ota_total: util::getSIPaccount == enter. Jul 2 22:16:01 ota_total: *********** length == 9. Jul 2 22:16:01 ota_total: *********** length == 9. Jul 2 22:16:01 ota_total: SIP account == helena45. Jul 2 22:16:01 ota_total: SIP password == 9so72vu9 . Jul 2 22:16:01 ota_total: util::OTA_Start == enter. Jul 2 22:16:03 kernel: SPI2:: drvHhalEventIndicationHandler :setting PHGHHAL_EVENT_POWER_WAKE Jul 2 22:16:03 ota_total: util::getImageInformation == enter. Jul 2 22:16:03 ota_total: NORMAL URL== http://gw1cfg.neufbox.neuf.fr:80/general_config_gw1.txt?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:03 ota_total: util::getImageInformation == before get_http. Jul 2 22:16:03 ota_total: get_http::get_http == enter. Jul 2 22:16:03 ota_total: URL= http://gw1cfg.neufbox.neuf.fr:80/general_config_gw1.txt?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:03 ota_total: http::parse_url == enter Jul 2 22:16:03 ota_total: parse_url::URL= http://gw1cfg.neufbox.neuf.fr:80/general_config_gw1.txt?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:03 ota_total: http::parse_url == http Jul 2 22:16:03 ota_total: http::lookup_port == enter Jul 2 22:16:03 ota_total: http::parse_url == port = 80 host = gw1cfg.neufbox.neuf.fr:80/general_config_gw1.txt?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:03 ota_total: http::parse_url == sp Jul 2 22:16:03 ota_total: http::parse_url port== 20480 path = general_config_gw1.txt?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:03 ota_total: http::parse_url port== 20480 path = general_config_gw1.txt?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:03 ota_total: get_http::get_http == parse_url. Jul 2 22:16:03 ota_total: http::get_http == before fopen. Jul 2 22:16:03 ota_total: http::get_http continue = 0 Jul 2 22:16:03 ota_total: http::get_http == after fopen. Jul 2 22:16:03 ota_total: http::lookup_host == enter Jul 2 22:16:03 kernel: SPI2:: drvIoctl :Ioctl confirm ack is got, cmd is :0x8b2c Jul 2 22:16:03 ota_total: http::get_http == start to get. Jul 2 22:16:03 ota_total: ++++++++++++xconnect Jul 2 22:16:03 ota_total: ++++++++++++socket Jul 2 22:16:03 ota_total: ++++++++++++xconneetsocketopt Jul 2 22:16:03 ota_total: ++++++++++++ before connect Jul 2 22:16:03 ota_total: ++++++++++++ connect success Jul 2 22:16:03 ota_total: ++++++++++++ after connect (success) Jul 2 22:16:03 ota_total: open_socket Jul 2 22:16:03 ota_total: http::get_http == after open socket. Jul 2 22:16:03 ota_total: http::get_http == don't use proxy. Jul 2 22:16:03 ota_total: http::get_http == finish the http get request. Jul 2 22:16:03 ota_total: http::get_http == 200 Jul 2 22:16:03 ota_total: gethrd = date Jul 2 22:16:03 ota_total: http::get_http == gethrd Jul 2 22:16:03 ota_total: gethrd = server Jul 2 22:16:03 ota_total: http::get_http == gethrd Jul 2 22:16:03 ota_total: gethrd = last-modified Jul 2 22:16:03 ota_total: http::get_http == gethrd Jul 2 22:16:03 ota_total: gethrd = etag Jul 2 22:16:03 ota_total: http::get_http == gethrd Jul 2 22:16:03 ota_total: gethrd = accept-ranges Jul 2 22:16:03 ota_total: http::get_http == gethrd Jul 2 22:16:03 ota_total: gethrd = content-length Jul 2 22:16:03 ota_total: http::get_http == gethrd Jul 2 22:16:03 ota_total: content-length = 421 Jul 2 22:16:03 ota_total: gethrd = connection Jul 2 22:16:03 ota_total: http::get_http == gethrd Jul 2 22:16:03 ota_total: gethrd = content-type Jul 2 22:16:03 ota_total: http::get_http == gethrd Jul 2 22:16:03 ota_total: usleepSeconds=10000 Jul 2 22:16:03 ota_total: util::getImageInformation == after get_http. Jul 2 22:16:03 ota_total: util::parsedownloadinfo == enter Jul 2 22:16:03 ota_total: util::parsedownloadinfo == open file success Jul 2 22:16:03 ota_total: **** SW date original == 2007/06/32 AAAAA Jul 2 22:16:03 ota_total: **** str len == 11BBB Jul 2 22:16:03 ota_total: **** SW date original == 2007/06/32 AAAAA Jul 2 22:16:03 ota_total: **** str len == 11EEE Jul 2 22:16:03 ota_total: *** SWdate: 2007/06/32 Jul 2 22:16:03 ota_total: *** url: http://192.168.0.102:80/images/ Jul 2 22:16:03 ota_total: *** kernel1 MD5: fac6ed4eee65ae5b6069f63018cfd984 Jul 2 22:16:03 ota_total: *** kernel2 MD5: 4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:03 ota_total: *** fs1 MD5: 4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:03 ota_total: *** fs1 SIZE: 20029440 Jul 2 22:16:03 ota_total: *** kernel1 SIZE: 2095300 Jul 2 22:16:03 ota_total: *** kernel2 SIZE: 2095300 Jul 2 22:16:03 ota_total: ####new image is newer than booting one. Jul 2 22:16:03 ota_total: open the download image information file Jul 2 22:16:03 ota_total: download image infor: date = 2007/05/32 bdownloadDat = 1 Jul 2 22:16:03 ota_total: fir = 2pp last= qq Jul 2 22:16:03 ota_total: new image: date = 2007/06/32 Jul 2 22:16:03 ota_total: fir = 2aa last=2bb Jul 2 22:16:03 ota_total: need to download new image(1).... Jul 2 22:16:03 ota_total: result 1 and length 11 Jul 2 22:16:03 ota_total: start to clean download info Jul 2 22:16:03 ota_total: deletedKernelSize (kernel1+kernel2+fs)= 0 Jul 2 22:16:03 ota_total: enter cleandownloadinfo Jul 2 22:16:03 ota_total: rm -rf /root/ota/image/OTAnewversion.txt Jul 2 22:16:03 ota_total: rm -rf /root/ota/image/QtopiaOtaInfo.conf Jul 2 22:16:03 ota_total: rm -rf /root/Documents/kernel1 Jul 2 22:16:03 ota_total: rm -rf /root/Documents/kernel2 Jul 2 22:16:03 ota_total: rm -rf /root/Documents/fs.bin Jul 2 22:16:03 ota_total: enter createdownloadinfo Jul 2 22:16:03 ota_total: [TWIN_128M_DATE] 2007/06/32 Jul 2 22:16:03 ota_total: [TWIN_128M_URL] http://192.168.0.102:80/images/ Jul 2 22:16:03 ota_total: [TWIN_128M_KERNEL1_MD5] fac6ed4eee65ae5b6069f63018cfd984 Jul 2 22:16:03 ota_total: [TWIN_128M_KERNEL2_MD5] 4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:03 ota_total: [TWIN_128M_FS_MD5] 4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:03 ota_total: [TWIN_128M_FS_SIZE_BYTES] 20029440 Jul 2 22:16:03 ota_total: [TWIN_128M_KERNEL1_SIZE_BYTES] 2095300 Jul 2 22:16:03 ota_total: [TWIN_128M_KERNEL2_SIZE_BYTES] 2095300 Jul 2 22:16:03 ota_total: enter createQtopiaConfigInfo Jul 2 22:16:03 ota_total: [ota_info] Jul 2 22:16:03 ota_total: kernel1MD5=fac6ed4eee65ae5b6069f63018cfd984 Jul 2 22:16:03 ota_total: kernel1Path=/root/Documents/kernel1 Jul 2 22:16:03 ota_total: kernel2MD5=4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:03 ota_total: kernel2Path=/root/Documents/kernel2 Jul 2 22:16:03 ota_total: fsMD5=4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:03 ota_total: fsPath=/root/Documents/fs.bin Jul 2 22:16:03 ota_total: updateKernel1=0 Jul 2 22:16:03 ota_total: before = 1 Jul 2 22:16:03 ota_total: Image total size is 22124740 Jul 2 22:16:03 ota_total: Image total size (sub already download size) is 22124740 Jul 2 22:16:03 ota_total: after = 1 Jul 2 22:16:03 ota_total: reset counter Jul 2 22:16:03 ota_total: rm -rf /root/ota/image/usb_counter.txt Jul 2 22:16:03 ota_total: no need to update files... Jul 2 22:16:03 ota_total: message is /usr/ota_total/qpe_ota_msg.sh 10 Jul 2 22:16:04 ota_total: getURLandMD5 == enter Jul 2 22:16:04 ota_total: getURLandMD5 == open file success Jul 2 22:16:04 ota_total: ** url: http://192.168.0.102:80/images/ Jul 2 22:16:04 ota_total: ** kernel1 MD5: fac6ed4eee65ae5b6069f63018cfd984 Jul 2 22:16:04 ota_total: ** kernel2 MD5: 4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:04 ota_total: ** fs1 MD5: 4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:04 ota_total: downloadKernel == enter. Jul 2 22:16:04 ota_total: downloadKernel -- URL is http://192.168.0.102:80/images/ kernel2?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:04 ota_total: get kernel == before get_http. Jul 2 22:16:04 ota_total: get_http::get_http == enter. Jul 2 22:16:04 ota_total: URL= http://192.168.0.102:80/images/ kernel2?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:04 ota_total: http::parse_url == enter Jul 2 22:16:04 ota_total: parse_url::URL= http://192.168.0.102:80/images/ kernel2?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:04 ota_total: http::parse_url == http Jul 2 22:16:04 ota_total: http::lookup_port == enter Jul 2 22:16:04 ota_total: http::parse_url == port = 80 host = 192.168.0.102:80/images/ kernel2?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:04 ota_total: http::parse_url == sp Jul 2 22:16:04 ota_total: http::parse_url port== 20480 path = images/ kernel2?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:04 ota_total: http::parse_url port== 20480 path = images/ kernel2?Hardware_type=TWIN128M&Software_type=W3_04NM00_20070112_14&Wifi_Mac_address=0001244823A1&sip_id=helena45@neuf.com&Partition=2 Jul 2 22:16:04 ota_total: get_http::get_http == parse_url. Jul 2 22:16:04 ota_total: http::get_http == before fopen. Jul 2 22:16:04 ota_total: http::get_http continue = 1 Jul 2 22:16:04 ota_total: http::get_http state = 0 Jul 2 22:16:04 ota_total: http::get_http == after fopen. Jul 2 22:16:04 ota_total: http::lookup_host == enter Jul 2 22:16:04 ota_total: http::get_http == start to get. Jul 2 22:16:04 ota_total: ++++++++++++xconnect Jul 2 22:16:04 ota_total: ++++++++++++socket Jul 2 22:16:04 ota_total: ++++++++++++xconneetsocketopt Jul 2 22:16:04 ota_total: ++++++++++++ before connect Jul 2 22:16:04 ota_total: ++++++++++++ connect success Jul 2 22:16:04 ota_total: ++++++++++++ after connect (success) Jul 2 22:16:04 ota_total: open_socket Jul 2 22:16:04 ota_total: http::get_http == after open socket. Jul 2 22:16:04 ota_total: http::get_http == don't use proxy. Jul 2 22:16:04 ota_total: http::get_http == finish the http get request. Jul 2 22:16:04 ota_total: http::get_http == 200 Jul 2 22:16:04 ota_total: gethrd = date Jul 2 22:16:04 ota_total: http::get_http == gethrd Jul 2 22:16:04 ota_total: gethrd = server Jul 2 22:16:04 ota_total: http::get_http == gethrd Jul 2 22:16:04 ota_total: gethrd = content-length Jul 2 22:16:04 ota_total: http::get_http == gethrd Jul 2 22:16:04 ota_total: content-length = 1234 Jul 2 22:16:04 ota_total: gethrd = connection Jul 2 22:16:04 ota_total: http::get_http == gethrd Jul 2 22:16:04 ota_total: gethrd = content-type Jul 2 22:16:04 ota_total: http::get_http == gethrd Jul 2 22:16:04 ota_total: usleepSeconds=10000 Jul 2 22:16:04 ota_total: get kernel == after get_http. Jul 2 22:16:04 ota_total: kernel MD5 should be 4a73b75bff074a63f24a7c3208fa6d17 Jul 2 22:16:04 ota_total: kernel MD5 is 775637f6ccebc26e7aae0129e919b5f8 Jul 2 22:16:04 ota_total: kernel MD5 error Jul 2 22:16:04 ota_total: total download time is [1.153976] Jul 2 22:16:04 ota_total: need to update files... Jul 2 22:16:04 ota_total: Buffer Length: 422 Bytes Jul 2 22:16:04 ota_total: Index File Data Length: 421 Bytes Jul 2 22:16:04 ota_total: End characters 0D0A0D0A or 0A0A not found. Jul 2 22:16:04 ota_total: Wrong Index File Format. Jul 2 22:16:04 ota_total: message is /usr/ota_total/qpe_ota_msg.sh 2 Jul 2 22:16:08 kernel: SPI2:: drvHhalEventIndicationHandler :setting PHGHHAL_EVENT_POWER_SAVE Jul 2 22:16:08 ota_total: util::OTA_Stop == enter. Jul 2 22:16:08 kernel: SPI2:: drvIoctl :Ioctl confirm ack is got, cmd is :0x8b2c Jul 2 22:16:20 kernel: ================| Jul 2 22:16:20 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:16:20 kernel: [AudioIdleBody],event=19 Jul 2 22:16:20 kernel: [AudioIdleExit] Jul 2 22:16:20 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:16:20 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:16:20 kernel: AIC28: disable 4096 Jul 2 22:16:20 kernel: [AudioSleepStateEntry] Jul 2 22:16:20 kernel: AIC28:Reset DSP Jul 2 22:16:20 kernel: [AudioSleepStateExit] Jul 2 22:16:20 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:16:20 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:16:20 kernel: AIC28: enable 4096 Jul 2 22:16:20 kernel: [AudioIdleEntry] Jul 2 22:16:20 kernel: Restarting tasks... done Jul 3 00:16:20 hs_voip: select >=0 Jul 3 00:16:20 hs_voip: voipSipPingFd entery Jul 3 00:16:20 hs_voip: SIP:FD_ISSET->voipSipPingFd=9,read: 0x1 Jul 3 00:16:20 hs_voip: !!!receive timeout event Jul 3 00:16:20 hs_voip: SIP:FD_ISSET->voipSipPingFd=9,read: 0x1 Jul 3 00:16:20 hs_voip: start dpmDeepsleepPause Jul 3 00:16:20 hs_voip: get voipSipPingStop3SecDeepSleepFd=:22 Jul 3 00:16:20 hs_voip: voipRegisterStop3SecDeepSleepFd=0,voipRegisterFd=7,voipSipNhmStop3SecDeepSleepFd=0,voipSipNhmFd=8,voipSipPingStop3SecDeepSleepFd=22,voipSipPingFd=9,maxFd=22,httpTimerFd=0 Jul 3 00:16:21 hs_voip: HS_VOIP_CCM_PING_REQUEST_TIMER_VALUE voipSipPingFd=9 - timer=55000 wncPingTimer=55 Jul 3 00:16:21 hs_voip: ping Retry Timer result=0 Jul 3 00:16:21 hs_voip: UA receive Ping Jul 3 00:16:23 hs_voip: select >=0 Jul 3 00:16:23 hs_voip: voipSipPingStop3SecDeepSleepFd entery Jul 3 00:16:23 hs_voip: SIP:FD_ISSET->voipSipPingStop3SecDeepSleepFd=22,read: 0x1 Jul 3 00:16:23 hs_voip: !!!voipSipPingStop3SecDeepSleepFd receive timeout event Jul 3 00:16:23 hs_voip: hwtimer_stop and free voipSipPingStop3SecDeepSleepFd Jul 3 00:16:23 hs_voip: start dpmDeepsleepNormal Jul 3 00:16:23 hs_voip: voipRegisterStop3SecDeepSleepFd=0,voipRegisterFd=7,voipSipNhmStop3SecDeepSleepFd=0,voipSipNhmFd=8,voipSipPingStop3SecDeepSleepFd=0,voipSipPingFd=9,maxFd=9,httpTimerFd=0 Jul 2 22:16:40 kernel: ================| Jul 2 22:16:40 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:16:40 kernel: [AudioIdleBody],event=19 Jul 2 22:16:40 kernel: [AudioIdleExit] Jul 2 22:16:40 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:16:40 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:16:40 kernel: AIC28: disable 4096 Jul 2 22:16:40 kernel: [AudioSleepStateEntry] Jul 2 22:16:40 kernel: AIC28:Reset DSP Jul 2 22:16:40 kernel: [AudioSleepStateExit] Jul 2 22:16:40 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:16:40 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:16:40 kernel: AIC28: enable 4096 Jul 2 22:16:40 kernel: [AudioIdleEntry] Jul 2 22:16:40 kernel: Restarting tasks... done Jul 2 22:16:51 kernel: ================| Jul 2 22:16:51 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:16:51 kernel: [AudioIdleBody],event=19 Jul 2 22:16:51 kernel: [AudioIdleExit] Jul 2 22:16:51 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:16:51 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:16:51 kernel: AIC28: disable 4096 Jul 2 22:16:51 kernel: [AudioSleepStateEntry] Jul 2 22:16:51 kernel: AIC28:Reset DSP Jul 2 22:16:51 kernel: [AudioSleepStateExit] Jul 2 22:16:51 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:16:51 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:16:51 kernel: AIC28: enable 4096 Jul 2 22:16:51 kernel: [AudioIdleEntry] Jul 2 22:16:51 kernel: Restarting tasks... done Jul 2 22:17:02 kernel: ================| Jul 2 22:17:02 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:17:02 kernel: [AudioIdleBody],event=19 Jul 2 22:17:02 kernel: [AudioIdleExit] Jul 2 22:17:02 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:17:02 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:17:02 kernel: AIC28: disable 4096 Jul 2 22:17:02 kernel: [AudioSleepStateEntry] Jul 2 22:17:02 kernel: AIC28:Reset DSP Jul 2 22:17:02 kernel: [AudioSleepStateExit] Jul 2 22:17:02 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:17:02 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:17:02 kernel: AIC28: enable 4096 Jul 2 22:17:02 kernel: [AudioIdleEntry] Jul 2 22:17:02 kernel: Restarting tasks... done Jul 2 22:17:16 kernel: ================| Jul 2 22:17:16 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 3 00:17:16 hs_voip: select >=0 Jul 3 00:17:16 hs_voip: voipSipPingFd entery Jul 3 00:17:16 hs_voip: SIP:FD_ISSET->voipSipPingFd=9,read: 0x1 Jul 3 00:17:16 hs_voip: !!!receive timeout event Jul 3 00:17:16 hs_voip: SIP:FD_ISSET->voipSipPingFd=9,read: 0x1 Jul 3 00:17:16 hs_voip: start dpmDeepsleepPause Jul 3 00:17:16 hs_voip: get voipSipPingStop3SecDeepSleepFd=:22 Jul 3 00:17:16 hs_voip: voipRegisterStop3SecDeepSleepFd=0,voipRegisterFd=7,voipSipNhmStop3SecDeepSleepFd=0,voipSipNhmFd=8,voipSipPingStop3SecDeepSleepFd=22,voipSipPingFd=9,maxFd=22,httpTimerFd=0 Jul 2 22:17:16 kernel: [AudioIdleBody],event=19 Jul 2 22:17:16 kernel: [AudioIdleExit] Jul 2 22:17:16 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:17:16 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:17:16 kernel: AIC28: disable 4096 Jul 2 22:17:16 kernel: [AudioSleepStateEntry] Jul 2 22:17:16 kernel: AIC28:Reset DSP Jul 2 22:17:16 kernel: [AudioSleepStateExit] Jul 2 22:17:16 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:17:16 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:17:16 kernel: AIC28: enable 4096 Jul 2 22:17:16 kernel: [AudioIdleEntry] Jul 2 22:17:16 kernel: Restarting tasks... done Jul 3 00:17:16 hs_voip: HS_VOIP_CCM_PING_REQUEST_TIMER_VALUE voipSipPingFd=9 - timer=55000 wncPingTimer=55 Jul 3 00:17:16 hs_voip: ping Retry Timer result=0 Jul 3 00:17:16 hs_voip: UA receive Ping Jul 3 00:17:19 hs_voip: select >=0 Jul 3 00:17:19 hs_voip: voipSipPingStop3SecDeepSleepFd entery Jul 3 00:17:19 hs_voip: SIP:FD_ISSET->voipSipPingStop3SecDeepSleepFd=22,read: 0x1 Jul 3 00:17:19 hs_voip: !!!voipSipPingStop3SecDeepSleepFd receive timeout event Jul 3 00:17:19 hs_voip: hwtimer_stop and free voipSipPingStop3SecDeepSleepFd Jul 3 00:17:19 hs_voip: start dpmDeepsleepNormal Jul 3 00:17:19 hs_voip: voipRegisterStop3SecDeepSleepFd=0,voipRegisterFd=7,voipSipNhmStop3SecDeepSleepFd=0,voipSipNhmFd=8,voipSipPingStop3SecDeepSleepFd=0,voipSipPingFd=9,maxFd=9,httpTimerFd=0 Jul 2 22:17:31 kernel: ==============| Jul 2 22:17:31 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:17:31 kernel: [AudioIdleBody],event=19 Jul 2 22:17:31 kernel: [AudioIdleExit] Jul 2 22:17:31 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:17:31 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:17:31 kernel: AIC28: disable 4096 Jul 2 22:17:31 kernel: [AudioSleepStateEntry] Jul 2 22:17:31 kernel: AIC28:Reset DSP Jul 2 22:17:31 kernel: [AudioSleepStateExit] Jul 2 22:17:31 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:17:31 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:17:31 kernel: AIC28: enable 4096 Jul 2 22:17:31 kernel: [AudioIdleEntry] Jul 2 22:17:31 kernel: Restarting tasks... done Jul 2 22:17:33 login[652]: root login on `pts/1' Jul 2 22:17:40 kernel: ===============| Jul 2 22:17:40 kernel: OMAP-McBSP: McBSP1 is currently in use Jul 2 22:17:40 kernel: [AudioIdleBody],event=19 Jul 2 22:17:40 kernel: [AudioIdleExit] Jul 2 22:17:40 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:17:40 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:17:40 kernel: AIC28: disable 4096 Jul 2 22:17:40 kernel: [AudioSleepStateEntry] Jul 2 22:17:40 kernel: AIC28:Reset DSP Jul 2 22:17:40 kernel: [AudioSleepStateExit] Jul 2 22:17:40 kernel: AIC28:device->out_device 0 ... device->in_device 0 Jul 2 22:17:40 kernel: AIC28:device->out_device 4096 ... device->in_device 0 Jul 2 22:17:40 kernel: AIC28: enable 4096 Jul 2 22:17:40 kernel: [AudioIdleEntry] Jul 2 22:17:40 kernel: Restarting tasks... done #