[22.486983] Initializing watchdogs [22.487110] /dev/watchdog0 [22.501244] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [22.507813] [001/162] (960s left) i915_module_load (load) [22.910416] Starting subtest: load [24.940062] Subtest load: SUCCESS (2.036s) [24.972831] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [24.974007] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [24.978475] [002/162] (958s left) core_auth (basic-auth) [25.038739] Starting subtest: basic-auth [25.041702] Subtest basic-auth: SUCCESS (0.001s) [25.084850] [003/162] (958s left) core_debugfs (read-all-entries) [25.129497] Starting subtest: read-all-entries [25.132646] Subtest read-all-entries: SUCCESS (0.002s) [25.170788] [004/162] (957s left) core_sysfs (read-all-entries) [25.221238] Starting subtest: read-all-entries [25.224580] Subtest read-all-entries: SUCCESS (0.003s) [25.262424] [005/162] (957s left) fbdev (eof) [25.316198] Subtest eof: SKIP (0.000s) [25.352657] [006/162] (957s left) fbdev (info) [25.407408] Subtest info: SKIP (0.000s) [25.447164] [007/162] (957s left) fbdev (nullptr) [25.497265] Subtest nullptr: SKIP (0.000s) [25.533693] [008/162] (957s left) fbdev (read) [25.587197] Subtest read: SKIP (0.000s) [25.623671] [009/162] (957s left) fbdev (write) [25.677186] Subtest write: SKIP (0.000s) [25.713500] [010/162] (957s left) gem_basic (bad-close) [25.761185] Starting subtest: bad-close [25.767574] Subtest bad-close: SUCCESS (0.000s) [25.811128] [011/162] (957s left) gem_basic (create-close) [25.856993] Starting subtest: create-close [25.863368] Subtest create-close: SUCCESS (0.000s) [25.919156] [012/162] (957s left) gem_basic (create-fd-close) [25.969747] Starting subtest: create-fd-close [25.976129] Subtest create-fd-close: SUCCESS (0.000s) [26.024756] [013/162] (957s left) gem_busy (busy@all-engines) [26.080643] Starting subtest: busy [26.083667] Starting dynamic subtest: all-engines [26.106545] Dynamic subtest all-engines: SUCCESS (0.026s) [26.109643] Subtest busy: SUCCESS (0.026s) [26.412431] [014/162] (957s left) gem_close_race (basic-process) [26.469806] Starting subtest: basic-process [26.525560] Subtest basic-process: SUCCESS (0.056s) [26.674921] [015/162] (956s left) gem_close_race (basic-threads) [26.745555] Starting subtest: basic-threads [27.954837] Subtest basic-threads: SUCCESS (1.209s) [28.104748] [016/162] (955s left) gem_ctx_create (basic) [28.158630] Starting subtest: basic [28.161780] Subtest basic: SUCCESS (0.000s) [28.301870] [017/162] (955s left) gem_ctx_create (basic-files) [28.360736] Starting subtest: basic-files [30.373901] Subtest basic-files: SUCCESS (2.013s) [30.561258] [018/162] (953s left) gem_ctx_exec (basic) [30.612471] Starting subtest: basic [30.615747] Subtest basic: SUCCESS (0.005s) [30.683503] [019/162] (953s left) gem_exec_basic (basic) [30.735153] Starting subtest: basic [30.738219] Starting dynamic subtest: rcs0-smem [30.741305] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [30.750960] Starting dynamic subtest: bcs0-smem [30.754009] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [30.763368] Starting dynamic subtest: vcs0-smem [30.766550] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [30.775885] Starting dynamic subtest: vecs0-smem [30.778928] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [30.782056] Subtest basic: SUCCESS (0.005s) [30.908381] [020/162] (952s left) gem_exec_create (basic) [30.962530] Starting subtest: basic [30.965735] Starting dynamic subtest: smem [33.016416] Dynamic subtest smem: SUCCESS (2.054s) [33.019528] Subtest basic: SUCCESS (2.054s) [33.165168] [021/162] (950s left) gem_exec_fence (basic-busy) [33.334615] Starting subtest: basic-busy [33.337872] Starting dynamic subtest: rcs0 [33.370393] Dynamic subtest rcs0: SUCCESS (0.036s) [33.382458] Starting dynamic subtest: bcs0 [33.397166] Dynamic subtest bcs0: SUCCESS (0.027s) [33.407644] Starting dynamic subtest: vcs0 [33.430273] Dynamic subtest vcs0: SUCCESS (0.033s) [33.441063] Starting dynamic subtest: vecs0 [33.461177] Dynamic subtest vecs0: SUCCESS (0.031s) [33.464261] Subtest basic-busy: SUCCESS (0.127s) [33.986684] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [33.991060] [022/162] (949s left) gem_exec_fence (basic-wait) [34.168350] Starting subtest: basic-wait [34.171776] Starting dynamic subtest: rcs0 [34.194506] Dynamic subtest rcs0: SUCCESS (0.028s) [34.206888] Starting dynamic subtest: bcs0 [34.221449] Dynamic subtest bcs0: SUCCESS (0.027s) [34.232869] Starting dynamic subtest: vcs0 [34.248671] Dynamic subtest vcs0: SUCCESS (0.027s) [34.262142] Starting dynamic subtest: vecs0 [34.281395] Dynamic subtest vecs0: SUCCESS (0.033s) [34.284681] Subtest basic-wait: SUCCESS (0.116s) [34.777508] [023/162] (949s left) gem_exec_fence (basic-await) [34.942607] Starting subtest: basic-await [34.945747] Starting dynamic subtest: rcs0 [35.019299] Dynamic subtest rcs0: SUCCESS (0.076s) [35.035772] Starting dynamic subtest: bcs0 [35.107666] Dynamic subtest bcs0: SUCCESS (0.088s) [35.124087] Starting dynamic subtest: vcs0 [35.195479] Dynamic subtest vcs0: SUCCESS (0.087s) [35.214353] Starting dynamic subtest: vecs0 [35.287472] Dynamic subtest vecs0: SUCCESS (0.091s) [35.290827] Subtest basic-await: SUCCESS (0.345s) [35.778506] [024/162] (948s left) gem_exec_fence (nb-await) [35.966477] Starting subtest: nb-await [35.969470] Starting dynamic subtest: rcs0 [36.073355] Dynamic subtest rcs0: SUCCESS (0.062s) [36.137178] Starting dynamic subtest: bcs0 [36.200314] Dynamic subtest bcs0: SUCCESS (0.067s) [36.264245] Starting dynamic subtest: vcs0 [36.328111] Dynamic subtest vcs0: SUCCESS (0.066s) [36.392141] Starting dynamic subtest: vecs0 [36.457147] Dynamic subtest vecs0: SUCCESS (0.065s) [36.521652] Subtest nb-await: SUCCESS (0.262s) [37.200142] [025/162] (947s left) gem_exec_gttfill (basic) [37.462509] Starting subtest: basic [40.729552] Subtest basic: SUCCESS (3.379s) [40.891359] [026/162] (943s left) gem_exec_parallel (engines) [41.027162] Starting subtest: engines [41.030154] Starting dynamic subtest: basic [42.884821] Dynamic subtest basic: SUCCESS (1.861s) [42.895742] Starting dynamic subtest: contexts [45.701711] Dynamic subtest contexts: SUCCESS (2.816s) [45.712911] Starting dynamic subtest: fds [47.850143] Dynamic subtest fds: SUCCESS (2.148s) [47.861478] Starting dynamic subtest: userptr [50.295932] Dynamic subtest userptr: SUCCESS (2.446s) [50.298984] Subtest engines: SUCCESS (9.272s) [50.464047] [027/162] (934s left) gem_exec_store (basic) [50.536403] Starting subtest: basic [50.593766] Subtest basic: SUCCESS (0.062s) [50.747226] [028/162] (933s left) gem_flink_basic (bad-flink) [50.799495] Starting subtest: bad-flink [50.802531] Subtest bad-flink: SUCCESS (0.000s) [50.849825] [029/162] (933s left) gem_flink_basic (bad-open) [50.895321] Starting subtest: bad-open [50.898663] Subtest bad-open: SUCCESS (0.000s) [50.941701] [030/162] (933s left) gem_flink_basic (basic) [50.987556] Starting subtest: basic [50.990576] Subtest basic: SUCCESS (0.000s) [51.047683] [031/162] (933s left) gem_flink_basic (double-flink) [51.095924] Starting subtest: double-flink [51.099259] Subtest double-flink: SUCCESS (0.000s) [51.158875] [032/162] (933s left) gem_flink_basic (flink-lifetime) [51.206470] Starting subtest: flink-lifetime [51.209493] Subtest flink-lifetime: SUCCESS (0.001s) [51.263521] [033/162] (933s left) gem_huc_copy (huc-copy) [51.315212] Starting subtest: huc-copy [51.321407] Subtest huc-copy: SKIP (0.000s) [51.384897] [034/162] (933s left) gem_linear_blits (basic) [51.497980] Starting subtest: basic [51.507106] Subtest basic: SUCCESS (0.009s) [51.596480] [035/162] (933s left) gem_mmap (basic) [51.728636] Starting subtest: basic [51.743719] Subtest basic: SUCCESS (0.000s) [51.786409] [036/162] (933s left) gem_mmap_gtt (basic) [51.836392] Starting subtest: basic [51.839642] Subtest basic: SUCCESS (0.001s) [51.882823] [037/162] (933s left) gem_render_linear_blits (basic) [51.933141] Starting subtest: basic [51.956201] Subtest basic: SUCCESS (0.025s) [52.016737] [038/162] (933s left) gem_render_tiled_blits (basic) [52.063501] Starting subtest: basic [52.093155] Subtest basic: SUCCESS (0.030s) [52.149857] [039/162] (932s left) gem_ringfill (basic-all) [52.407936] Starting subtest: basic-all [53.542163] Subtest basic-all: SUCCESS (1.134s) [53.614797] [040/162] (931s left) gem_softpin (allocator-basic) [53.670372] Starting subtest: allocator-basic [53.765292] Subtest allocator-basic: SUCCESS (0.098s) [53.832891] [041/162] (931s left) gem_softpin (allocator-basic-reserve) [53.880274] Starting subtest: allocator-basic-reserve [53.975101] Subtest allocator-basic-reserve: SUCCESS (0.095s) [54.064748] [042/162] (931s left) gem_softpin (safe-alignment) [54.121523] Starting subtest: safe-alignment [54.132185] Subtest safe-alignment: SUCCESS (0.011s) [54.202348] [043/162] (931s left) gem_sync (basic-all) [54.283165] Starting subtest: basic-all [56.568513] Subtest basic-all: SUCCESS (2.308s) [56.725792] [044/162] (928s left) gem_sync (basic-each) [56.800110] Starting subtest: basic-each [58.885670] Subtest basic-each: SUCCESS (2.105s) [59.042876] [045/162] (926s left) gem_tiled_blits (basic) [59.147243] Starting subtest: basic [59.164907] Subtest basic: SUCCESS (0.018s) [59.258380] [046/162] (926s left) gem_tiled_fence_blits (basic) [59.440323] Starting subtest: basic [59.447961] Subtest basic: SUCCESS (0.008s) [59.546685] [047/162] (925s left) gem_tiled_pread_basic (basic) [59.676741] Starting subtest: basic [59.784821] Subtest basic: SUCCESS (0.112s) [59.852759] [048/162] (925s left) gem_wait (busy@all-engines) [59.913155] Starting subtest: busy [59.916524] Starting dynamic subtest: all-engines [60.442219] Dynamic subtest all-engines: SUCCESS (0.529s) [60.445211] Subtest busy: SUCCESS (0.530s) [60.601089] [049/162] (924s left) gem_wait (wait@all-engines) [60.659980] Starting subtest: wait [60.663205] Starting dynamic subtest: all-engines [61.689751] Dynamic subtest all-engines: SUCCESS (1.029s) [61.693486] Subtest wait: SUCCESS (1.030s) [61.852197] [050/162] (923s left) i915_getparams_basic (basic-eu-total) [61.904189] Starting subtest: basic-eu-total [61.910497] Subtest basic-eu-total: SUCCESS (0.000s) [61.953315] [051/162] (923s left) i915_getparams_basic (basic-subslice-total) [62.002705] Starting subtest: basic-subslice-total [62.008962] Subtest basic-subslice-total: SUCCESS (0.000s) [62.050904] [052/162] (923s left) i915_hangman (error-state-basic) [62.105826] Starting subtest: error-state-basic [62.113766] Subtest error-state-basic: SUCCESS (0.005s) [62.184163] [053/162] (923s left) i915_pciid [62.280957] [054/162] (923s left) intel_hwmon (hwmon-read) [62.332034] Subtest hwmon-read: SKIP (0.000s) [62.378381] [055/162] (923s left) intel_hwmon (hwmon-write) [62.430615] Subtest hwmon-write: SKIP (0.000s) [62.478231] [056/162] (923s left) kms_addfb_basic (addfb25-4-tiled) [62.568070] Starting subtest: addfb25-4-tiled [62.571235] Subtest addfb25-4-tiled: SUCCESS (0.000s) [62.632579] [057/162] (923s left) kms_addfb_basic (addfb25-bad-modifier) [62.711127] Starting subtest: addfb25-bad-modifier [62.714232] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [62.772785] [058/162] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [62.852516] Starting subtest: addfb25-framebuffer-vs-set-tiling [62.855479] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [62.915819] [059/162] (923s left) kms_addfb_basic (addfb25-modifier-no-flag) [62.992043] Starting subtest: addfb25-modifier-no-flag [62.995158] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [63.049597] [060/162] (923s left) kms_addfb_basic (addfb25-x-tiled-legacy) [63.132952] Starting subtest: addfb25-x-tiled-legacy [63.136209] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [63.196431] [061/162] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [63.284918] Starting subtest: addfb25-x-tiled-mismatch-legacy [63.288102] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [63.343888] [062/162] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [63.424314] Starting subtest: addfb25-yf-tiled-legacy [63.427703] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [63.487890] [063/162] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy) [63.567151] Starting subtest: addfb25-y-tiled-legacy [63.570181] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [63.619447] [064/162] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [63.699193] Starting subtest: addfb25-y-tiled-small-legacy [63.702644] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [63.752200] [065/162] (922s left) kms_addfb_basic (bad-pitch-0) [63.805867] Starting subtest: bad-pitch-0 [63.809033] Subtest bad-pitch-0: SUCCESS (0.000s) [63.895136] [066/162] (922s left) kms_addfb_basic (bad-pitch-1024) [63.944947] Starting subtest: bad-pitch-1024 [63.949636] Subtest bad-pitch-1024: SUCCESS (0.000s) [64.047657] [067/162] (922s left) kms_addfb_basic (bad-pitch-128) [64.098567] Starting subtest: bad-pitch-128 [64.102579] Subtest bad-pitch-128: SUCCESS (0.000s) [64.194165] [068/162] (922s left) kms_addfb_basic (bad-pitch-256) [64.247116] Starting subtest: bad-pitch-256 [64.250208] Subtest bad-pitch-256: SUCCESS (0.000s) [64.332862] [069/162] (922s left) kms_addfb_basic (bad-pitch-32) [64.387703] Starting subtest: bad-pitch-32 [64.390665] Subtest bad-pitch-32: SUCCESS (0.000s) [64.474916] [070/162] (922s left) kms_addfb_basic (bad-pitch-63) [64.524660] Starting subtest: bad-pitch-63 [64.529101] Subtest bad-pitch-63: SUCCESS (0.000s) [64.611071] [071/162] (921s left) kms_addfb_basic (bad-pitch-65536) [64.661442] Starting subtest: bad-pitch-65536 [64.665429] Subtest bad-pitch-65536: SUCCESS (0.000s) [64.743838] [072/162] (921s left) kms_addfb_basic (bad-pitch-999) [64.796891] Starting subtest: bad-pitch-999 [64.799842] Subtest bad-pitch-999: SUCCESS (0.000s) [64.894731] [073/162] (921s left) kms_addfb_basic (basic) [64.947800] Starting subtest: basic [64.950791] Subtest basic: SUCCESS (0.000s) [65.040622] [074/162] (921s left) kms_addfb_basic (basic-x-tiled-legacy) [65.090311] Starting subtest: basic-x-tiled-legacy [65.093938] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [65.186187] [075/162] (921s left) kms_addfb_basic (basic-y-tiled-legacy) [65.241609] Starting subtest: basic-y-tiled-legacy [65.247302] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [65.332997] [076/162] (921s left) kms_addfb_basic (bo-too-small) [65.412708] Starting subtest: bo-too-small [65.415913] Subtest bo-too-small: SUCCESS (0.000s) [65.475369] [077/162] (921s left) kms_addfb_basic (bo-too-small-due-to-tiling) [65.553156] Starting subtest: bo-too-small-due-to-tiling [65.556556] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [65.616351] [078/162] (921s left) kms_addfb_basic (clobberred-modifier) [65.665901] Starting subtest: clobberred-modifier [65.669730] Subtest clobberred-modifier: SUCCESS (0.000s) [65.752345] [079/162] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling) [65.802558] Starting subtest: framebuffer-vs-set-tiling [65.805938] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [65.933402] [080/162] (921s left) kms_addfb_basic (invalid-get-prop) [66.298699] Starting subtest: invalid-get-prop [66.362728] Subtest invalid-get-prop: SUCCESS (0.000s) [66.742817] [081/162] (920s left) kms_addfb_basic (invalid-get-prop-any) [67.130614] Starting subtest: invalid-get-prop-any [67.195337] Subtest invalid-get-prop-any: SUCCESS (0.000s) [67.458370] [082/162] (920s left) kms_addfb_basic (invalid-set-prop) [67.510528] Starting subtest: invalid-set-prop [67.516300] Subtest invalid-set-prop: SUCCESS (0.000s) [67.591334] [083/162] (920s left) kms_addfb_basic (invalid-set-prop-any) [67.644627] Starting subtest: invalid-set-prop-any [67.647791] Subtest invalid-set-prop-any: SUCCESS (0.000s) [67.729339] [084/162] (919s left) kms_addfb_basic (no-handle) [67.779657] Starting subtest: no-handle [67.782710] Subtest no-handle: SUCCESS (0.000s) [67.858906] [085/162] (919s left) kms_addfb_basic (size-max) [67.937158] Starting subtest: size-max [67.940293] Subtest size-max: SUCCESS (0.000s) [68.006679] [086/162] (919s left) kms_addfb_basic (small-bo) [68.084493] Starting subtest: small-bo [68.087678] Subtest small-bo: SUCCESS (0.000s) [68.136485] [087/162] (919s left) kms_addfb_basic (tile-pitch-mismatch) [68.186448] Starting subtest: tile-pitch-mismatch [68.190325] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [68.267799] [088/162] (919s left) kms_addfb_basic (too-high) [68.346713] Starting subtest: too-high [68.349971] Subtest too-high: SUCCESS (0.001s) [68.407211] [089/162] (919s left) kms_addfb_basic (too-wide) [68.486134] Starting subtest: too-wide [68.489292] Subtest too-wide: SUCCESS (0.000s) [68.556687] [090/162] (919s left) kms_addfb_basic (unused-handle) [68.608159] Starting subtest: unused-handle [68.611899] Subtest unused-handle: SUCCESS (0.000s) [68.698780] [091/162] (919s left) kms_addfb_basic (unused-modifier) [68.747923] Starting subtest: unused-modifier [68.754222] Subtest unused-modifier: SUCCESS (0.000s) [68.838229] [092/162] (919s left) kms_addfb_basic (unused-offsets) [68.889348] Starting subtest: unused-offsets [68.892836] Subtest unused-offsets: SUCCESS (0.000s) [68.985672] [093/162] (919s left) kms_addfb_basic (unused-pitches) [69.036035] Starting subtest: unused-pitches [69.039797] Subtest unused-pitches: SUCCESS (0.000s) [69.128747] [094/162] (918s left) kms_busy (basic) [69.212763] Subtest basic: SKIP (0.000s) [69.254608] [095/162] (918s left) kms_prop_blob (basic) [69.305862] Starting subtest: basic [69.309011] Subtest basic: SUCCESS (0.000s) [69.351241] [096/162] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [69.449467] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [69.494456] [097/162] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [69.596467] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [69.642429] [098/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [69.756581] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [69.801258] [099/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [69.903399] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [69.948685] [100/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [70.047640] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [70.092365] [101/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [70.191897] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [70.237364] [102/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [70.340528] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [70.385930] [103/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [70.486153] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [70.531712] [104/162] (917s left) kms_dsc (dsc-basic) [70.608644] Subtest dsc-basic: SKIP (0.000s) [70.650594] [105/162] (917s left) kms_flip (basic-flip-vs-dpms) [70.730756] Starting subtest: basic-flip-vs-dpms [70.736910] Subtest basic-flip-vs-dpms: SKIP (0.001s) [70.778901] [106/162] (917s left) kms_flip (basic-flip-vs-modeset) [70.869240] Starting subtest: basic-flip-vs-modeset [70.879659] Subtest basic-flip-vs-modeset: SKIP (0.001s) [70.936644] [107/162] (917s left) kms_flip (basic-flip-vs-wf_vblank) [71.018542] Starting subtest: basic-flip-vs-wf_vblank [71.024588] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [71.088343] [108/162] (917s left) kms_flip (basic-plain-flip) [71.166541] Starting subtest: basic-plain-flip [71.172251] Subtest basic-plain-flip: SKIP (0.001s) [71.226015] [109/162] (917s left) kms_force_connector_basic (force-connector-state) [71.382389] Starting subtest: force-connector-state [71.459376] Subtest force-connector-state: SUCCESS (0.080s) [71.618653] [110/162] (917s left) kms_force_connector_basic (force-edid) [71.779047] Starting subtest: force-edid [71.971610] Subtest force-edid: SUCCESS (0.190s) [72.055094] [111/162] (916s left) kms_force_connector_basic (force-load-detect) [72.210269] Starting subtest: force-load-detect [72.216367] Subtest force-load-detect: SKIP (0.000s) [72.418493] [112/162] (916s left) kms_force_connector_basic (prune-stale-modes) [72.802205] Starting subtest: prune-stale-modes [72.995056] Subtest prune-stale-modes: SUCCESS (0.191s) [73.476795] [113/162] (915s left) kms_frontbuffer_tracking (basic) [73.784683] Subtest basic: SKIP (0.000s) [73.841562] [114/162] (915s left) kms_hdmi_inject (inject-audio) [73.892112] Starting subtest: inject-audio [73.898162] Subtest inject-audio: SKIP (0.000s) [73.947364] [115/162] (915s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [74.029402] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [74.074388] [116/162] (915s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [74.156983] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [74.204750] [117/162] (915s left) kms_pipe_crc_basic (hang-read-crc) [74.289746] Subtest hang-read-crc: SKIP (0.000s) [74.332873] [118/162] (915s left) kms_pipe_crc_basic (nonblocking-crc) [74.416437] Subtest nonblocking-crc: SKIP (0.000s) [74.460663] [119/162] (915s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [74.546194] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [74.591721] [120/162] (915s left) kms_pipe_crc_basic (read-crc) [74.672456] Subtest read-crc: SKIP (0.000s) [74.716132] [121/162] (915s left) kms_pipe_crc_basic (read-crc-frame-sequence) [74.799846] Subtest read-crc-frame-sequence: SKIP (0.000s) [74.851551] [122/162] (915s left) kms_pm_backlight (basic-brightness) [74.933475] Subtest basic-brightness: SKIP (0.000s) [74.976401] [123/162] (914s left) kms_pm_rpm (basic-pci-d3-state) [86.265832] Starting subtest: basic-pci-d3-state [86.449891] Subtest basic-pci-d3-state: SUCCESS (0.183s) [86.504364] [124/162] (903s left) kms_pm_rpm (basic-rte) [86.550537] Starting subtest: basic-rte [98.076593] Subtest basic-rte: SUCCESS (11.528s) [98.377558] [125/162] (891s left) kms_psr (psr-primary-page-flip) [98.461697] Subtest psr-primary-page-flip: SKIP (0.000s) [98.505539] [126/162] (891s left) kms_psr (psr-cursor-plane-move) [98.601539] Subtest psr-cursor-plane-move: SKIP (0.000s) [98.645504] [127/162] (891s left) kms_psr (psr-sprite-plane-onoff) [98.727385] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [98.771367] [128/162] (891s left) kms_psr (psr-primary-mmap-gtt) [98.854034] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [98.897212] [129/162] (891s left) kms_setmode (basic-clone-single-crtc) [98.946619] Starting subtest: basic-clone-single-crtc [98.955956] Subtest basic-clone-single-crtc: SKIP (0.000s) [99.005778] [130/162] (891s left) i915_pm_rps (basic-api) [99.060157] Starting subtest: basic-api [99.063328] Subtest basic-api: SUCCESS (0.003s) [99.109611] [131/162] (891s left) prime_self_import (basic-llseek-bad) [99.155467] Starting subtest: basic-llseek-bad [99.162421] Subtest basic-llseek-bad: SUCCESS (0.002s) [99.224551] [132/162] (891s left) prime_self_import (basic-llseek-size) [99.269353] Starting subtest: basic-llseek-size [99.275561] Subtest basic-llseek-size: SUCCESS (0.003s) [99.346845] [133/162] (891s left) prime_self_import (basic-with_fd_dup) [99.393467] Starting subtest: basic-with_fd_dup [99.399835] Subtest basic-with_fd_dup: SUCCESS (0.002s) [99.458335] [134/162] (890s left) prime_self_import (basic-with_one_bo) [99.503835] Starting subtest: basic-with_one_bo [99.510081] Subtest basic-with_one_bo: SUCCESS (0.002s) [99.562432] [135/162] (890s left) prime_self_import (basic-with_one_bo_two_files) [99.608129] Starting subtest: basic-with_one_bo_two_files [99.614787] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [99.684586] [136/162] (890s left) prime_self_import (basic-with_two_bos) [99.733703] Starting subtest: basic-with_two_bos [99.739989] Subtest basic-with_two_bos: SUCCESS (0.003s) [99.801838] [137/162] (890s left) prime_vgem (basic-fence-flip) [99.854853] Starting subtest: basic-fence-flip [99.912794] Subtest basic-fence-flip: SKIP (0.055s) [99.959824] [138/162] (890s left) prime_vgem (basic-fence-mmap) [100.014269] Starting subtest: basic-fence-mmap [100.034770] Subtest basic-fence-mmap: SUCCESS (0.022s) [100.112385] [139/162] (890s left) prime_vgem (basic-fence-read) [100.164550] Starting subtest: basic-fence-read [100.209735] Subtest basic-fence-read: SUCCESS (0.046s) [100.283690] [140/162] (890s left) prime_vgem (basic-gtt) [100.336209] Starting subtest: basic-gtt [100.346306] Subtest basic-gtt: SUCCESS (0.011s) [100.419913] [141/162] (890s left) prime_vgem (basic-read) [100.475446] Starting subtest: basic-read [100.493918] Subtest basic-read: SUCCESS (0.022s) [100.569314] [142/162] (890s left) prime_vgem (basic-write) [100.621550] Starting subtest: basic-write [100.641157] Subtest basic-write: SUCCESS (0.021s) [100.726202] [143/162] (890s left) vgem_basic (setversion) [100.777221] Starting subtest: setversion [100.783839] Subtest setversion: SUCCESS (0.000s) [100.837618] [144/162] (890s left) vgem_basic (create) [100.889820] Starting subtest: create [100.892922] Subtest create: SUCCESS (0.000s) [100.939815] [145/162] (890s left) vgem_basic (debugfs) [100.991129] Starting subtest: debugfs [100.994167] Subtest debugfs: SUCCESS (0.000s) [101.044321] [146/162] (889s left) vgem_basic (dmabuf-export) [101.096192] Starting subtest: dmabuf-export [101.102701] Subtest dmabuf-export: SUCCESS (0.002s) [101.160115] [147/162] (889s left) vgem_basic (dmabuf-fence) [101.207844] Starting subtest: dmabuf-fence [101.210917] Subtest dmabuf-fence: SUCCESS (0.001s) [101.259800] [148/162] (889s left) vgem_basic (dmabuf-fence-before) [101.312165] Starting subtest: dmabuf-fence-before [101.315164] Subtest dmabuf-fence-before: SUCCESS (0.000s) [101.364381] [149/162] (889s left) vgem_basic (dmabuf-mmap) [101.415681] Starting subtest: dmabuf-mmap [101.424067] Subtest dmabuf-mmap: SUCCESS (0.009s) [101.467809] [150/162] (889s left) vgem_basic (mmap) [101.521849] Starting subtest: mmap [101.525127] Subtest mmap: SUCCESS (0.006s) [101.569355] [151/162] (889s left) vgem_basic (second-client) [101.631694] Starting subtest: second-client [101.637409] Subtest second-client: SUCCESS (0.002s) [101.684797] [152/162] (889s left) vgem_basic (sysfs) [101.731534] Starting subtest: sysfs [101.734792] Subtest sysfs: SUCCESS (0.000s) [101.785500] [153/162] (889s left) core_hotunplug (unbind-rebind) [101.891212] Starting subtest: unbind-rebind [105.347428] Subtest unbind-rebind: SUCCESS (3.456s) [105.392797] [154/162] (886s left) vgem_basic (unload) [105.443058] Starting subtest: unload [134.285530] Subtest unload: SUCCESS (28.847s) [134.352849] [155/162] (857s left) i915_module_load (reload) [134.406474] Starting subtest: reload [136.834858] Subtest reload: SUCCESS (2.430s) [136.879395] [156/162] (854s left) gem_lmem_swapping (basic) [136.961161] Subtest basic: SKIP (0.000s) [137.003902] [157/162] (854s left) gem_lmem_swapping (parallel-random-engines) [137.061157] Subtest parallel-random-engines: SKIP (0.000s) [137.105069] [158/162] (854s left) gem_lmem_swapping (random-engines) [137.157143] Subtest random-engines: SKIP (0.000s) [137.200160] [159/162] (854s left) gem_lmem_swapping (verify-random) [137.251572] Subtest verify-random: SKIP (0.000s) [137.295292] [160/162] (854s left) i915_pm_rpm (module-reload) [148.715716] Starting subtest: module-reload [176.480631] Subtest module-reload: SUCCESS (27.768s) [176.511811] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [176.512812] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [176.516805] [161/162] (815s left) i915_selftest (live) [176.566739] Starting subtest: live [176.569821] Starting dynamic subtest: sanitycheck [178.681799] Dynamic subtest sanitycheck: SUCCESS (2.118s) [178.692270] Starting dynamic subtest: uncore [180.801975] Dynamic subtest uncore: SUCCESS (2.120s) [180.813138] Starting dynamic subtest: workarounds [183.104546] Dynamic subtest workarounds: SUCCESS (2.302s) [183.115206] Starting dynamic subtest: gt_engines [185.654439] Dynamic subtest gt_engines: SUCCESS (2.549s) [185.683566] Starting dynamic subtest: gt_timelines [194.849667] Dynamic subtest gt_timelines: SUCCESS (9.195s) [194.862148] Starting dynamic subtest: gt_contexts [197.183815] Dynamic subtest gt_contexts: SUCCESS (2.323s) [197.194307] Starting dynamic subtest: gt_lrc [201.729384] Dynamic subtest gt_lrc: SUCCESS (4.555s) [201.740303] Starting dynamic subtest: gt_mocs [204.025820] Dynamic subtest gt_mocs: SUCCESS (2.237s) [204.089769] Starting dynamic subtest: gt_pm [210.423465] Dynamic subtest gt_pm: SUCCESS (6.453s) [210.434394] Starting dynamic subtest: gt_heartbeat [212.563295] Dynamic subtest gt_heartbeat: SUCCESS (2.138s) [212.575318] Starting dynamic subtest: gt_tlb [215.923980] Dynamic subtest gt_tlb: SUCCESS (3.353s) [215.934578] Starting dynamic subtest: requests [224.375562] Dynamic subtest requests: SUCCESS (8.460s) [224.386605] Starting dynamic subtest: migrate [229.518730] Dynamic subtest migrate: SUCCESS (5.142s) [229.529220] Starting dynamic subtest: active [231.663934] Dynamic subtest active: SUCCESS (2.136s) [231.676936] Starting dynamic subtest: objects [234.399107] Dynamic subtest objects: SUCCESS (2.691s) [234.463823] Starting dynamic subtest: mman [239.636853] Dynamic subtest mman: SUCCESS (5.288s) [239.647832] Starting dynamic subtest: dmabuf [241.824236] Dynamic subtest dmabuf: SUCCESS (2.180s) [241.835131] Starting dynamic subtest: vma [243.959522] Dynamic subtest vma: SUCCESS (2.141s) [243.970341] Starting dynamic subtest: coherency [247.666859] Dynamic subtest coherency: SUCCESS (3.706s) [247.681861] Starting dynamic subtest: gtt [256.971613] Dynamic subtest gtt: SUCCESS (9.304s) [256.982614] Starting dynamic subtest: gem [259.414278] Dynamic subtest gem: SUCCESS (2.436s) [259.426680] Starting dynamic subtest: evict [262.759041] Dynamic subtest evict: SUCCESS (3.349s) [262.770337] Starting dynamic subtest: hugepages [271.478770] Dynamic subtest hugepages: SUCCESS (8.719s) [271.489935] Starting dynamic subtest: gem_contexts [286.127976] Dynamic subtest gem_contexts: SUCCESS (14.648s) [286.139239] Starting dynamic subtest: client [288.313779] Dynamic subtest client: SUCCESS (2.176s) [288.327789] Starting dynamic subtest: gem_migrate [290.426945] Dynamic subtest gem_migrate: SUCCESS (2.121s) [290.442109] Starting dynamic subtest: reset [292.755798] Dynamic subtest reset: SUCCESS (2.328s) [292.767090] Starting dynamic subtest: memory_region [294.902660] Dynamic subtest memory_region: SUCCESS (2.146s) [294.913826] Starting dynamic subtest: hangcheck [320.094276] Dynamic subtest hangcheck: SUCCESS (25.188s) [320.106189] Starting dynamic subtest: execlists [330.530512] Dynamic subtest execlists: SUCCESS (10.436s) [330.541218] Starting dynamic subtest: ring_submission [332.659689] Dynamic subtest ring_submission: SUCCESS (2.130s) [332.670724] Starting dynamic subtest: perf [334.890403] Dynamic subtest perf: SUCCESS (2.227s) [334.903325] Starting dynamic subtest: slpc [337.041816] Dynamic subtest slpc: SUCCESS (2.094s) [337.107045] Starting dynamic subtest: guc [339.102598] Dynamic subtest guc: SUCCESS (2.119s) [339.114083] Starting dynamic subtest: guc_multi_lrc [341.241837] Dynamic subtest guc_multi_lrc: SUCCESS (2.138s) [341.253134] Starting dynamic subtest: guc_hang [343.348797] Dynamic subtest guc_hang: SUCCESS (2.106s) [343.360186] Starting dynamic subtest: late_gt_pm [345.503577] Dynamic subtest late_gt_pm: SUCCESS (2.148s) [345.506652] Subtest live: SUCCESS (168.934s) [345.543993] [162/162] (646s left) dmabuf (all-tests) [345.601581] Starting subtest: all-tests [345.604850] Starting dynamic subtest: sanitycheck [345.666654] Dynamic subtest sanitycheck: SUCCESS (0.058s) [345.689307] Starting dynamic subtest: dma_fence [345.826274] Dynamic subtest dma_fence: SUCCESS (0.168s) [345.838627] Starting dynamic subtest: dma_fence_chain [356.835219] Dynamic subtest dma_fence_chain: SUCCESS (11.007s) [356.850933] Starting dynamic subtest: dma_fence_unwrap [356.899051] Dynamic subtest dma_fence_unwrap: SUCCESS (0.061s) [356.924921] Starting dynamic subtest: dma_resv [356.968197] Dynamic subtest dma_resv: SUCCESS (0.066s) [356.971946] Subtest all-tests: SUCCESS (11.371s) [357.005783] 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.