rofi-timings

(process:404584): Timings-DEBUG: 00:56:17.205: 0.000000 (0.000000): Started
(process:404584): Timings-DEBUG: 00:56:17.205: 0.000080 (0.000080): source/rofi.c:main:884 
(process:404584): Timings-DEBUG: 00:56:17.205: 0.000427 (0.000347): source/rofi.c:main:935 
(process:404584): Timings-DEBUG: 00:56:17.205: 0.000467 (0.000040): source/rofi.c:main:942 Setup Locale
(process:404584): Timings-DEBUG: 00:56:17.205: 0.000566 (0.000099): source/rofi.c:main:944 Collect MODES
(process:404584): Timings-DEBUG: 00:56:17.205: 0.000577 (0.000011): source/rofi.c:main:946 Setup MODES
(process:404584): Timings-DEBUG: 00:56:17.205: 0.000588 (0.000011): source/rofi.c:main:950 Setup mainloop
(process:404584): Timings-DEBUG: 00:56:17.205: 0.000631 (0.000043): source/rofi.c:main:953 NK Bindings
(process:404584): Timings-DEBUG: 00:56:17.207: 0.002617 (0.001986): source/xcb.c:display_setup:1507 Open Display
(process:404584): Timings-DEBUG: 00:56:17.208: 0.003066 (0.000449): source/xcb.c:display_setup:1523 Setup XCB
(process:404584): Timings-DEBUG: 00:56:17.211: 0.005947 (0.002881): source/rofi.c:main:960 Setup Display
(process:404584): Timings-DEBUG: 00:56:17.211: 0.005974 (0.000027): source/rofi.c:main:964 Setup abe
(process:404584): Timings-DEBUG: 00:56:17.211: 0.006525 (0.000551): source/rofi.c:main:1019 Load cmd config 
(process:404584): Timings-DEBUG: 00:56:17.211: 0.006549 (0.000024): source/rofi.c:main:1041 Setup Modes
(process:404584): Timings-DEBUG: 00:56:17.211: 0.006586 (0.000037): source/view.c:rofi_view_workers_initialize:2288 Setup Threadpool, start
(process:404584): Timings-DEBUG: 00:56:17.211: 0.006638 (0.000052): source/view.c:rofi_view_workers_initialize:2312 Setup Threadpool, done
(process:404584): Timings-DEBUG: 00:56:17.211: 0.006648 (0.000010): source/rofi.c:main:1101 Workers initialize
(process:404584): Timings-DEBUG: 00:56:17.217: 0.012557 (0.005909): source/rofi.c:main:1103 Icon fetcher initialize
(process:404584): Timings-DEBUG: 00:56:17.217: 0.012594 (0.000037): source/rofi.c:main:1111 Pid file created
(process:404584): Timings-DEBUG: 00:56:17.217: 0.012607 (0.000013): source/rofi.c:main:1117 Text box setup
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024185 (0.011578): source/rofi.c:main:1124 Setup late Display
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024209 (0.000024): source/rofi.c:main:1128 Theme setup
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024261 (0.000052): source/rofi.c:startup:719 Startup
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024270 (0.000009): source/rofi.c:startup:728 Grab keyboard
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024353 (0.000083): source/view.c:__create_window:808 xcb create window
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024370 (0.000017): source/view.c:__create_window:812 xcb create gc
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024555 (0.000185): source/view.c:__create_window:822 create cairo surface
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024634 (0.000079): source/view.c:__create_window:831 pango cairo font setup
(process:404584): Timings-DEBUG: 00:56:17.229: 0.024654 (0.000020): source/view.c:__create_window:875 configure font
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033015 (0.008361): source/view.c:__create_window:883 textbox setup
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033031 (0.000016): source/view.c:__create_window:897 setup window attributes
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033039 (0.000008): source/view.c:__create_window:912 setup window fullscreen
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033044 (0.000005): source/view.c:__create_window:919 setup window name and class
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033054 (0.000010): source/view.c:__create_window:928 setup startup notification
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033060 (0.000006): source/view.c:__create_window:930 done
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033067 (0.000007): source/rofi.c:startup:730 Create Window
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033071 (0.000004): source/rofi.c:startup:732 Parse ABE
(process:404584): Timings-DEBUG: 00:56:17.238: 0.033076 (0.000005): source/rofi.c:startup:735 Config sanity check
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035108 (0.002032): source/view.c:rofi_view_create:2106 
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035132 (0.000024): source/view.c:rofi_view_create:2131 Startup notification
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035139 (0.000007): source/view.c:rofi_view_create:2134 Get active monitor
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035340 (0.000201): source/view.c:rofi_view_refilter_real:1170 Filter start
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035351 (0.000011): source/view.c:rofi_view_refilter_real:1175 Filter reload rows
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035355 (0.000004): source/view.c:rofi_view_refilter_real:1180 Filter tokenize
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035360 (0.000005): source/view.c:rofi_view_refilter_real:1255 Filter matching done
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035364 (0.000004): source/widgets/listview.c:listview_set_num_elements:565 listview_set_num_elements
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035368 (0.000004): source/widgets/listview.c:listview_set_num_elements:571 Set selected
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035429 (0.000061): source/widgets/listview.c:listview_set_num_elements:573 recompute elements
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035435 (0.000006): source/widgets/listview.c:listview_set_num_elements:575 queue redraw
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035440 (0.000005): source/view.c:rofi_view_refilter_real:1268 Update filter lines
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035446 (0.000006): source/view.c:rofi_view_refilter_real:1286 Filter resize window based on window 
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035450 (0.000004): source/view.c:rofi_view_refilter_real:1288 Filter done
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035455 (0.000005): source/view.c:rofi_view_update:1123 
(process:404584): Timings-DEBUG: 00:56:17.240: 0.035472 (0.000017): source/view.c:rofi_view_update:1141 Background
(process:404584): Timings-DEBUG: 00:56:17.241: 0.035815 (0.000343): source/view.c:rofi_view_update:1147 widgets
(process:404584): Timings-DEBUG: 00:56:17.250: 0.045311 (0.009496): source/view.c:rofi_view_update:1123 
(process:404584): Timings-DEBUG: 00:56:17.250: 0.045329 (0.000018): source/view.c:rofi_view_update:1141 Background
(process:404584): Timings-DEBUG: 00:56:17.250: 0.045526 (0.000197): source/view.c:rofi_view_update:1147 widgets
(process:404584): Timings-DEBUG: 00:56:17.250: 0.045565 (0.000039): source/view.c:rofi_view_repaint:278 Update start
(process:404584): Timings-DEBUG: 00:56:17.250: 0.045573 (0.000008): source/view.c:rofi_view_repaint:281 Expose
(process:404584): Timings-DEBUG: 00:56:17.250: 0.045580 (0.000007): source/view.c:rofi_view_repaint:286 flush
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242468 (1.196888): source/view.c:rofi_view_refilter_real:1170 Filter start
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242544 (0.000076): source/view.c:rofi_view_refilter_real:1175 Filter reload rows
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242569 (0.000025): source/view.c:rofi_view_refilter_real:1180 Filter tokenize
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242589 (0.000020): source/view.c:rofi_view_refilter_real:1255 Filter matching done
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242608 (0.000019): source/widgets/listview.c:listview_set_num_elements:565 listview_set_num_elements
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242627 (0.000019): source/widgets/listview.c:listview_set_num_elements:571 Set selected
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242661 (0.000034): source/widgets/listview.c:listview_set_num_elements:573 recompute elements
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242667 (0.000006): source/widgets/listview.c:listview_set_num_elements:575 queue redraw
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242671 (0.000004): source/view.c:rofi_view_refilter_real:1268 Update filter lines
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242680 (0.000009): source/view.c:rofi_view_refilter_real:1286 Filter resize window based on window 
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242685 (0.000005): source/view.c:rofi_view_refilter_real:1288 Filter done
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242690 (0.000005): source/view.c:rofi_view_update:1123 
(process:404584): Timings-DEBUG: 00:56:18.447: 1.242707 (0.000017): source/view.c:rofi_view_update:1141 Background
(process:404584): Timings-DEBUG: 00:56:18.448: 1.243114 (0.000407): source/view.c:rofi_view_update:1147 widgets
(process:404584): Timings-DEBUG: 00:56:18.448: 1.243157 (0.000043): source/view.c:rofi_view_repaint:278 Update start
(process:404584): Timings-DEBUG: 00:56:18.448: 1.243167 (0.000010): source/view.c:rofi_view_update:1123 
(process:404584): Timings-DEBUG: 00:56:18.448: 1.243175 (0.000008): source/view.c:rofi_view_update:1141 Background
(process:404584): Timings-DEBUG: 00:56:18.448: 1.243366 (0.000191): source/view.c:rofi_view_update:1147 widgets
(process:404584): Timings-DEBUG: 00:56:18.448: 1.243380 (0.000014): source/view.c:rofi_view_repaint:281 Expose
(process:404584): Timings-DEBUG: 00:56:18.448: 1.243391 (0.000011): source/view.c:rofi_view_repaint:286 flush
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692645 (0.449254): source/view.c:rofi_view_refilter_real:1170 Filter start
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692673 (0.000028): source/view.c:rofi_view_refilter_real:1175 Filter reload rows
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692680 (0.000007): source/view.c:rofi_view_refilter_real:1180 Filter tokenize
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692685 (0.000005): source/view.c:rofi_view_refilter_real:1255 Filter matching done
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692691 (0.000006): source/widgets/listview.c:listview_set_num_elements:565 listview_set_num_elements
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692696 (0.000005): source/widgets/listview.c:listview_set_num_elements:571 Set selected
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692700 (0.000004): source/widgets/listview.c:listview_set_num_elements:573 recompute elements
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692707 (0.000007): source/widgets/listview.c:listview_set_num_elements:575 queue redraw
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692713 (0.000006): source/view.c:rofi_view_refilter_real:1268 Update filter lines
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692721 (0.000008): source/view.c:rofi_view_refilter_real:1286 Filter resize window based on window 
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692727 (0.000006): source/view.c:rofi_view_refilter_real:1288 Filter done
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692732 (0.000005): source/view.c:rofi_view_update:1123 
(process:404584): Timings-DEBUG: 00:56:18.897: 1.692751 (0.000019): source/view.c:rofi_view_update:1141 Background
(process:404584): Timings-DEBUG: 00:56:18.898: 1.693072 (0.000321): source/view.c:rofi_view_update:1147 widgets
(process:404584): Timings-DEBUG: 00:56:18.898: 1.693114 (0.000042): source/view.c:rofi_view_repaint:278 Update start
(process:404584): Timings-DEBUG: 00:56:18.898: 1.693124 (0.000010): source/view.c:rofi_view_repaint:281 Expose
(process:404584): Timings-DEBUG: 00:56:18.898: 1.693134 (0.000010): source/view.c:rofi_view_repaint:286 flush
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090528 (0.397394): source/view.c:rofi_view_refilter_real:1170 Filter start
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090603 (0.000075): source/view.c:rofi_view_refilter_real:1175 Filter reload rows
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090626 (0.000023): source/view.c:rofi_view_refilter_real:1180 Filter tokenize
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090643 (0.000017): source/view.c:rofi_view_refilter_real:1255 Filter matching done
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090659 (0.000016): source/widgets/listview.c:listview_set_num_elements:565 listview_set_num_elements
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090678 (0.000019): source/widgets/listview.c:listview_set_num_elements:571 Set selected
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090697 (0.000019): source/widgets/listview.c:listview_set_num_elements:573 recompute elements
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090715 (0.000018): source/widgets/listview.c:listview_set_num_elements:575 queue redraw
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090732 (0.000017): source/view.c:rofi_view_refilter_real:1268 Update filter lines
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090758 (0.000026): source/view.c:rofi_view_refilter_real:1286 Filter resize window based on window 
(process:404584): Timings-DEBUG: 00:56:19.295: 2.090776 (0.000018): source/view.c:rofi_view_refilter_real:1288 Filter done
(process:404584): Timings-DEBUG: 00:56:19.296: 2.090797 (0.000021): source/view.c:rofi_view_update:1123 
(process:404584): Timings-DEBUG: 00:56:19.296: 2.090844 (0.000047): source/view.c:rofi_view_update:1141 Background
(process:404584): Timings-DEBUG: 00:56:19.297: 2.091772 (0.000928): source/view.c:rofi_view_update:1147 widgets
(process:404584): Timings-DEBUG: 00:56:19.297: 2.091901 (0.000129): source/view.c:rofi_view_repaint:278 Update start
(process:404584): Timings-DEBUG: 00:56:19.297: 2.091938 (0.000037): source/view.c:rofi_view_repaint:281 Expose
(process:404584): Timings-DEBUG: 00:56:19.297: 2.091968 (0.000030): source/view.c:rofi_view_repaint:286 flush
(process:404584): Timings-DEBUG: 00:56:19.648: 2.443579 (0.351611): source/view.c:rofi_view_repaint:278 Update start
(process:404584): Timings-DEBUG: 00:56:19.648: 2.443654 (0.000075): source/view.c:rofi_view_update:1123 
(process:404584): Timings-DEBUG: 00:56:19.648: 2.443693 (0.000039): source/view.c:rofi_view_update:1141 Background
(process:404584): Timings-DEBUG: 00:56:19.649: 2.444660 (0.000967): source/view.c:rofi_view_update:1147 widgets
(process:404584): Timings-DEBUG: 00:56:19.649: 2.444712 (0.000052): source/view.c:rofi_view_repaint:281 Expose
(process:404584): Timings-DEBUG: 00:56:19.649: 2.444766 (0.000054): source/view.c:rofi_view_repaint:286 flush
(process:404584): Timings-DEBUG: 00:56:19.842: 2.637686 (0.192920): source/view.c:rofi_view_refilter_real:1170 Filter start
(process:404584): Timings-DEBUG: 00:56:19.842: 2.637767 (0.000081): source/view.c:rofi_view_refilter_real:1175 Filter reload rows
(process:404584): Timings-DEBUG: 00:56:19.843: 2.637789 (0.000022): source/view.c:rofi_view_refilter_real:1180 Filter tokenize
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638093 (0.000304): source/view.c:rofi_view_refilter_real:1255 Filter matching done
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638134 (0.000041): source/widgets/listview.c:listview_set_num_elements:565 listview_set_num_elements
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638154 (0.000020): source/widgets/listview.c:listview_set_num_elements:571 Set selected
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638215 (0.000061): source/widgets/listview.c:listview_set_num_elements:573 recompute elements
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638237 (0.000022): source/widgets/listview.c:listview_set_num_elements:575 queue redraw
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638256 (0.000019): source/view.c:rofi_view_refilter_real:1268 Update filter lines
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638283 (0.000027): source/view.c:rofi_view_refilter_real:1286 Filter resize window based on window 
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638303 (0.000020): source/view.c:rofi_view_refilter_real:1288 Filter done
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638322 (0.000019): source/view.c:rofi_view_update:1123 
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638357 (0.000035): source/view.c:rofi_view_update:1141 Background
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638623 (0.000266): source/view.c:rofi_view_update:1147 widgets
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638704 (0.000081): source/view.c:rofi_view_repaint:278 Update start
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638730 (0.000026): source/view.c:rofi_view_repaint:281 Expose
(process:404584): Timings-DEBUG: 00:56:19.843: 2.638758 (0.000028): source/view.c:rofi_view_repaint:286 flush
(process:404584): Timings-DEBUG: 00:56:20.884: 3.678834 (0.000000): Stopped