[38.349029] Initializing watchdogs [38.349141] /dev/watchdog0 [38.373066] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [38.379103] [001/162] (960s left) i915_module_load (load) [38.968804] Starting subtest: load [41.655549] Subtest load: SUCCESS (2.687s) [41.695446] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [41.697312] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [41.700895] [002/162] (957s left) core_auth (basic-auth) [41.771233] Starting subtest: basic-auth [41.772186] Subtest basic-auth: SUCCESS (0.001s) [41.817461] [003/162] (957s left) core_debugfs (read-all-entries) [41.872336] Starting subtest: read-all-entries [41.874991] Subtest read-all-entries: SUCCESS (0.003s) [41.921293] [004/162] (957s left) core_sysfs (read-all-entries) [41.977057] Starting subtest: read-all-entries [41.980379] Subtest read-all-entries: SUCCESS (0.004s) [42.025775] [005/162] (957s left) fbdev (eof) [42.091659] Subtest eof: SKIP (0.000s) [42.134460] [006/162] (956s left) fbdev (info) [42.202776] Subtest info: SKIP (0.000s) [42.244770] [007/162] (956s left) fbdev (nullptr) [42.308943] Subtest nullptr: SKIP (0.000s) [42.366246] [008/162] (956s left) fbdev (read) [42.438731] Subtest read: SKIP (0.000s) [42.482443] [009/162] (956s left) fbdev (write) [42.547459] Subtest write: SKIP (0.000s) [42.591570] [010/162] (956s left) gem_basic (bad-close) [42.645383] Starting subtest: bad-close [42.647187] Subtest bad-close: SUCCESS (0.000s) [42.691330] [011/162] (956s left) gem_basic (create-close) [42.745448] Starting subtest: create-close [42.747865] Subtest create-close: SUCCESS (0.000s) [42.813790] [012/162] (956s left) gem_basic (create-fd-close) [42.869145] Starting subtest: create-fd-close [42.870920] Subtest create-fd-close: SUCCESS (0.000s) [42.928797] [013/162] (956s left) gem_busy (busy@all-engines) [43.005148] Starting subtest: busy [43.006101] Starting dynamic subtest: all-engines [43.074580] Dynamic subtest all-engines: SUCCESS (0.069s) [43.075673] Subtest busy: SUCCESS (0.070s) [43.481591] [014/162] (956s left) gem_close_race (basic-process) [43.556522] Starting subtest: basic-process [43.635317] Subtest basic-process: SUCCESS (0.078s) [43.876357] [015/162] (955s left) gem_close_race (basic-threads) [43.957497] Starting subtest: basic-threads [45.151654] Subtest basic-threads: SUCCESS (1.158s) [45.332779] [016/162] (954s left) gem_ctx_create (basic) [45.408454] Starting subtest: basic [45.409608] Subtest basic: SUCCESS (0.000s) [45.585334] [017/162] (954s left) gem_ctx_create (basic-files) [45.659578] Starting subtest: basic-files [47.678327] Subtest basic-files: SUCCESS (2.018s) [47.930758] [018/162] (951s left) gem_ctx_exec (basic) [47.993733] Starting subtest: basic [47.998972] Subtest basic: SUCCESS (0.005s) [48.091650] [019/162] (951s left) gem_exec_basic (basic) [48.162896] Starting subtest: basic [48.164086] Starting dynamic subtest: rcs0-smem [48.166838] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [48.177288] Starting dynamic subtest: bcs0-smem [48.178351] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [48.187347] Starting dynamic subtest: vcs0-smem [48.188455] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [48.197310] Starting dynamic subtest: vcs1-smem [48.198421] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [48.207402] Starting dynamic subtest: vecs0-smem [48.208585] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [48.209768] Subtest basic: SUCCESS (0.011s) [48.378640] [020/162] (951s left) gem_exec_create (basic) [48.659507] Starting subtest: basic [48.660453] Starting dynamic subtest: smem [50.743203] Dynamic subtest smem: SUCCESS (1.970s) [50.745085] Subtest basic: SUCCESS (1.970s) [50.888315] [021/162] (949s left) gem_exec_fence (basic-busy) [51.129890] Starting subtest: basic-busy [51.131656] Starting dynamic subtest: rcs0 [51.166537] Dynamic subtest rcs0: SUCCESS (0.037s) [51.178496] Starting dynamic subtest: bcs0 [51.193520] Dynamic subtest bcs0: SUCCESS (0.026s) [51.207602] Starting dynamic subtest: vcs0 [51.216486] Dynamic subtest vcs0: SUCCESS (0.022s) [51.229905] Starting dynamic subtest: vcs1 [51.245536] Dynamic subtest vcs1: SUCCESS (0.028s) [51.256605] Starting dynamic subtest: vecs0 [51.270564] Dynamic subtest vecs0: SUCCESS (0.024s) [51.271853] Subtest basic-busy: SUCCESS (0.139s) [52.008007] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [52.010631] [022/162] (948s left) gem_exec_fence (basic-wait) [52.464051] Starting subtest: basic-wait [52.465723] Starting dynamic subtest: rcs0 [52.504609] Dynamic subtest rcs0: SUCCESS (0.039s) [52.521751] Starting dynamic subtest: bcs0 [52.539169] Dynamic subtest bcs0: SUCCESS (0.032s) [52.556450] Starting dynamic subtest: vcs0 [52.575486] Dynamic subtest vcs0: SUCCESS (0.035s) [52.589612] Starting dynamic subtest: vcs1 [52.604507] Dynamic subtest vcs1: SUCCESS (0.028s) [52.616618] Starting dynamic subtest: vecs0 [52.631536] Dynamic subtest vecs0: SUCCESS (0.026s) [52.632593] Subtest basic-wait: SUCCESS (0.163s) [53.293024] [023/162] (946s left) gem_exec_fence (basic-await) [53.533536] Starting subtest: basic-await [53.535057] Starting dynamic subtest: rcs0 [53.649000] Dynamic subtest rcs0: SUCCESS (0.111s) [53.661900] Starting dynamic subtest: bcs0 [53.758167] Dynamic subtest bcs0: SUCCESS (0.107s) [53.768804] Starting dynamic subtest: vcs0 [53.862668] Dynamic subtest vcs0: SUCCESS (0.101s) [53.879579] Starting dynamic subtest: vcs1 [53.975284] Dynamic subtest vcs1: SUCCESS (0.109s) [53.988921] Starting dynamic subtest: vecs0 [54.081932] Dynamic subtest vecs0: SUCCESS (0.104s) [54.083235] Subtest basic-await: SUCCESS (0.535s) [54.752991] [024/162] (945s left) gem_exec_fence (nb-await) [54.973424] Starting subtest: nb-await [54.974937] Starting dynamic subtest: rcs0 [55.043976] Dynamic subtest rcs0: SUCCESS (0.069s) [55.073333] Starting dynamic subtest: bcs0 [55.133863] Dynamic subtest bcs0: SUCCESS (0.084s) [55.162115] Starting dynamic subtest: vcs0 [55.216390] Dynamic subtest vcs0: SUCCESS (0.082s) [55.250400] Starting dynamic subtest: vcs1 [55.310920] Dynamic subtest vcs1: SUCCESS (0.088s) [55.338519] Starting dynamic subtest: vecs0 [55.394582] Dynamic subtest vecs0: SUCCESS (0.083s) [55.396637] Subtest nb-await: SUCCESS (0.414s) [56.114247] [025/162] (944s left) gem_exec_gttfill (basic) [56.192879] Starting subtest: basic [61.287069] Subtest basic: SUCCESS (5.027s) [61.544002] [026/162] (938s left) gem_exec_parallel (engines) [61.704060] Starting subtest: engines [61.705264] Starting dynamic subtest: basic [64.036595] Dynamic subtest basic: SUCCESS (2.269s) [64.049768] Starting dynamic subtest: contexts [70.314456] Dynamic subtest contexts: SUCCESS (6.124s) [70.329811] Starting dynamic subtest: fds [76.045671] Dynamic subtest fds: SUCCESS (5.846s) [76.059687] Starting dynamic subtest: userptr [78.983145] Dynamic subtest userptr: SUCCESS (2.937s) [78.985064] Subtest engines: SUCCESS (17.180s) [79.132960] [027/162] (921s left) gem_exec_store (basic) [79.216411] Starting subtest: basic [79.295871] Subtest basic: SUCCESS (0.079s) [79.487163] [028/162] (921s left) gem_flink_basic (bad-flink) [79.542894] Starting subtest: bad-flink [79.544171] Subtest bad-flink: SUCCESS (0.000s) [79.596895] [029/162] (920s left) gem_flink_basic (bad-open) [79.652399] Starting subtest: bad-open [79.653512] Subtest bad-open: SUCCESS (0.000s) [79.705118] [030/162] (920s left) gem_flink_basic (basic) [79.888130] Starting subtest: basic [79.889681] Subtest basic: SUCCESS (0.000s) [79.951301] [031/162] (920s left) gem_flink_basic (double-flink) [80.050519] Starting subtest: double-flink [80.051530] Subtest double-flink: SUCCESS (0.000s) [80.143889] [032/162] (920s left) gem_flink_basic (flink-lifetime) [80.242340] Starting subtest: flink-lifetime [80.244687] Subtest flink-lifetime: SUCCESS (0.002s) [80.338707] [033/162] (920s left) gem_huc_copy (huc-copy) [80.408207] Starting subtest: huc-copy [80.410113] Subtest huc-copy: SKIP (0.000s) [80.483560] [034/162] (920s left) gem_linear_blits (basic) [80.664472] Starting subtest: basic [80.671736] Subtest basic: SUCCESS (0.007s) [80.767559] [035/162] (920s left) gem_mmap (basic) [80.919538] Starting subtest: basic [80.925021] Subtest basic: SUCCESS (0.001s) [81.007407] [036/162] (920s left) gem_mmap_gtt (basic) [81.063183] Starting subtest: basic [81.064323] Subtest basic: SUCCESS (0.001s) [81.132907] [037/162] (919s left) gem_render_linear_blits (basic) [81.201100] Starting subtest: basic [81.232103] Subtest basic: SUCCESS (0.031s) [81.299328] [038/162] (919s left) gem_render_tiled_blits (basic) [81.367122] Starting subtest: basic [81.407172] Subtest basic: SUCCESS (0.041s) [81.470269] [039/162] (919s left) gem_ringfill (basic-all) [81.765410] Starting subtest: basic-all [82.994902] Subtest basic-all: SUCCESS (1.171s) [83.051783] [040/162] (918s left) gem_softpin (allocator-basic) [83.118599] Starting subtest: allocator-basic [83.321063] Subtest allocator-basic: SUCCESS (0.147s) [83.370123] [041/162] (917s left) gem_softpin (allocator-basic-reserve) [83.445688] Starting subtest: allocator-basic-reserve [83.641520] Subtest allocator-basic-reserve: SUCCESS (0.139s) [83.697322] [042/162] (917s left) gem_softpin (safe-alignment) [83.767933] Starting subtest: safe-alignment [83.787060] Subtest safe-alignment: SUCCESS (0.018s) [83.876799] [043/162] (917s left) gem_sync (basic-all) [83.954491] Starting subtest: basic-all [86.235178] Subtest basic-all: SUCCESS (2.234s) [86.423914] [044/162] (915s left) gem_sync (basic-each) [86.498407] Starting subtest: basic-each [88.755665] Subtest basic-each: SUCCESS (2.255s) [88.979822] [045/162] (912s left) gem_tiled_blits (basic) [89.121669] Starting subtest: basic [89.139862] Subtest basic: SUCCESS (0.018s) [89.243894] [046/162] (912s left) gem_tiled_fence_blits (basic) [89.809579] Starting subtest: basic [89.820534] Subtest basic: SUCCESS (0.011s) [89.950659] [047/162] (911s left) gem_tiled_pread_basic [90.292434] [048/162] (911s left) gem_wait (busy@all-engines) [90.379508] Starting subtest: busy [90.380621] Starting dynamic subtest: all-engines [90.952536] Dynamic subtest all-engines: SUCCESS (0.573s) [90.954727] Subtest busy: SUCCESS (0.574s) [91.246340] [049/162] (910s left) gem_wait (wait@all-engines) [91.329990] Starting subtest: wait [91.331248] Starting dynamic subtest: all-engines [92.416491] Dynamic subtest all-engines: SUCCESS (1.057s) [92.418546] Subtest wait: SUCCESS (1.058s) [92.603618] [050/162] (909s left) i915_getparams_basic (basic-eu-total) [92.668560] Starting subtest: basic-eu-total [92.670683] Subtest basic-eu-total: SUCCESS (0.000s) [92.724151] [051/162] (909s left) i915_getparams_basic (basic-subslice-total) [92.778749] Starting subtest: basic-subslice-total [92.780932] Subtest basic-subslice-total: SUCCESS (0.000s) [92.833077] [052/162] (909s left) i915_hangman (error-state-basic) [92.907299] Starting subtest: error-state-basic [92.915326] Subtest error-state-basic: SUCCESS (0.008s) [93.015216] [053/162] (909s left) i915_pciid [93.307852] [054/162] (908s left) intel_hwmon (hwmon-read) [93.364718] Subtest hwmon-read: SKIP (0.000s) [93.414778] [055/162] (908s left) intel_hwmon (hwmon-write) [93.470136] Subtest hwmon-write: SKIP (0.000s) [93.521804] [056/162] (908s left) kms_addfb_basic (addfb25-4-tiled) [93.811927] Starting subtest: addfb25-4-tiled [93.813602] Subtest addfb25-4-tiled: SUCCESS (0.001s) [93.899395] [057/162] (908s left) kms_addfb_basic (addfb25-bad-modifier) [94.174483] Starting subtest: addfb25-bad-modifier [94.176443] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [94.277898] [058/162] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [94.546494] Starting subtest: addfb25-framebuffer-vs-set-tiling [94.547644] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [94.631014] [059/162] (907s left) kms_addfb_basic (addfb25-modifier-no-flag) [94.906387] Starting subtest: addfb25-modifier-no-flag [94.907496] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [94.980277] [060/162] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy) [95.249541] Starting subtest: addfb25-x-tiled-legacy [95.250666] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [95.324179] [061/162] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [95.602546] Starting subtest: addfb25-x-tiled-mismatch-legacy [95.603538] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [95.718037] [062/162] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [95.988353] Starting subtest: addfb25-yf-tiled-legacy [95.989459] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [96.069581] [063/162] (906s left) kms_addfb_basic (addfb25-y-tiled-legacy) [96.348455] Starting subtest: addfb25-y-tiled-legacy [96.349512] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [96.420741] [064/162] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [96.691726] Starting subtest: addfb25-y-tiled-small-legacy [96.693208] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [96.770698] [065/162] (906s left) kms_addfb_basic (bad-pitch-0) [96.826616] Starting subtest: bad-pitch-0 [96.827523] Subtest bad-pitch-0: SUCCESS (0.000s) [97.127959] [066/162] (905s left) kms_addfb_basic (bad-pitch-1024) [97.185603] Starting subtest: bad-pitch-1024 [97.186526] Subtest bad-pitch-1024: SUCCESS (0.000s) [97.515938] [067/162] (905s left) kms_addfb_basic (bad-pitch-128) [97.571114] Starting subtest: bad-pitch-128 [97.572086] Subtest bad-pitch-128: SUCCESS (0.000s) [97.871262] [068/162] (905s left) kms_addfb_basic (bad-pitch-256) [97.925837] Starting subtest: bad-pitch-256 [97.926792] Subtest bad-pitch-256: SUCCESS (0.000s) [98.217584] [069/162] (904s left) kms_addfb_basic (bad-pitch-32) [98.272999] Starting subtest: bad-pitch-32 [98.273985] Subtest bad-pitch-32: SUCCESS (0.000s) [98.563407] [070/162] (904s left) kms_addfb_basic (bad-pitch-63) [98.620263] Starting subtest: bad-pitch-63 [98.621177] Subtest bad-pitch-63: SUCCESS (0.000s) [98.928501] [071/162] (904s left) kms_addfb_basic (bad-pitch-65536) [98.983088] Starting subtest: bad-pitch-65536 [98.984148] Subtest bad-pitch-65536: SUCCESS (0.000s) [99.312790] [072/162] (904s left) kms_addfb_basic (bad-pitch-999) [99.368226] Starting subtest: bad-pitch-999 [99.369169] Subtest bad-pitch-999: SUCCESS (0.000s) [99.682845] [073/162] (903s left) kms_addfb_basic (basic) [99.736968] Starting subtest: basic [99.737945] Subtest basic: SUCCESS (0.000s) [100.038627] [074/162] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [100.094355] Starting subtest: basic-x-tiled-legacy [100.095281] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [100.407992] [075/162] (903s left) kms_addfb_basic (basic-y-tiled-legacy) [100.464136] Starting subtest: basic-y-tiled-legacy [100.465065] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [100.763945] [076/162] (902s left) kms_addfb_basic (bo-too-small) [101.037364] Starting subtest: bo-too-small [101.038673] Subtest bo-too-small: SUCCESS (0.001s) [101.124081] [077/162] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [101.404967] Starting subtest: bo-too-small-due-to-tiling [101.406202] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [101.485068] [078/162] (902s left) kms_addfb_basic (clobberred-modifier) [101.542180] Starting subtest: clobberred-modifier [101.543097] Subtest clobberred-modifier: SUCCESS (0.000s) [101.834287] [079/162] (901s left) kms_addfb_basic (framebuffer-vs-set-tiling) [101.891395] Starting subtest: framebuffer-vs-set-tiling [101.892327] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.214719] [080/162] (901s left) kms_addfb_basic (invalid-get-prop) [102.270329] Starting subtest: invalid-get-prop [102.271248] Subtest invalid-get-prop: SUCCESS (0.000s) [102.584320] [081/162] (901s left) kms_addfb_basic (invalid-get-prop-any) [102.640641] Starting subtest: invalid-get-prop-any [102.642108] Subtest invalid-get-prop-any: SUCCESS (0.000s) [102.956244] [082/162] (901s left) kms_addfb_basic (invalid-set-prop) [103.011251] Starting subtest: invalid-set-prop [103.012194] Subtest invalid-set-prop: SUCCESS (0.000s) [103.318758] [083/162] (900s left) kms_addfb_basic (invalid-set-prop-any) [103.374047] Starting subtest: invalid-set-prop-any [103.374928] Subtest invalid-set-prop-any: SUCCESS (0.000s) [103.703348] [084/162] (900s left) kms_addfb_basic (no-handle) [103.760169] Starting subtest: no-handle [103.761103] Subtest no-handle: SUCCESS (0.000s) [104.069684] [085/162] (900s left) kms_addfb_basic (size-max) [104.349663] Starting subtest: size-max [104.350981] Subtest size-max: SUCCESS (0.000s) [104.435273] [086/162] (899s left) kms_addfb_basic (small-bo) [104.704881] Starting subtest: small-bo [104.706088] Subtest small-bo: SUCCESS (0.000s) [104.784449] [087/162] (899s left) kms_addfb_basic (tile-pitch-mismatch) [104.840352] Starting subtest: tile-pitch-mismatch [104.841248] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [105.136795] [088/162] (899s left) kms_addfb_basic (too-high) [105.421922] Starting subtest: too-high [105.423689] Subtest too-high: SUCCESS (0.002s) [105.501823] [089/162] (898s left) kms_addfb_basic (too-wide) [105.770395] Starting subtest: too-wide [105.771577] Subtest too-wide: SUCCESS (0.000s) [105.855330] [090/162] (898s left) kms_addfb_basic (unused-handle) [105.910520] Starting subtest: unused-handle [105.911534] Subtest unused-handle: SUCCESS (0.000s) [106.230804] [091/162] (898s left) kms_addfb_basic (unused-modifier) [106.291592] Starting subtest: unused-modifier [106.292819] Subtest unused-modifier: SUCCESS (0.000s) [106.620689] [092/162] (898s left) kms_addfb_basic (unused-offsets) [106.676932] Starting subtest: unused-offsets [106.677847] Subtest unused-offsets: SUCCESS (0.000s) [106.977722] [093/162] (897s left) kms_addfb_basic (unused-pitches) [107.033364] Starting subtest: unused-pitches [107.034256] Subtest unused-pitches: SUCCESS (0.000s) [107.334418] [094/162] (897s left) kms_busy (basic) [107.619679] Subtest basic: SKIP (0.000s) [107.688090] [095/162] (897s left) kms_prop_blob (basic) [107.744142] Starting subtest: basic [107.745255] Subtest basic: SUCCESS (0.000s) [107.801289] [096/162] (897s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [108.089482] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [108.148675] [097/162] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [108.434554] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [108.493625] [098/162] (896s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [108.783867] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [108.841734] [099/162] (896s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [109.125054] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [109.178763] [100/162] (896s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [109.460713] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [109.515895] [101/162] (895s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [109.805051] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [109.870688] [102/162] (895s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [110.147794] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [110.202487] [103/162] (895s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [110.486830] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [110.547081] [104/162] (894s left) kms_dsc (dsc-basic) [110.825754] Subtest dsc-basic: SKIP (0.000s) [110.898515] [105/162] (894s left) kms_flip (basic-flip-vs-dpms) [111.182409] Starting subtest: basic-flip-vs-dpms [111.185948] Subtest basic-flip-vs-dpms: SKIP (0.003s) [111.259270] [106/162] (894s left) kms_flip (basic-flip-vs-modeset) [111.533525] Starting subtest: basic-flip-vs-modeset [111.537136] Subtest basic-flip-vs-modeset: SKIP (0.003s) [111.613087] [107/162] (894s left) kms_flip (basic-flip-vs-wf_vblank) [111.883948] Starting subtest: basic-flip-vs-wf_vblank [111.887827] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s) [111.966795] [108/162] (893s left) kms_flip (basic-plain-flip) [112.242854] Starting subtest: basic-plain-flip [112.249943] Subtest basic-plain-flip: SKIP (0.002s) [112.320110] [109/162] (893s left) kms_force_connector_basic (force-connector-state) [112.706165] Starting subtest: force-connector-state [113.525076] Subtest force-connector-state: SUCCESS (0.819s) [114.119684] [110/162] (891s left) kms_force_connector_basic (force-edid) [114.505635] Starting subtest: force-edid [115.140579] Subtest force-edid: SUCCESS (0.636s) [115.650943] [111/162] (890s left) kms_force_connector_basic (force-load-detect) [116.037504] Starting subtest: force-load-detect [116.039575] Subtest force-load-detect: SKIP (0.000s) [116.429983] [112/162] (889s left) kms_force_connector_basic (prune-stale-modes) [116.816123] Starting subtest: prune-stale-modes [117.542938] Subtest prune-stale-modes: SUCCESS (0.728s) [118.040939] [113/162] (887s left) kms_frontbuffer_tracking (basic) [118.315639] Subtest basic: SKIP (0.000s) [118.390887] [114/162] (887s left) kms_hdmi_inject (inject-audio) [118.449967] Starting subtest: inject-audio [119.084806] Subtest inject-audio: SUCCESS (0.632s) [119.352767] [115/162] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [119.627936] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [119.694286] [116/162] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [119.972404] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [120.051454] [117/162] (886s left) kms_pipe_crc_basic (hang-read-crc) [120.326864] Subtest hang-read-crc: SKIP (0.000s) [120.398067] [118/162] (885s left) kms_pipe_crc_basic (nonblocking-crc) [120.667232] Subtest nonblocking-crc: SKIP (0.000s) [120.741872] [119/162] (885s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [121.023170] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [121.091950] [120/162] (885s left) kms_pipe_crc_basic (read-crc) [121.372130] Subtest read-crc: SKIP (0.000s) [121.433421] [121/162] (885s left) kms_pipe_crc_basic (read-crc-frame-sequence) [121.713929] Subtest read-crc-frame-sequence: SKIP (0.000s) [121.779571] [122/162] (884s left) kms_pm_backlight (basic-brightness) [122.050266] Subtest basic-brightness: SKIP (0.000s) [122.116699] [123/162] (884s left) kms_pm_rpm (basic-pci-d3-state) [123.755902] Starting subtest: basic-pci-d3-state [124.099561] Subtest basic-pci-d3-state: SUCCESS (0.344s) [124.275671] [124/162] (882s left) kms_pm_rpm (basic-rte) [124.545815] Starting subtest: basic-rte [126.494545] Subtest basic-rte: SUCCESS (1.987s) [126.996165] [125/162] (879s left) kms_psr (psr-primary-page-flip) [127.437567] Subtest psr-primary-page-flip: SKIP (0.000s) [127.515446] [126/162] (879s left) kms_psr (psr-cursor-plane-move) [127.791036] Subtest psr-cursor-plane-move: SKIP (0.000s) [127.856199] [127/162] (879s left) kms_psr (psr-sprite-plane-onoff) [128.134465] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [128.207757] [128/162] (878s left) kms_psr (psr-primary-mmap-gtt) [128.480248] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [128.589454] [129/162] (878s left) kms_setmode (basic-clone-single-crtc) [128.653737] Starting subtest: basic-clone-single-crtc [128.656880] Subtest basic-clone-single-crtc: SKIP (0.000s) [128.712612] [130/162] (878s left) i915_pm_rps (basic-api) [128.781064] Starting subtest: basic-api [128.784518] Subtest basic-api: SUCCESS (0.004s) [128.862371] [131/162] (878s left) prime_self_import (basic-llseek-bad) [128.915846] Starting subtest: basic-llseek-bad [128.919246] Subtest basic-llseek-bad: SUCCESS (0.002s) [128.987364] [132/162] (878s left) prime_self_import (basic-llseek-size) [129.040846] Starting subtest: basic-llseek-size [129.044528] Subtest basic-llseek-size: SUCCESS (0.005s) [129.132146] [133/162] (878s left) prime_self_import (basic-with_fd_dup) [129.185066] Starting subtest: basic-with_fd_dup [129.188213] Subtest basic-with_fd_dup: SUCCESS (0.004s) [129.261459] [134/162] (878s left) prime_self_import (basic-with_one_bo) [129.316553] Starting subtest: basic-with_one_bo [129.319967] Subtest basic-with_one_bo: SUCCESS (0.004s) [129.382777] [135/162] (877s left) prime_self_import (basic-with_one_bo_two_files) [129.434165] Starting subtest: basic-with_one_bo_two_files [129.438440] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [129.512777] [136/162] (877s left) prime_self_import (basic-with_two_bos) [129.566447] Starting subtest: basic-with_two_bos [129.569739] Subtest basic-with_two_bos: SUCCESS (0.004s) [129.644277] [137/162] (877s left) prime_vgem (basic-fence-flip) [129.724455] Starting subtest: basic-fence-flip [129.956661] Subtest basic-fence-flip: SKIP (0.230s) [130.025181] [138/162] (877s left) prime_vgem (basic-fence-mmap) [130.090468] Starting subtest: basic-fence-mmap [130.120605] Subtest basic-fence-mmap: SUCCESS (0.030s) [130.207598] [139/162] (877s left) prime_vgem (basic-fence-read) [130.290901] Starting subtest: basic-fence-read [130.356902] Subtest basic-fence-read: SUCCESS (0.066s) [130.420843] [140/162] (877s left) prime_vgem (basic-gtt) [130.486157] Starting subtest: basic-gtt [130.498826] Subtest basic-gtt: SUCCESS (0.014s) [130.585118] [141/162] (877s left) prime_vgem (basic-read) [130.653674] Starting subtest: basic-read [130.686241] Subtest basic-read: SUCCESS (0.033s) [130.771800] [142/162] (877s left) prime_vgem (basic-write) [130.837052] Starting subtest: basic-write [130.870836] Subtest basic-write: SUCCESS (0.035s) [130.933887] [143/162] (876s left) vgem_basic (setversion) [130.991511] Starting subtest: setversion [130.993265] Subtest setversion: SUCCESS (0.000s) [131.047202] [144/162] (876s left) vgem_basic (create) [131.105989] Starting subtest: create [131.106937] Subtest create: SUCCESS (0.000s) [131.163167] [145/162] (876s left) vgem_basic (debugfs) [131.222627] Starting subtest: debugfs [131.224113] Subtest debugfs: SUCCESS (0.000s) [131.278104] [146/162] (876s left) vgem_basic (dmabuf-export) [131.336185] Starting subtest: dmabuf-export [131.349415] Subtest dmabuf-export: SUCCESS (0.013s) [131.428129] [147/162] (876s left) vgem_basic (dmabuf-fence) [131.485071] Starting subtest: dmabuf-fence [131.485950] Subtest dmabuf-fence: SUCCESS (0.001s) [131.541839] [148/162] (876s left) vgem_basic (dmabuf-fence-before) [131.600764] Starting subtest: dmabuf-fence-before [131.601707] Subtest dmabuf-fence-before: SUCCESS (0.000s) [131.656459] [149/162] (876s left) vgem_basic (dmabuf-mmap) [131.713749] Starting subtest: dmabuf-mmap [131.724221] Subtest dmabuf-mmap: SUCCESS (0.013s) [131.780602] [150/162] (876s left) vgem_basic (mmap) [131.837117] Starting subtest: mmap [131.847609] Subtest mmap: SUCCESS (0.011s) [131.902923] [151/162] (876s left) vgem_basic (second-client) [131.961109] Starting subtest: second-client [131.965119] Subtest second-client: SUCCESS (0.004s) [132.026132] [152/162] (876s left) vgem_basic (sysfs) [132.083488] Starting subtest: sysfs [132.084420] Subtest sysfs: SUCCESS (0.001s) [132.140231] [153/162] (876s left) core_hotunplug (unbind-rebind) [132.245711] Starting subtest: unbind-rebind [136.838382] Subtest unbind-rebind: SUCCESS (4.587s) [136.889255] [154/162] (871s left) vgem_basic (unload) [136.950464] Starting subtest: unload [165.990472] Subtest unload: SUCCESS (28.984s) [166.042499] [155/162] (842s left) i915_module_load (reload) [166.104062] Starting subtest: reload [170.080766] Subtest reload: SUCCESS (3.978s) [170.165766] [156/162] (838s left) gem_lmem_swapping (basic) [170.402780] Subtest basic: SKIP (0.000s) [170.517565] [157/162] (838s left) gem_lmem_swapping (parallel-random-engines) [170.581467] Subtest parallel-random-engines: SKIP (0.000s) [170.634468] [158/162] (838s left) gem_lmem_swapping (random-engines) [170.695555] Subtest random-engines: SKIP (0.000s) [170.748062] [159/162] (838s left) gem_lmem_swapping (verify-random) [170.811286] Subtest verify-random: SKIP (0.000s) [170.864305] [160/162] (838s left) i915_pm_rpm (module-reload) [173.961701] Starting subtest: module-reload [188.453675] Subtest module-reload: SUCCESS (14.439s) [188.518604] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [188.520225] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [188.523530] [161/162] (820s left) i915_selftest (live) [188.592338] Starting subtest: live [188.593876] Starting dynamic subtest: sanitycheck [191.702833] Dynamic subtest sanitycheck: SUCCESS (3.056s) [191.716033] Starting dynamic subtest: uncore [194.729997] Dynamic subtest uncore: SUCCESS (3.026s) [194.742027] Starting dynamic subtest: workarounds [198.070607] Dynamic subtest workarounds: SUCCESS (3.339s) [198.080665] Starting dynamic subtest: gt_engines [201.613986] Dynamic subtest gt_engines: SUCCESS (3.542s) [201.624207] Starting dynamic subtest: gt_timelines [216.574658] Dynamic subtest gt_timelines: SUCCESS (14.959s) [216.584764] Starting dynamic subtest: gt_contexts [219.744049] Dynamic subtest gt_contexts: SUCCESS (3.168s) [219.757724] Starting dynamic subtest: gt_lrc [226.019874] Dynamic subtest gt_lrc: SUCCESS (6.273s) [226.032630] Starting dynamic subtest: gt_mocs [229.143833] Dynamic subtest gt_mocs: SUCCESS (3.123s) [229.156197] Starting dynamic subtest: gt_pm [240.754760] Dynamic subtest gt_pm: SUCCESS (11.609s) [240.765023] Starting dynamic subtest: gt_heartbeat [243.812200] Dynamic subtest gt_heartbeat: SUCCESS (3.055s) [243.822343] Starting dynamic subtest: gt_tlb [248.574985] Dynamic subtest gt_tlb: SUCCESS (4.761s) [248.586993] Starting dynamic subtest: requests [259.071973] Dynamic subtest requests: SUCCESS (10.495s) [259.082182] Starting dynamic subtest: migrate [265.212933] Dynamic subtest migrate: SUCCESS (6.138s) [265.223235] Starting dynamic subtest: active [268.250653] Dynamic subtest active: SUCCESS (3.036s) [268.263994] Starting dynamic subtest: objects [272.179952] Dynamic subtest objects: SUCCESS (3.927s) [272.190211] Starting dynamic subtest: mman [278.817330] Dynamic subtest mman: SUCCESS (6.635s) [278.827562] Starting dynamic subtest: dmabuf [281.869620] Dynamic subtest dmabuf: SUCCESS (3.050s) [281.879783] Starting dynamic subtest: vma [284.869486] Dynamic subtest vma: SUCCESS (2.999s) [284.882778] Starting dynamic subtest: coherency [288.953645] Dynamic subtest coherency: SUCCESS (4.082s) [288.966954] Starting dynamic subtest: gtt [299.220062] Dynamic subtest gtt: SUCCESS (10.265s) [299.230319] Starting dynamic subtest: gem [302.764959] Dynamic subtest gem: SUCCESS (3.543s) [302.775225] Starting dynamic subtest: evict [308.028123] Dynamic subtest evict: SUCCESS (5.262s) [308.038406] Starting dynamic subtest: hugepages [317.587832] Dynamic subtest hugepages: SUCCESS (9.557s) [317.598032] Starting dynamic subtest: gem_contexts [337.505843] Dynamic subtest gem_contexts: SUCCESS (19.916s) [337.516205] Starting dynamic subtest: client [340.613932] Dynamic subtest client: SUCCESS (3.106s) [340.624236] Starting dynamic subtest: gem_migrate [343.647095] Dynamic subtest gem_migrate: SUCCESS (3.030s) [343.657386] Starting dynamic subtest: reset [347.067354] Dynamic subtest reset: SUCCESS (3.419s) [347.077565] Starting dynamic subtest: memory_region [350.062134] Dynamic subtest memory_region: SUCCESS (2.992s) [350.072611] Starting dynamic subtest: hangcheck [381.800918] Dynamic subtest hangcheck: SUCCESS (31.735s) [381.814319] Starting dynamic subtest: execlists [397.941718] Dynamic subtest execlists: SUCCESS (16.138s) [397.952040] Starting dynamic subtest: ring_submission [400.950893] Dynamic subtest ring_submission: SUCCESS (3.007s) [400.961140] Starting dynamic subtest: perf [404.023504] Dynamic subtest perf: SUCCESS (3.070s) [404.033768] Starting dynamic subtest: slpc [407.024686] Dynamic subtest slpc: SUCCESS (2.998s) [407.034958] Starting dynamic subtest: guc [410.022187] Dynamic subtest guc: SUCCESS (2.995s) [410.032426] Starting dynamic subtest: guc_multi_lrc [413.020839] Dynamic subtest guc_multi_lrc: SUCCESS (2.996s) [413.031203] Starting dynamic subtest: guc_hang [415.989875] Dynamic subtest guc_hang: SUCCESS (2.966s) [416.002624] Starting dynamic subtest: late_gt_pm [419.012168] Dynamic subtest late_gt_pm: SUCCESS (3.019s) [419.014587] Subtest live: SUCCESS (230.357s) [419.081731] [162/162] (589s left) dmabuf (all-tests) [419.150920] Starting subtest: all-tests [419.152302] Starting dynamic subtest: sanitycheck [419.215284] Dynamic subtest sanitycheck: SUCCESS (0.063s) [419.249366] Starting dynamic subtest: dma_fence [419.434024] Dynamic subtest dma_fence: SUCCESS (0.213s) [419.457092] Starting dynamic subtest: dma_fence_chain [419.459662] Dynamic subtest dma_fence_chain: SKIP (0.000s) [419.480397] Starting dynamic subtest: dma_fence_unwrap [419.522234] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [419.560544] Starting dynamic subtest: dma_resv [419.609361] Dynamic subtest dma_resv: SUCCESS (0.082s) [419.617271] Subtest all-tests: SUCCESS (0.461s) [419.695776] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.