[1336] [t744112128] [2014-06-19 10:45:11.648410] ***** log_redirect_to_file() succeeded *****
[1336] [t744112128] [2014-06-19 10:45:12.644047] Input: 190
fip_show_text: 'Видео'
[1336] [t744112128] [2014-06-19 10:45:13.205735] Input: 147
fip_show_text: 'Игры'
[1336] [t744112128] [2014-06-19 10:45:13.809211] Input: 190
fip_show_text: 'Приложения'
[1336] [t744112128] [2014-06-19 10:45:14.629818] Input: 143
fip_show_text: 'Музыка и радио'
[1336] [t744112128] [2014-06-19 10:45:15.133553] Input: 145
fip_show_text: 'Видео'
[1336] [t744112128] [2014-06-19 10:45:15.487849] Input: 146
[1336] [t744112128] [2014-06-19 10:45:15.488209] [gui_action] NavPluginExecutor: performing action plugin_open_folder
[1336] [t744112128] [2014-06-19 10:45:15.488350] [plugin] current entry media_url = 'category_list'
[1336] [t744112128] [2014-06-19 10:45:15.488408] [plugin] open_folder: url={"screen_id":"plugin_list","name":"video","show_installed":true}, ((null)/(null))
[1336] [t744112128] [2014-06-19 10:45:15.488455] [plugin] (nav) 'dunestore'->get_folder_view(): starting (timeout=60000000)
[1336] [t744112128] [2014-06-19 10:45:15.488518] [dunestore] [8] [get_folder_view] Starting...
[1336] [t744112128] [2014-06-19 10:45:15.488673] [dunestore] [PhpDriver] start_call(): call_id: 8.
[1336] [t744112128] [2014-06-19 10:45:15.488794] [dunestore] [PhpClient] [call: 8]: starting...
[1336] [t744112128] [2014-06-19 10:45:15.488896] [dunestore] [PhpClient] [call: 8]: started.
[1336] [t744112128] [2014-06-19 10:45:15.489006] [dunestore] [8] [get_folder_view] Started.
[1336] [t744112128] [2014-06-19 10:45:15.701270] NonblockingReader (9): re-allocated buffer of 81920 bytes.
[1336] [t744112128] [2014-06-19 10:45:15.753158] NonblockingReader (9): re-allocated buffer of 163840 bytes.
[1336] [t744112128] [2014-06-19 10:45:15.777481] [dunestore] [8] [get_folder_view] Succeeded.
[1336] [t744112128] [2014-06-19 10:45:15.807457] [plugin] (nav) 'dunestore'->get_folder_view(): finished with status 'succeded'
[1336] [t744112128] [2014-06-19 10:45:15.809827] [plugin] apply_range: no more items available
[1336] [t744112128] [2014-06-19 10:45:15.811755] [DEBUG] Plugin icon view model
[1336] [t744112128] [2014-06-19 10:45:15.811892] view: matrix=3x2, bg=('(null)'; before_icons; 0,0; 2147483646x2147483646), num_items = 1
[1336] [t744112128] [2014-06-19 10:45:15.811940] base: icon=((null),2147483647x2147483647), sel_icon=((null),2147483647x2147483647), valign=center, halign=(null), vpadding=(6,28), item_detailed_info='(null)'
[1336] [t744112128] [2014-06-19 10:45:15.812005] not_loaded: [yes,yes,no], icon=(plugin_file://%dunestore%/icons/transparent.aai,0x0), sel_icon=((null),0x0), valign=center, halign=center, vpadding=(6,28), item_detailed_info='(null)'
fip_show_text: 'IVI-RU'
[1336] [t744112128] [2014-06-19 10:45:16.156842] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:45:16.156957] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:45:16.156995] '
http://online.dune-h...vi.ru/logo.png'
[1336] [t744112128] [2014-06-19 10:45:16.157027] '
http://online.dune-h...i.ru/badge.png'
[1336] [t744112128] [2014-06-19 10:45:16.157116] '
http://online.dune-h...egogo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:16.157150] '
http://online.dune-h...gogo/badge.png'
[1336] [t744112128] [2014-06-19 10:45:16.157182] '
http://online.dune-h...ia.ru/logo.png'
[1336] [t744112128] [2014-06-19 10:45:16.157213] '
http://online.dune-h...a.ru/badge.png'
[1336] [t744112128] [2014-06-19 10:45:16.157244] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:45:16.158407] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:45:16.160438] nav_async_loader: child process is started with pid 1895
[1336] [t744112128] [2014-06-19 10:45:16.163832] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
[1336] [t744112128] [2014-06-19 10:45:16.594769] Input: 214
fip_show_text: 'YOUTUBE'
L image from '/tmp/nav_async_loader/result/18.png'
[1336] [t744112128] [2014-06-19 10:45:16.934453] nav_async_loader: image loaded in 0.014 sec
[1336] [t744112128] [2014-06-19 10:45:17.002857] Input: 214
fip_show_text: 'DOCFILMS-COM-UA'
L image from '/tmp/nav_async_loader/result/20.png'
[1336] [t744112128] [2014-06-19 10:45:17.360209] nav_async_loader: image loaded in 0.013 sec
L image from '/tmp/nav_async_loader/result/19.png'
[1336] [t744112128] [2014-06-19 10:45:17.372820] nav_async_loader: image loaded in 0.012 sec
L image from '/tmp/nav_async_loader/result/21.png'
[1336] [t744112128] [2014-06-19 10:45:17.661923] nav_async_loader: image loaded in 0.018 sec
L image from '/tmp/nav_async_loader/result/22.png'
[1336] [t744112128] [2014-06-19 10:45:17.828249] nav_async_loader: image loaded in 0.013 sec
[1336] [t744112128] [2014-06-19 10:45:18.098312] nav_async_loader: process 1895 finished with status 0 after 1.9 sec
L image from '/tmp/nav_async_loader/result/23.png'
[1336] [t744112128] [2014-06-19 10:45:18.115638] nav_async_loader: image loaded in 0.017 sec
[1336] [t744112128] [2014-06-19 10:45:18.116174] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:45:18.116502] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:45:18.119198] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:45:18.119313] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:45:18.119352] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:18.119387] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:18.119420] '
http://copy.com/8aMn...go/default.png'
[1336] [t744112128] [2014-06-19 10:45:18.119452] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:18.119484] '
http://dl.dropboxuse...go/default.png'
[1336] [t744112128] [2014-06-19 10:45:18.119517] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:18.119549] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:45:18.119852] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:45:18.121871] nav_async_loader: child process is started with pid 1897
[1336] [t744112128] [2014-06-19 10:45:18.125674] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
[1336] [t744112128] [2014-06-19 10:45:18.199610] Input: 214
fip_show_text: 'KINOPOISK'
L image from '/tmp/nav_async_loader/result/25.png'
[1336] [t744112128] [2014-06-19 10:45:19.011548] nav_async_loader: image loaded in 0.020 sec
L image from '/tmp/nav_async_loader/result/26.png'
[1336] [t744112128] [2014-06-19 10:45:19.149562] nav_async_loader: image loaded in 0.015 sec
[1336] [t744112128] [2014-06-19 10:45:19.219871] Input: 190
fip_show_text: 'KINOYLEI'
L image from '/tmp/nav_async_loader/result/24.png'
[1336] [t744112128] [2014-06-19 10:45:19.658526] nav_async_loader: image loaded in 0.027 sec
[1336] [t744112128] [2014-06-19 10:45:20.108033] Input: 146
[1336] [t744112128] [2014-06-19 10:45:20.108388] [gui_action] NavPluginExecutor: performing action plugin_open_folder
[1336] [t744112128] [2014-06-19 10:45:20.108527] [plugin] current entry media_url = 'category_list'
[1336] [t744112128] [2014-06-19 10:45:20.108586] [plugin] open_folder: url={"screen_id":"plugin","category":"video","name":"Kinoylei"}, ((null)/(null))
[1336] [t744112128] [2014-06-19 10:45:20.108634] [plugin] (nav) 'dunestore'->get_folder_view(): starting (timeout=60000000)
[1336] [t744112128] [2014-06-19 10:45:20.108698] [dunestore] [9] [get_folder_view] Starting...
[1336] [t744112128] [2014-06-19 10:45:20.108847] [dunestore] [PhpDriver] start_call(): call_id: 9.
[1336] [t744112128] [2014-06-19 10:45:20.108965] [dunestore] [PhpClient] [call: 9]: starting...
[1336] [t744112128] [2014-06-19 10:45:20.109122] [dunestore] [PhpClient] [call: 9]: started.
[1336] [t744112128] [2014-06-19 10:45:20.109407] [dunestore] [9] [get_folder_view] Started.
[1336] [t744112128] [2014-06-19 10:45:20.160929] [dunestore] [9] [get_folder_view] Succeeded.
[1336] [t744112128] [2014-06-19 10:45:20.161549] [plugin] (nav) 'dunestore'->get_folder_view(): finished with status 'succeded'
[1336] [t744112128] [2014-06-19 10:45:20.162484] nav_async_loader: denying current tasks
[1336] [t744112128] [2014-06-19 10:45:20.162602] nav_async_loader: killing process 1897
fip_show_text: 'PLUGIN'
[1336] [t744112128] [2014-06-19 10:45:20.178387] Loading 1 needed icons
L image from '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:20.972302] Loaded in 0.794 sec
[1336] [t744112128] [2014-06-19 10:45:21.753943] Input: 146
[1336] [t744112128] [2014-06-19 10:45:21.754593] [gui_action] NavPluginExecutor: performing action plugin_handle_user_input
[1336] [t744112128] [2014-06-19 10:45:21.754716] [plugin] launching HandleUserInput for plugin 'dunestore' with 4 params
handler_id = plugin
control_id = install
category = video
name = Kinoylei
[1336] [t744112128] [2014-06-19 10:45:21.754817] [plugin] current entry media_url = 'category_list'
[1336] [t744112128] [2014-06-19 10:45:21.754930] [plugin] (nav) 'dunestore'->handle_user_input(): starting (timeout=60000000)
[1336] [t744112128] [2014-06-19 10:45:21.755016] [dunestore] [10] [handle_user_input] Starting...
[1336] [t744112128] [2014-06-19 10:45:21.755265] [dunestore] [PhpDriver] start_call(): call_id: 10.
[1336] [t744112128] [2014-06-19 10:45:21.755408] [dunestore] [PhpClient] [call: 10]: starting...
[1336] [t744112128] [2014-06-19 10:45:21.755508] [dunestore] [PhpClient] [call: 10]: started.
[1336] [t744112128] [2014-06-19 10:45:21.755582] [dunestore] [10] [handle_user_input] Started.
[1336] [t744112128] [2014-06-19 10:45:21.807509] [dunestore] [10] [handle_user_input] Succeeded.
[1336] [t744112128] [2014-06-19 10:45:21.807719] [plugin] (nav) 'dunestore'->handle_user_input(): finished with status 'succeded'
[1336] [t744112128] [2014-06-19 10:45:21.807820] [gui_action] NavGeneralExecutor: performing action launch_media_url
[1336] [t744112128] [2014-06-19 10:45:21.808161] Processed: 0 media items, 0 dirs, 0 playlists, 0 http urls
[1336] [t744112128] [2014-06-19 10:45:21.808263] Building playlist from 1 source files (sel = 0)
[1336] [t744112128] [2014-06-19 10:45:21.808697] ======================== Play list constructed (1 items):
[1336] [t744112128] [2014-06-19 10:45:21.808805] #1: 'plugin_installer://
http://copy.com/8aMn...nfirm_replace=0' (-1,
'plugin_installer://http://copy.com/8aMn0OK4hrZlxQk4/Dune/update/Kinoylei/dune_plugin_kinoylei_v1.6.2.tar.gz:::name=Kinoylei&space_needed=1400000&need_confirm_replace=0', 15, 0, 0)
Selected playlist item is 0
[1336] [t744112128] [2014-06-19 10:45:21.808864] [play] media_player_choice: plugin_installer
[1336] [t744112128] [2014-06-19 10:45:21.809001] [plugin_installer] parsing url 'plugin_installer://
http://copy.com/8aMn...firm_replace=0'
[1336] [t744112128] [2014-06-19 10:45:21.809223] [plugin_installer] parsing url '
http://copy.com/8aMn...i_v1.6.2.tar.gz' tgz=1
[1336] [t744112128] [2014-06-19 10:45:21.809330] [plugin_installer] data_url='
http://copy.com/8aMn...i_v1.6.2.tar.gz' name='Kinoylei', space_needed=1400000, need_confirm_replace=0, need_launch=0
[1336] [t744112128] [2014-06-19 10:45:21.809421] [plugin_installer] installing application
[1336] [t744112128] [2014-06-19 10:45:21.809474] [plugin_installer] - update: no
[1336] [t744112128] [2014-06-19 10:45:21.809506] [plugin_installer] - name: Kinoylei
[1336] [t744112128] [2014-06-19 10:45:21.809537] [plugin_installer] - space needed: 1400000
fip_show_text: 'DIALOG'
[1336] [t744112128] [2014-06-19 10:45:21.896369] [sysstor] lookup for writable storage with 1367.19 KB free space
[1336] [t744112128] [2014-06-19 10:45:21.921903] [sysstor] already mounted with enough space (3717868Kb): /persistfs
[1336] [t744112128] [2014-06-19 10:45:21.922150] [plugin_installer] loading tgz-archive
[1336] [t744112128] [2014-06-19 10:45:21.922207] [plugin_installer] - url:
http://copy.com/8aMn...i_v1.6.2.tar.gz
[1336] [t744112128] [2014-06-19 10:45:23.337789] [plugin_installer] - file_size: 458218
[1336] [t744112128] [2014-06-19 10:45:23.337924] [plugin_installer] - temp_dir: /persistfs/plugins/_temp
[1336] [t744112128] [2014-06-19 10:45:23.337960] [plugin_installer] rm -rf '/persistfs/plugins/_temp'
[1336] [t744112128] [2014-06-19 10:45:23.338156] [plugin_installer] ensure_dir '/persistfs/plugins'
[1336] [t744112128] [2014-06-19 10:45:23.338291] [plugin_installer] mkdir '/persistfs/plugins/_temp'
[1336] [t744112128] [2014-06-19 10:45:23.338650] [plugin_installer] starting command '/bin/tar -x -z -C /persistfs/plugins/_temp'
[1336] [t744112128] [2014-06-19 10:45:34.468239] RMReadFile('
http://copy.com/8aMn...i_v1.6.2.tar.gz' 65536) failed: RM_ERRORREADFILE
[1336] [t744112128] [2014-06-19 10:45:34.468441] Terminating process '/bin/tar' (pid 1900)
[1336] [t744112128] [2014-06-19 10:45:34.683750] [plugin_installer] command failed
error details: ReadFailed (Connection timed out)
[1336] [t744112128] [2014-06-19 10:45:34.761663] [plugin_installer] syncing
[1336] [t744112128] [2014-06-19 10:45:37.658146] Clearing FIP input buffer...
[1336] [t744112128] [2014-06-19 10:45:37.658350] FIP input buffer cleared
[1336] [t744112128] [2014-06-19 10:45:38.412159] Input: 146
[+] app_switcher_run_loop()
[app_switcher] 0 commands loaded
[-] app_switcher_run_loop()
[1336] [t744112128] [2014-06-19 10:45:38.412867] [gui_action] NavPluginExecutor: performing action plugin_handle_user_input
[1336] [t744112128] [2014-06-19 10:45:38.412978] [plugin] launching HandleUserInput for plugin 'dunestore' with 4 params
handler_id = plugin
control_id = refresh
category = video
name = Kinoylei
[1336] [t744112128] [2014-06-19 10:45:38.413080] [plugin] current entry media_url = 'category_list'
[1336] [t744112128] [2014-06-19 10:45:38.413263] [plugin] (nav) 'dunestore'->handle_user_input(): starting (timeout=60000000)
[1336] [t744112128] [2014-06-19 10:45:38.413394] [dunestore] [11] [handle_user_input] Starting...
[1336] [t744112128] [2014-06-19 10:45:38.413598] [dunestore] [PhpDriver] start_call(): call_id: 11.
[1336] [t744112128] [2014-06-19 10:45:38.413725] [dunestore] [PhpClient] [call: 11]: starting...
[1336] [t744112128] [2014-06-19 10:45:38.413831] [dunestore] [PhpClient] [call: 11]: started.
[1336] [t744112128] [2014-06-19 10:45:38.413938] [dunestore] [11] [handle_user_input] Started.
fip_show_text: 'PLUGIN'
[1336] [t744112128] [2014-06-19 10:45:39.620915] [plugin] (nav) 'dunestore'->handle_user_input(): still working...
[1336] [t744112128] [2014-06-19 10:45:39.888110] [dunestore] [11] [handle_user_input] Succeeded.
[1336] [t744112128] [2014-06-19 10:45:39.888357] [plugin] (nav) 'dunestore'->handle_user_input(): finished with status 'succeded'
[1336] [t744112128] [2014-06-19 10:45:39.888630] [gui_action] NavPluginExecutor: performing action plugin_invalidate_folders
[1336] [t744112128] [2014-06-19 10:45:39.889522] [plugin] invalidate({"screen_id":"plugin_list","name":"video","show_installed":true}) => done
[1336] [t744112128] [2014-06-19 10:45:39.889699] [plugin] invalidate({"screen_id":"plugin_list","name":"video","show_installed":false}) => not found
[1336] [t744112128] [2014-06-19 10:45:39.890165] [plugin] invalidate({"screen_id":"plugin","category":"video","name":"Kinoylei"}) => done (CURRENT)
[1336] [t744112128] [2014-06-19 10:45:39.890393] nav_async_loader: denying current tasks
[1336] [t744112128] [2014-06-19 10:45:39.890445] nav_async_loader: killing process 1897
[1336] [t744112128] [2014-06-19 10:45:39.901329] [plugin] (nav) 'dunestore'->get_folder_view(): starting (timeout=60000000)
[1336] [t744112128] [2014-06-19 10:45:39.901491] [dunestore] [12] [get_folder_view] Starting...
[1336] [t744112128] [2014-06-19 10:45:39.901749] [dunestore] [PhpDriver] start_call(): call_id: 12.
[1336] [t744112128] [2014-06-19 10:45:39.901898] [dunestore] [PhpClient] [call: 12]: starting...
[1336] [t744112128] [2014-06-19 10:45:39.901999] [dunestore] [PhpClient] [call: 12]: started.
[1336] [t744112128] [2014-06-19 10:45:39.902072] [dunestore] [12] [get_folder_view] Started.
[1336] [t744112128] [2014-06-19 10:45:40.089614] [dunestore] [12] [get_folder_view] Succeeded.
[1336] [t744112128] [2014-06-19 10:45:40.105461] [plugin] (nav) 'dunestore'->get_folder_view(): finished with status 'succeded'
[1336] [t744112128] [2014-06-19 10:45:40.108067] [plugin] apply_range: no more items available
[1336] [t744112128] [2014-06-19 10:45:40.108769] [plugin] (nav) 'dunestore'->get_folder_view(): starting (timeout=60000000)
[1336] [t744112128] [2014-06-19 10:45:40.108896] [dunestore] [13] [get_folder_view] Starting...
[1336] [t744112128] [2014-06-19 10:45:40.109255] [dunestore] [PhpDriver] start_call(): call_id: 13.
[1336] [t744112128] [2014-06-19 10:45:40.109418] [dunestore] [PhpClient] [call: 13]: starting...
[1336] [t744112128] [2014-06-19 10:45:40.109521] [dunestore] [PhpClient] [call: 13]: started.
[1336] [t744112128] [2014-06-19 10:45:40.109596] [dunestore] [13] [get_folder_view] Started.
[1336] [t744112128] [2014-06-19 10:45:40.162107] [dunestore] [13] [get_folder_view] Succeeded.
[1336] [t744112128] [2014-06-19 10:45:40.162564] [plugin] (nav) 'dunestore'->get_folder_view(): finished with status 'succeded'
[1336] [t744112128] [2014-06-19 10:45:40.674564] Input: 208
[1336] [t744112128] [2014-06-19 10:45:40.675069] nav_async_loader: denying current tasks
[1336] [t744112128] [2014-06-19 10:45:40.675182] nav_async_loader: killing process 1897
[1336] [t744112128] [2014-06-19 10:45:40.686417] nav_async_loader: process 1897 finished with status -1 after 22.6 sec
[1336] [t744112128] [2014-06-19 10:45:40.686596] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:45:40.687767] nav_async_loader: 4 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:45:40.689400] [DEBUG] Plugin icon view model
[1336] [t744112128] [2014-06-19 10:45:40.689535] view: matrix=3x2, bg=('(null)'; before_icons; 0,0; 2147483646x2147483646), num_items = 1
[1336] [t744112128] [2014-06-19 10:45:40.689583] base: icon=((null),2147483647x2147483647), sel_icon=((null),2147483647x2147483647), valign=center, halign=(null), vpadding=(6,28), item_detailed_info='(null)'
[1336] [t744112128] [2014-06-19 10:45:40.689648] not_loaded: [yes,yes,no], icon=(plugin_file://%dunestore%/icons/transparent.aai,0x0), sel_icon=((null),0x0), valign=center, halign=center, vpadding=(6,28), item_detailed_info='(null)'
fip_show_text: 'KINOYLEI'
[1336] [t744112128] [2014-06-19 10:45:41.032556] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:45:41.032675] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:45:41.032715] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:41.032750] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:41.032783] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:41.032816] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:41.032849] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:41.032882] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:41.032916] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:45:41.033282] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:45:41.035273] nav_async_loader: child process is started with pid 1904
[1336] [t744112128] [2014-06-19 10:45:41.039027] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/30.png'
[1336] [t744112128] [2014-06-19 10:45:41.754120] nav_async_loader: image loaded in 0.013 sec
L image from '/tmp/nav_async_loader/result/31.png'
[1336] [t744112128] [2014-06-19 10:45:42.644986] nav_async_loader: image loaded in 0.017 sec
L image from '/tmp/nav_async_loader/result/32.png'
[1336] [t744112128] [2014-06-19 10:45:43.333904] nav_async_loader: image loaded in 0.018 sec
L image from '/tmp/nav_async_loader/result/33.png'
[1336] [t744112128] [2014-06-19 10:45:44.069272] nav_async_loader: image loaded in 0.015 sec
L image from '/tmp/nav_async_loader/result/34.png'
[1336] [t744112128] [2014-06-19 10:45:44.703870] nav_async_loader: image loaded in 0.014 sec
HH HH HHHHH HH HH HHHH HHHH HHHHHH HHHHHH
HH HH HH HH HHH HHH HH HH HH HH HH
HHHHHH HH HH HH H HH HH HH HH HHHHH HHHHH
HH HH HH HH HH HH HH HH HH HH HH
HH HH HHHHH HH HH HHHH HHHH HH HH
No need to re-configure analog outputs.
L image from '/tmp/nav_async_loader/result/35.png'
[1336] [t744112128] [2014-06-19 10:45:45.601632] nav_async_loader: image loaded in 0.024 sec
[1336] [t744112128] [2014-06-19 10:45:45.721402] nav_async_loader: process 1904 finished with status 0 after 4.7 sec
[1336] [t744112128] [2014-06-19 10:45:45.721758] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:45:45.722071] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:45:45.722559] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:45:45.722660] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:45:45.722697] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:45.722730] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:45.722764] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:45.722797] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:45.722829] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:45.722861] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:45:45.722895] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:45:45.723194] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:45:45.725256] nav_async_loader: child process is started with pid 1905
[1336] [t744112128] [2014-06-19 10:45:45.729100] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/36.png'
[1336] [t744112128] [2014-06-19 10:45:47.358811] nav_async_loader: image loaded in 0.022 sec
HH HH HHHHH HH HH HHHH HHHH HH HH
HH HH HH HH HHH HHH HH HH HH HHH HH
HHHHHH HH HH HH H HH HH HH HH HH H HH
HH HH HH HH HH HH HH HH HH HH HHH
HH HH HHHHH HH HH HHHH HHHH HH HH
EDID[0][00]: 00 FF FF FF FF FF FF 00
EDID[0][08]: 65 A8 61 31 00 00 00 00
EDID[0][10]: 00 15 01 03 80 00 00 78
EDID[0][18]: 0A 0D C9 A0 57 47 98 27
EDID[0][20]: 12 48 4C 00 00 00 01 01
EDID[0][28]: 01 01 01 01 01 01 01 01
EDID[0][30]: 01 01 01 01 01 01 01 1D
EDID[0][38]: 80 18 71 1C 16 20 58 2C
EDID[0][40]: 25 00 C4 8E 21 00 00 9E
EDID[0][48]: 01 1D 80 D0 72 1C 16 20
EDID[0][50]: 10 2C 25 80 C4 8E 21 00
EDID[0][58]: 00 9E 00 00 00 FC 00 52
EDID[0][60]: 58 2D 56 33 37 31 0A 20
EDID[0][68]: 20 20 20 20 00 00 00 FD
EDID[0][70]: 00 17 79 0F 5B 0F 00 0A
EDID[0][78]: 20 20 20 20 20 20 01 2D
EDID[1][00]: 02 03 45 74 5A 85 04 02
EDID[1][08]: 03 06 07 10 0E 0F 0A 0B
EDID[1][10]: 23 24 14 13 11 12 15 16
EDID[1][18]: 1F 1D 1E 19 1A 25 26 38
EDID[1][20]: 09 7F 07 0F 7F 07 15 07
EDID[1][28]: 50 3E 1F C0 4D 02 00 57
EDID[1][30]: 06 00 67 54 00 5F 54 01
EDID[1][38]: 83 0F 00 00 68 03 0C 00
EDID[1][40]: 11 00 80 21 00 8C 0A D0
EDID[1][48]: 8A 20 E0 2D 10 10 3E 96
EDID[1][50]: 00 13 8E 21 00 00 18 8C
EDID[1][58]: 0A D0 90 20 40 31 20 0C
EDID[1][60]: 40 55 00 13 8E 21 00 00
EDID[1][68]: 18 00 00 00 00 00 00 00
EDID[1][70]: 00 00 00 00 00 00 00 00
EDID[1][78]: 00 00 00 00 00 00 00 AF
Display is HDMI
[HDMI] TVStandard from EDID: VIC 16, 1920x1080p 59.94/60Hz (16:9), , 16:9
[HDMI] HDMI ColorSpace: YCbCr 709
[HDMI] Same mode on SMP Digital Out and HDMI Tx
Input Video Format is 12 bit YCbCr 4:4:4 709
Output Video Format is 8 bit YCbCr 4:4:4 709
Monitor is HDMI
L image from '/tmp/nav_async_loader/result/37.png'
[1336] [t744112128] [2014-06-19 10:45:48.015094] nav_async_loader: image loaded in 0.022 sec
HH HH HHHHH HH HH HHHH HHHH HHHHHH HHHHHH
HH HH HH HH HHH HHH HH HH HH HH HH
HHHHHH HH HH HH H HH HH HH HH HHHHH HHHHH
HH HH HH HH HH HH HH HH HH HH HH
HH HH HHHHH HH HH HHHH HHHH HH HH
No need to re-configure analog outputs.
L image from '/tmp/nav_async_loader/result/38.png'
[1336] [t744112128] [2014-06-19 10:45:49.215624] nav_async_loader: image loaded in 0.027 sec
L image from '/tmp/nav_async_loader/result/39.png'
[1336] [t744112128] [2014-06-19 10:45:49.804952] nav_async_loader: image loaded in 0.017 sec
L image from '/tmp/nav_async_loader/result/41.png'
[1336] [t744112128] [2014-06-19 10:45:50.997328] nav_async_loader: image loaded in 0.023 sec
[1336] [t744112128] [2014-06-19 10:46:15.741529] nav_async_loader: process 1905 failed to finish in 30 seconds, killing it
[1336] [t744112128] [2014-06-19 10:46:15.741647] nav_async_loader: killing process 1905
[1336] [t744112128] [2014-06-19 10:46:15.753505] nav_async_loader: process 1905 finished with status -1 after 30.0 sec
[1336] [t744112128] [2014-06-19 10:46:15.753892] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:46:15.755032] nav_async_loader: 2 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:46:15.755322] [NAV_VIEW] failed to load image (id=24, url=
http://copy.com/8aMn...s/logo/logo.png): loading cancelled
[1336] [t744112128] [2014-06-19 10:46:15.755898] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:46:15.755983] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:46:15.756026] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:15.756068] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:15.756105] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:15.756143] '
http://dl.dropboxuse...go/default.png'
[1336] [t744112128] [2014-06-19 10:46:15.756182] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:15.756221] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:15.756258] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:46:15.756654] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:46:15.759561] nav_async_loader: child process is started with pid 1908
[1336] [t744112128] [2014-06-19 10:46:15.764930] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/43.png'
[1336] [t744112128] [2014-06-19 10:46:16.973225] nav_async_loader: image loaded in 0.025 sec
L image from '/tmp/nav_async_loader/result/44.png'
[1336] [t744112128] [2014-06-19 10:46:17.375020] nav_async_loader: image loaded in 0.026 sec
L image from '/tmp/nav_async_loader/result/45.png'
[1336] [t744112128] [2014-06-19 10:46:17.863251] nav_async_loader: image loaded in 0.017 sec
L image from '/tmp/nav_async_loader/result/46.png'
[1336] [t744112128] [2014-06-19 10:46:19.004145] nav_async_loader: image loaded in 0.020 sec
L image from '/tmp/nav_async_loader/result/47.png'
[1336] [t744112128] [2014-06-19 10:46:19.946659] nav_async_loader: image loaded in 0.020 sec
[1336] [t744112128] [2014-06-19 10:46:45.761731] nav_async_loader: process 1908 failed to finish in 30 seconds, killing it
[1336] [t744112128] [2014-06-19 10:46:45.761852] nav_async_loader: killing process 1908
[1336] [t744112128] [2014-06-19 10:46:45.773696] nav_async_loader: process 1908 finished with status -1 after 30.0 sec
[1336] [t744112128] [2014-06-19 10:46:45.774088] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:46:45.775234] nav_async_loader: 2 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:46:45.775517] [NAV_VIEW] failed to load image (id=24, url=
http://copy.com/8aMn...s/logo/logo.png): loading cancelled
[1336] [t744112128] [2014-06-19 10:46:45.775931] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:46:45.776011] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:46:45.776052] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:45.776089] '
http://dl.dropboxuse...go/default.png'
[1336] [t744112128] [2014-06-19 10:46:45.776125] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:45.776159] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:45.776195] '
http://dl.dropboxuse...go/default.png'
[1336] [t744112128] [2014-06-19 10:46:45.776229] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:46:45.776265] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:46:45.776629] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:46:45.778659] nav_async_loader: child process is started with pid 1913
[1336] [t744112128] [2014-06-19 10:46:45.782202] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/48.png'
[1336] [t744112128] [2014-06-19 10:46:46.737655] nav_async_loader: image loaded in 0.016 sec
L image from '/tmp/nav_async_loader/result/49.png'
[1336] [t744112128] [2014-06-19 10:46:47.385473] nav_async_loader: image loaded in 0.019 sec
L image from '/tmp/nav_async_loader/result/51.png'
[1336] [t744112128] [2014-06-19 10:46:48.947990] nav_async_loader: image loaded in 0.020 sec
L image from '/tmp/nav_async_loader/result/52.png'
[1336] [t744112128] [2014-06-19 10:46:49.347198] nav_async_loader: image loaded in 0.015 sec
L image from '/tmp/nav_async_loader/result/53.png'
[1336] [t744112128] [2014-06-19 10:46:51.044334] nav_async_loader: image loaded in 0.023 sec
[1336] [t744112128] [2014-06-19 10:47:15.813895] nav_async_loader: process 1913 failed to finish in 30 seconds, killing it
[1336] [t744112128] [2014-06-19 10:47:15.814013] nav_async_loader: killing process 1913
[1336] [t744112128] [2014-06-19 10:47:15.824881] nav_async_loader: process 1913 finished with status -1 after 30.0 sec
[1336] [t744112128] [2014-06-19 10:47:15.825270] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:47:15.826401] nav_async_loader: 2 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:47:15.826698] [NAV_VIEW] failed to load image (id=28, url=
http://copy.com/8aMn...u/logo/logo.png): loading cancelled
[1336] [t744112128] [2014-06-19 10:47:15.827386] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:47:15.827471] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:47:15.827512] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:15.827550] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:15.827586] '
http://online.dune-h...utube/logo.png'
[1336] [t744112128] [2014-06-19 10:47:15.827623] '
http://online.dune-h...tube/badge.png'
[1336] [t744112128] [2014-06-19 10:47:15.827660] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:15.827696] '
http://online.dune-h...omore/logo.png'
[1336] [t744112128] [2014-06-19 10:47:15.827733] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:47:15.828123] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:47:15.830870] nav_async_loader: child process is started with pid 1915
[1336] [t744112128] [2014-06-19 10:47:15.836348] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/56.png'
[1336] [t744112128] [2014-06-19 10:47:16.525613] nav_async_loader: image loaded in 0.013 sec
L image from '/tmp/nav_async_loader/result/57.png'
[1336] [t744112128] [2014-06-19 10:47:16.707931] nav_async_loader: image loaded in 0.012 sec
L image from '/tmp/nav_async_loader/result/59.png'
[1336] [t744112128] [2014-06-19 10:47:17.450053] nav_async_loader: image loaded in 0.021 sec
[1336] [t744112128] [2014-06-19 10:47:45.865106] nav_async_loader: process 1915 failed to finish in 30 seconds, killing it
[1336] [t744112128] [2014-06-19 10:47:45.865226] nav_async_loader: killing process 1915
[1336] [t744112128] [2014-06-19 10:47:45.876060] nav_async_loader: process 1915 finished with status -1 after 30.0 sec
[1336] [t744112128] [2014-06-19 10:47:45.876449] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:47:45.877615] nav_async_loader: 4 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:47:45.878086] [NAV_VIEW] failed to load image (id=24, url=
http://copy.com/8aMn...s/logo/logo.png): loading cancelled
[1336] [t744112128] [2014-06-19 10:47:45.878194] [NAV_VIEW] failed to load image (id=28, url=
http://copy.com/8aMn...u/logo/logo.png): loading cancelled
[1336] [t744112128] [2014-06-19 10:47:45.878240] [NAV_VIEW] failed to load image (id=30, url=
http://copy.com/8aMn...v/logo/logo.png): loading cancelled
[1336] [t744112128] [2014-06-19 10:47:45.878555] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:47:45.878632] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:47:45.878673] '
http://online.dune-h...more/badge.png'
[1336] [t744112128] [2014-06-19 10:47:45.878710] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:45.878747] '
http://online.dune-h...vigle/logo.png'
[1336] [t744112128] [2014-06-19 10:47:45.878783] '
http://online.dune-h...igle/badge.png'
[1336] [t744112128] [2014-06-19 10:47:45.878820] '
http://dl.dropboxuse...go/youtube.png'
[1336] [t744112128] [2014-06-19 10:47:45.878856] '
http://dl.dropboxuse...go/default.png'
[1336] [t744112128] [2014-06-19 10:47:45.878892] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:47:45.879272] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:47:45.881264] nav_async_loader: child process is started with pid 1918
[1336] [t744112128] [2014-06-19 10:47:45.887848] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/60.png'
[1336] [t744112128] [2014-06-19 10:47:46.790347] nav_async_loader: image loaded in 0.025 sec
L image from '/tmp/nav_async_loader/result/62.png'
[1336] [t744112128] [2014-06-19 10:47:46.923385] nav_async_loader: image loaded in 0.012 sec
L image from '/tmp/nav_async_loader/result/61.png'
[1336] [t744112128] [2014-06-19 10:47:47.063019] nav_async_loader: image loaded in 0.017 sec
L image from '/tmp/nav_async_loader/result/63.png'
[1336] [t744112128] [2014-06-19 10:47:47.203347] nav_async_loader: image loaded in 0.019 sec
L image from '/tmp/nav_async_loader/result/64.png'
[1336] [t744112128] [2014-06-19 10:47:47.480047] nav_async_loader: image loaded in 0.006 sec
[1336] [t744112128] [2014-06-19 10:47:48.753215] nav_async_loader: process 1918 finished with status 0 after 2.9 sec
L image from '/tmp/nav_async_loader/result/65.png'
[1336] [t744112128] [2014-06-19 10:47:48.766047] nav_async_loader: image loaded in 0.012 sec
[1336] [t744112128] [2014-06-19 10:47:48.766518] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:47:48.766852] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:47:48.770096] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:47:48.770212] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:47:48.770252] '
http://online.dune-h...utube/logo.png'
[1336] [t744112128] [2014-06-19 10:47:48.770285] '
http://online.dune-h...tube/badge.png'
[1336] [t744112128] [2014-06-19 10:47:48.770318] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:48.770350] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:48.770383] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:48.770416] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:48.770449] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:47:48.770766] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:47:48.772730] nav_async_loader: child process is started with pid 1919
[1336] [t744112128] [2014-06-19 10:47:48.775878] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/66.png'
[1336] [t744112128] [2014-06-19 10:47:50.922097] nav_async_loader: image loaded in 0.014 sec
L image from '/tmp/nav_async_loader/result/67.png'
[1336] [t744112128] [2014-06-19 10:47:51.107653] nav_async_loader: image loaded in 0.013 sec
L image from '/tmp/nav_async_loader/result/68.png'
[1336] [t744112128] [2014-06-19 10:47:51.344907] nav_async_loader: image loaded in 0.017 sec
L image from '/tmp/nav_async_loader/result/69.png'
[1336] [t744112128] [2014-06-19 10:47:51.780079] nav_async_loader: image loaded in 0.014 sec
L image from '/tmp/nav_async_loader/result/70.png'
[1336] [t744112128] [2014-06-19 10:47:52.625235] nav_async_loader: image loaded in 0.022 sec
[1336] [t744112128] [2014-06-19 10:47:53.276226] nav_async_loader: process 1919 finished with status 0 after 4.5 sec
L image from '/tmp/nav_async_loader/result/71.png'
[1336] [t744112128] [2014-06-19 10:47:53.292793] nav_async_loader: image loaded in 0.016 sec
[1336] [t744112128] [2014-06-19 10:47:53.293335] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:47:53.293667] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:47:53.296478] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:47:53.296595] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:47:53.296632] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:53.296665] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:53.296699] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:53.296733] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:53.296766] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:53.296800] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:47:53.296834] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:47:53.297230] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:47:53.299233] nav_async_loader: child process is started with pid 1920
[1336] [t744112128] [2014-06-19 10:47:53.305106] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/72.png'
[1336] [t744112128] [2014-06-19 10:47:53.995217] nav_async_loader: image loaded in 0.008 sec
L image from '/tmp/nav_async_loader/result/74.png'
[1336] [t744112128] [2014-06-19 10:47:55.142540] nav_async_loader: image loaded in 0.025 sec
L image from '/tmp/nav_async_loader/result/75.png'
[1336] [t744112128] [2014-06-19 10:47:55.530384] nav_async_loader: image loaded in 0.015 sec
L image from '/tmp/nav_async_loader/result/76.png'
[1336] [t744112128] [2014-06-19 10:47:57.276519] nav_async_loader: image loaded in 0.023 sec
L image from '/tmp/nav_async_loader/result/77.png'
[1336] [t744112128] [2014-06-19 10:47:58.478000] nav_async_loader: image loaded in 0.026 sec
[1336] [t744112128] [2014-06-19 10:48:23.320307] nav_async_loader: process 1920 failed to finish in 30 seconds, killing it
[1336] [t744112128] [2014-06-19 10:48:23.320424] nav_async_loader: killing process 1920
[1336] [t744112128] [2014-06-19 10:48:23.331281] nav_async_loader: process 1920 finished with status -1 after 30.0 sec
[1336] [t744112128] [2014-06-19 10:48:23.331666] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:48:23.332823] nav_async_loader: 2 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:48:23.333114] [NAV_VIEW] failed to load image (id=38, url=
http://copy.com/8aMn...u/logo/logo.png): loading cancelled
[1336] [t744112128] [2014-06-19 10:48:23.334158] [NAV_VIEW_INFO] 6 load-image tasks added (max=6)
[1336] [t744112128] [2014-06-19 10:48:23.334328] nav_async_loader: starting load of the following URLs:
[1336] [t744112128] [2014-06-19 10:48:23.334370] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:48:23.334405] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:48:23.334439] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:48:23.334471] '
http://copy.com/8aMn.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:48:23.334505] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:48:23.334539] '
http://dl.dropboxuse.../logo/logo.png'
[1336] [t744112128] [2014-06-19 10:48:23.334573] nav_async_loader: clearing directory
[1336] [t744112128] [2014-06-19 10:48:23.334889] nav_async_loader: 1 files to delete in '/tmp/nav_async_loader'
[1336] [t744112128] [2014-06-19 10:48:23.336867] nav_async_loader: child process is started with pid 1924
[1336] [t744112128] [2014-06-19 10:48:23.342711] Starting logging to '/tmp/run/nav_async_loader.log' (file max size = 102400)
L image from '/tmp/nav_async_loader/result/82.png'
[1336] [t744112128] [2014-06-19 10:48:24.644333] nav_async_loader: image loaded in 0.019 sec
L image from '/tmp/nav_async_loader/result/83.png'
[1336] [t744112128] [2014-06-19 10:48:25.641768] nav_async_loader: image loaded in 0.021 sec