[81.357694] Initializing watchdogs [81.358190] /dev/watchdog0 [81.442106] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller [81.465822] [001/162] (960s left) i915_module_load (load) [81.740322] Starting subtest: load [87.356219] Subtest load: SUCCESS (5.610s) [87.630249] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [87.642750] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [87.654356] [002/162] (954s left) core_auth (basic-auth) [88.013723] Starting subtest: basic-auth [88.022299] Subtest basic-auth: SUCCESS (0.008s) [88.211982] [003/162] (954s left) core_debugfs (read-all-entries) [88.446299] Starting subtest: read-all-entries [88.462500] Subtest read-all-entries: SUCCESS (0.016s) [88.638766] [004/162] (953s left) core_sysfs (read-all-entries) [88.881192] Starting subtest: read-all-entries [88.898714] Subtest read-all-entries: SUCCESS (0.020s) [89.086542] [005/162] (953s left) fbdev (eof) [89.353743] Subtest eof: SKIP (0.000s) [89.525933] [006/162] (953s left) fbdev (info) [89.796333] Subtest info: SKIP (0.000s) [89.986829] [007/162] (953s left) fbdev (nullptr) [90.260843] Subtest nullptr: SKIP (0.000s) [90.422948] [008/162] (952s left) fbdev (read) [90.691065] Subtest read: SKIP (0.000s) [90.855760] [009/162] (952s left) fbdev (write) [91.124654] Subtest write: SKIP (0.000s) [91.288276] [010/162] (952s left) gem_basic (bad-close) [91.508346] Starting subtest: bad-close [91.514859] Subtest bad-close: SUCCESS (0.000s) [91.678526] [011/162] (952s left) gem_basic (create-close) [91.927115] Starting subtest: create-close [91.936501] Subtest create-close: SUCCESS (0.003s) [92.115463] [012/162] (951s left) gem_basic (create-fd-close) [92.347245] Starting subtest: create-fd-close [92.355849] Subtest create-fd-close: SUCCESS (0.001s) [92.550776] [013/162] (951s left) gem_busy (busy@all-engines) [92.859095] Starting subtest: busy [92.862060] Starting dynamic subtest: all-engines [93.043475] Dynamic subtest all-engines: SUCCESS (0.188s) [93.046312] Subtest busy: SUCCESS (0.193s) [93.564167] [014/162] (950s left) gem_close_race (basic-process) [93.860225] Starting subtest: basic-process [94.000269] Subtest basic-process: SUCCESS (0.142s) [94.304766] [015/162] (950s left) gem_close_race (basic-threads) [94.597090] Starting subtest: basic-threads [95.799501] Subtest basic-threads: SUCCESS (1.207s) [96.111797] [016/162] (948s left) gem_ctx_create (basic) [96.381130] Starting subtest: basic [96.382970] Subtest basic: SUCCESS (0.001s) [96.693396] [017/162] (948s left) gem_ctx_create (basic-files) [96.955229] Starting subtest: basic-files [99.019268] Subtest basic-files: SUCCESS (2.067s) [99.332837] [018/162] (945s left) gem_ctx_exec (basic) [99.596139] Starting subtest: basic [99.614365] Subtest basic: SUCCESS (0.023s) [99.815730] [019/162] (945s left) gem_exec_basic (basic) [100.080099] Starting subtest: basic [100.084795] Starting dynamic subtest: rcs0-smem [100.087432] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [100.126309] Starting dynamic subtest: bcs0-smem [100.128088] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [100.154664] Starting dynamic subtest: vcs0-smem [100.156377] Dynamic subtest vcs0-smem: SUCCESS (0.005s) [100.182899] Starting dynamic subtest: vecs0-smem [100.184697] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [100.186404] Subtest basic: SUCCESS (0.030s) [100.409252] [020/162] (945s left) gem_exec_create (basic) [100.683062] Starting subtest: basic [100.685979] Starting dynamic subtest: smem [102.768969] Dynamic subtest smem: SUCCESS (2.083s) [102.771529] Subtest basic: SUCCESS (2.085s) [103.072516] [021/162] (942s left) gem_exec_fence (basic-busy) [103.504602] Starting subtest: basic-busy [103.510163] Starting dynamic subtest: rcs0 [103.539425] Dynamic subtest rcs0: SUCCESS (0.034s) [103.570265] Starting dynamic subtest: bcs0 [103.574381] Dynamic subtest bcs0: SUCCESS (0.036s) [103.605755] Starting dynamic subtest: vcs0 [103.612718] Dynamic subtest vcs0: SUCCESS (0.036s) [103.642309] Starting dynamic subtest: vecs0 [103.646256] Dynamic subtest vecs0: SUCCESS (0.030s) [103.649652] Subtest basic-busy: SUCCESS (0.145s) [104.613241] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [104.624508] [022/162] (941s left) gem_exec_fence (basic-wait) [105.064244] Starting subtest: basic-wait [105.068405] Starting dynamic subtest: rcs0 [105.100301] Dynamic subtest rcs0: SUCCESS (0.036s) [105.157213] Starting dynamic subtest: bcs0 [105.161155] Dynamic subtest bcs0: SUCCESS (0.037s) [105.203264] Starting dynamic subtest: vcs0 [105.207139] Dynamic subtest vcs0: SUCCESS (0.043s) [105.243397] Starting dynamic subtest: vecs0 [105.245109] Dynamic subtest vecs0: SUCCESS (0.031s) [105.246811] Subtest basic-wait: SUCCESS (0.157s) [106.000754] [023/162] (940s left) gem_exec_fence (basic-await) [106.441466] Starting subtest: basic-await [106.444899] Starting dynamic subtest: rcs0 [106.652439] Dynamic subtest rcs0: SUCCESS (0.208s) [106.692040] Starting dynamic subtest: bcs0 [106.858256] Dynamic subtest bcs0: SUCCESS (0.197s) [106.896503] Starting dynamic subtest: vcs0 [107.052941] Dynamic subtest vcs0: SUCCESS (0.191s) [107.099412] Starting dynamic subtest: vecs0 [107.230095] Dynamic subtest vecs0: SUCCESS (0.176s) [107.232207] Subtest basic-await: SUCCESS (0.785s) [108.193752] [024/162] (938s left) gem_exec_fence (nb-await) [108.628327] Starting subtest: nb-await [108.633303] Starting dynamic subtest: rcs0 [108.726508] Dynamic subtest rcs0: SUCCESS (0.094s) [108.768646] Starting dynamic subtest: bcs0 [108.814171] Dynamic subtest bcs0: SUCCESS (0.085s) [108.854077] Starting dynamic subtest: vcs0 [108.904879] Dynamic subtest vcs0: SUCCESS (0.087s) [108.942363] Starting dynamic subtest: vecs0 [108.998237] Dynamic subtest vecs0: SUCCESS (0.090s) [109.000884] Subtest nb-await: SUCCESS (0.372s) [109.789671] [025/162] (936s left) gem_exec_gttfill (basic) [110.069367] Starting subtest: basic [142.315062] Subtest basic: SUCCESS (32.252s) [142.686500] [026/162] (903s left) gem_exec_parallel (engines) [143.140093] Starting subtest: engines [143.144132] Starting dynamic subtest: basic [150.109385] Dynamic subtest basic: SUCCESS (6.978s) [150.159227] Starting dynamic subtest: contexts [160.930455] Dynamic subtest contexts: SUCCESS (10.812s) [160.967827] Starting dynamic subtest: fds [173.665332] Dynamic subtest fds: SUCCESS (12.734s) [173.713271] Starting dynamic subtest: userptr [180.095768] Dynamic subtest userptr: SUCCESS (6.424s) [180.097595] Subtest engines: SUCCESS (36.968s) [180.466842] [027/162] (866s left) gem_exec_store (basic) [180.742223] Starting subtest: basic [180.823708] Subtest basic: SUCCESS (0.084s) [181.165561] [028/162] (865s left) gem_flink_basic (bad-flink) [181.394850] Starting subtest: bad-flink [181.399633] Subtest bad-flink: SUCCESS (0.000s) [181.603865] [029/162] (865s left) gem_flink_basic (bad-open) [181.820463] Starting subtest: bad-open [181.824296] Subtest bad-open: SUCCESS (0.000s) [182.023225] [030/162] (865s left) gem_flink_basic (basic) [182.246447] Starting subtest: basic [182.251471] Subtest basic: SUCCESS (0.000s) [182.463093] [031/162] (865s left) gem_flink_basic (double-flink) [182.711779] Starting subtest: double-flink [182.716100] Subtest double-flink: SUCCESS (0.000s) [182.927408] [032/162] (865s left) gem_flink_basic (flink-lifetime) [183.151181] Starting subtest: flink-lifetime [183.153780] Subtest flink-lifetime: SUCCESS (0.008s) [183.375294] [033/162] (864s left) gem_huc_copy (huc-copy) [183.614148] Subtest huc-copy: SKIP (0.000s) [183.828452] [034/162] (864s left) gem_linear_blits (basic) [184.402953] Starting subtest: basic [184.458283] Subtest basic: SUCCESS (0.051s) [184.690135] [035/162] (863s left) gem_mmap (basic) [185.070685] Starting subtest: basic [185.088245] Subtest basic: SUCCESS (0.002s) [185.286145] [036/162] (863s left) gem_mmap_gtt (basic) [185.509629] Starting subtest: basic [185.517232] Subtest basic: SUCCESS (0.008s) [185.729259] [037/162] (863s left) gem_render_linear_blits (basic) [185.972228] Starting subtest: basic [186.127554] Subtest basic: SUCCESS (0.147s) [186.339446] [038/162] (862s left) gem_render_tiled_blits (basic) [186.570181] Starting subtest: basic [186.752632] Subtest basic: SUCCESS (0.175s) [186.977660] [039/162] (862s left) gem_ringfill (basic-all) [187.454513] Starting subtest: basic-all [188.741680] Subtest basic-all: SUCCESS (1.287s) [188.956710] [040/162] (860s left) gem_softpin (allocator-basic) [189.201895] Starting subtest: allocator-basic [189.665434] Subtest allocator-basic: SUCCESS (0.444s) [189.930596] [041/162] (859s left) gem_softpin (allocator-basic-reserve) [190.178518] Starting subtest: allocator-basic-reserve [190.611206] Subtest allocator-basic-reserve: SUCCESS (0.413s) [190.860193] [042/162] (859s left) gem_softpin (safe-alignment) [191.113229] Starting subtest: safe-alignment [191.169809] Subtest safe-alignment: SUCCESS (0.048s) [191.383973] [043/162] (858s left) gem_sync (basic-all) [191.670626] Starting subtest: basic-all [195.149863] Subtest basic-all: SUCCESS (3.480s) [195.499322] [044/162] (854s left) gem_sync (basic-each) [195.764099] Starting subtest: basic-each [198.690594] Subtest basic-each: SUCCESS (2.925s) [199.023172] [045/162] (851s left) gem_tiled_blits (basic) [199.503414] Starting subtest: basic [199.613065] Subtest basic: SUCCESS (0.092s) [199.866499] [046/162] (851s left) gem_tiled_fence_blits (basic) [200.524143] Starting subtest: basic [200.600886] Subtest basic: SUCCESS (0.066s) [200.833287] [047/162] (850s left) gem_tiled_pread_basic (basic) [201.228375] Starting subtest: basic [202.304830] Subtest basic: SUCCESS (1.076s) [202.516616] [048/162] (848s left) gem_wait (busy@all-engines) [202.815301] Starting subtest: busy [202.822507] Starting dynamic subtest: all-engines [203.359097] Dynamic subtest all-engines: SUCCESS (0.547s) [203.363296] Subtest busy: SUCCESS (0.549s) [203.778825] [049/162] (847s left) gem_wait (wait@all-engines) [204.075711] Starting subtest: wait [204.077739] Starting dynamic subtest: all-engines [205.127350] Dynamic subtest all-engines: SUCCESS (1.052s) [205.129761] Subtest wait: SUCCESS (1.055s) [205.545909] [050/162] (846s left) i915_getparams_basic (basic-eu-total) [205.775719] Starting subtest: basic-eu-total [205.781803] Subtest basic-eu-total: SUCCESS (0.000s) [205.981130] [051/162] (845s left) i915_getparams_basic (basic-subslice-total) [206.202561] Starting subtest: basic-subslice-total [206.207157] Subtest basic-subslice-total: SUCCESS (0.000s) [206.416823] [052/162] (845s left) i915_hangman (error-state-basic) [206.694394] Starting subtest: error-state-basic [206.758284] Subtest error-state-basic: SUCCESS (0.068s) [207.011328] [053/162] (845s left) i915_pciid [207.431357] [054/162] (845s left) intel_hwmon (hwmon-read) [207.664349] Subtest hwmon-read: SKIP (0.000s) [207.866607] [055/162] (844s left) intel_hwmon (hwmon-write) [208.087483] Subtest hwmon-write: SKIP (0.000s) [208.290536] [056/162] (844s left) kms_addfb_basic (addfb25-4-tiled) [208.869547] Starting subtest: addfb25-4-tiled [208.874320] Subtest addfb25-4-tiled: SUCCESS (0.002s) [209.089213] [057/162] (844s left) kms_addfb_basic (addfb25-bad-modifier) [209.643317] Starting subtest: addfb25-bad-modifier [209.646677] Subtest addfb25-bad-modifier: SUCCESS (0.003s) [209.931873] [058/162] (843s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [210.491648] Starting subtest: addfb25-framebuffer-vs-set-tiling [210.493590] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s) [210.725601] [059/162] (842s left) kms_addfb_basic (addfb25-modifier-no-flag) [211.321274] Starting subtest: addfb25-modifier-no-flag [211.324597] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [211.531180] [060/162] (842s left) kms_addfb_basic (addfb25-x-tiled-legacy) [212.091442] Starting subtest: addfb25-x-tiled-legacy [212.095872] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s) [212.321255] [061/162] (841s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [212.998353] Starting subtest: addfb25-x-tiled-mismatch-legacy [213.003743] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [213.211435] [062/162] (841s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [213.794615] Starting subtest: addfb25-yf-tiled-legacy [213.800659] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [214.020146] [063/162] (840s left) kms_addfb_basic (addfb25-y-tiled-legacy) [214.580660] Starting subtest: addfb25-y-tiled-legacy [214.583376] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [214.798731] [064/162] (839s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [215.346398] Starting subtest: addfb25-y-tiled-small-legacy [215.352552] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [215.562247] [065/162] (839s left) kms_addfb_basic (bad-pitch-0) [215.776193] Starting subtest: bad-pitch-0 [215.778188] Subtest bad-pitch-0: SUCCESS (0.000s) [216.349186] [066/162] (838s left) kms_addfb_basic (bad-pitch-1024) [216.578248] Starting subtest: bad-pitch-1024 [216.581213] Subtest bad-pitch-1024: SUCCESS (0.000s) [217.170826] [067/162] (838s left) kms_addfb_basic (bad-pitch-128) [217.404622] Starting subtest: bad-pitch-128 [217.407695] Subtest bad-pitch-128: SUCCESS (0.000s) [217.970821] [068/162] (837s left) kms_addfb_basic (bad-pitch-256) [218.186539] Starting subtest: bad-pitch-256 [218.189323] Subtest bad-pitch-256: SUCCESS (0.000s) [218.758528] [069/162] (837s left) kms_addfb_basic (bad-pitch-32) [218.979230] Starting subtest: bad-pitch-32 [218.982265] Subtest bad-pitch-32: SUCCESS (0.000s) [219.539524] [070/162] (836s left) kms_addfb_basic (bad-pitch-63) [219.759770] Starting subtest: bad-pitch-63 [219.761730] Subtest bad-pitch-63: SUCCESS (0.000s) [220.281138] [071/162] (835s left) kms_addfb_basic (bad-pitch-65536) [220.505258] Starting subtest: bad-pitch-65536 [220.507214] Subtest bad-pitch-65536: SUCCESS (0.001s) [221.100629] [072/162] (835s left) kms_addfb_basic (bad-pitch-999) [221.320342] Starting subtest: bad-pitch-999 [221.324907] Subtest bad-pitch-999: SUCCESS (0.000s) [221.874506] [073/162] (834s left) kms_addfb_basic (basic) [222.097178] Starting subtest: basic [222.100449] Subtest basic: SUCCESS (0.000s) [222.632665] [074/162] (834s left) kms_addfb_basic (basic-x-tiled-legacy) [222.857270] Starting subtest: basic-x-tiled-legacy [222.859226] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [223.372892] [075/162] (833s left) kms_addfb_basic (basic-y-tiled-legacy) [223.599180] Starting subtest: basic-y-tiled-legacy [223.603169] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [224.096369] [076/162] (833s left) kms_addfb_basic (bo-too-small) [224.662589] Starting subtest: bo-too-small [224.664379] Subtest bo-too-small: SUCCESS (0.003s) [224.887236] [077/162] (832s left) kms_addfb_basic (bo-too-small-due-to-tiling) [225.474298] Starting subtest: bo-too-small-due-to-tiling [225.478286] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [225.710559] [078/162] (831s left) kms_addfb_basic (clobberred-modifier) [225.941162] Starting subtest: clobberred-modifier [225.944417] Subtest clobberred-modifier: SUCCESS (0.001s) [226.469467] [079/162] (831s left) kms_addfb_basic (framebuffer-vs-set-tiling) [226.697335] Starting subtest: framebuffer-vs-set-tiling [226.700342] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [227.235683] [080/162] (830s left) kms_addfb_basic (invalid-get-prop) [227.453367] Starting subtest: invalid-get-prop [227.458164] Subtest invalid-get-prop: SUCCESS (0.000s) [228.126945] [081/162] (830s left) kms_addfb_basic (invalid-get-prop-any) [228.353431] Starting subtest: invalid-get-prop-any [228.357322] Subtest invalid-get-prop-any: SUCCESS (0.000s) [228.937697] [082/162] (829s left) kms_addfb_basic (invalid-set-prop) [229.161842] Starting subtest: invalid-set-prop [229.163892] Subtest invalid-set-prop: SUCCESS (0.000s) [229.711417] [083/162] (828s left) kms_addfb_basic (invalid-set-prop-any) [229.938103] Starting subtest: invalid-set-prop-any [229.940201] Subtest invalid-set-prop-any: SUCCESS (0.000s) [230.549884] [084/162] (828s left) kms_addfb_basic (no-handle) [230.775580] Starting subtest: no-handle [230.779189] Subtest no-handle: SUCCESS (0.000s) [231.361993] [085/162] (827s left) kms_addfb_basic (size-max) [231.937963] Starting subtest: size-max [231.941331] Subtest size-max: SUCCESS (0.001s) [232.159135] [086/162] (827s left) kms_addfb_basic (small-bo) [232.758496] Starting subtest: small-bo [232.762216] Subtest small-bo: SUCCESS (0.001s) [232.967412] [087/162] (826s left) kms_addfb_basic (tile-pitch-mismatch) [233.197417] Starting subtest: tile-pitch-mismatch [233.201305] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [233.783226] [088/162] (825s left) kms_addfb_basic (too-high) [234.308532] Starting subtest: too-high [234.312602] Subtest too-high: SUCCESS (0.004s) [234.529467] [089/162] (825s left) kms_addfb_basic (too-wide) [235.111215] Starting subtest: too-wide [235.116972] Subtest too-wide: SUCCESS (0.002s) [235.333539] [090/162] (824s left) kms_addfb_basic (unused-handle) [235.550317] Starting subtest: unused-handle [235.553400] Subtest unused-handle: SUCCESS (0.000s) [236.097975] [091/162] (824s left) kms_addfb_basic (unused-modifier) [236.324160] Starting subtest: unused-modifier [236.328378] Subtest unused-modifier: SUCCESS (0.000s) [236.859646] [092/162] (823s left) kms_addfb_basic (unused-offsets) [237.078451] Starting subtest: unused-offsets [237.082186] Subtest unused-offsets: SUCCESS (0.000s) [237.625768] [093/162] (823s left) kms_addfb_basic (unused-pitches) [237.846977] Starting subtest: unused-pitches [237.850246] Subtest unused-pitches: SUCCESS (0.000s) [238.418995] [094/162] (822s left) kms_busy (basic) [239.051226] Subtest basic: SKIP (0.000s) [239.257151] [095/162] (821s left) kms_prop_blob (basic) [239.479966] Starting subtest: basic [239.484316] Subtest basic: SUCCESS (0.000s) [239.696747] [096/162] (821s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [240.294385] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [240.491854] [097/162] (821s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [241.133625] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [241.336667] [098/162] (820s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [241.938092] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [242.134662] [099/162] (819s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [242.803205] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [242.995553] [100/162] (819s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [243.588189] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [243.794373] [101/162] (818s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [244.360924] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [244.548435] [102/162] (818s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [245.133164] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [245.326586] [103/162] (817s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [245.901181] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [246.094350] [104/162] (816s left) kms_dsc (dsc-basic) [246.658186] Subtest dsc-basic: SKIP (0.000s) [246.863909] [105/162] (816s left) kms_flip (basic-flip-vs-dpms) [247.447208] Starting subtest: basic-flip-vs-dpms [247.458084] Subtest basic-flip-vs-dpms: SKIP (0.009s) [247.719127] [106/162] (815s left) kms_flip (basic-flip-vs-modeset) [248.218195] Starting subtest: basic-flip-vs-modeset [248.231814] Subtest basic-flip-vs-modeset: SKIP (0.007s) [248.491474] [107/162] (815s left) kms_flip (basic-flip-vs-wf_vblank) [249.068226] Starting subtest: basic-flip-vs-wf_vblank [249.085118] Subtest basic-flip-vs-wf_vblank: SKIP (0.011s) [249.359228] [108/162] (814s left) kms_flip (basic-plain-flip) [249.985834] Starting subtest: basic-plain-flip [250.003157] Subtest basic-plain-flip: SKIP (0.014s) [250.278466] [109/162] (813s left) kms_force_connector_basic (force-connector-state) [250.646255] Starting subtest: force-connector-state [251.417658] Subtest force-connector-state: SUCCESS (0.775s) [252.559527] [110/162] (811s left) kms_force_connector_basic (force-edid) [253.006210] Starting subtest: force-edid [253.288117] Subtest force-edid: SUCCESS (0.294s) [253.992638] [111/162] (810s left) kms_force_connector_basic (force-load-detect) [254.336311] Starting subtest: force-load-detect [254.340824] Subtest force-load-detect: SKIP (0.000s) [254.829452] [112/162] (810s left) kms_force_connector_basic (prune-stale-modes) [255.167236] Starting subtest: prune-stale-modes [255.397450] Subtest prune-stale-modes: SUCCESS (0.230s) [256.014694] [113/162] (809s left) kms_frontbuffer_tracking (basic) [256.590932] Subtest basic: SKIP (0.000s) [256.822481] [114/162] (808s left) kms_hdmi_inject (inject-audio) [257.063289] Starting subtest: inject-audio [257.598209] Subtest inject-audio: SUCCESS (0.536s) [258.195343] [115/162] (807s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [258.765742] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [258.998530] [116/162] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [259.595383] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [259.830591] [117/162] (806s left) kms_pipe_crc_basic (hang-read-crc) [260.382699] Subtest hang-read-crc: SKIP (0.000s) [260.599474] [118/162] (805s left) kms_pipe_crc_basic (nonblocking-crc) [261.198783] Subtest nonblocking-crc: SKIP (0.000s) [261.440766] [119/162] (804s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [262.018227] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [262.243658] [120/162] (804s left) kms_pipe_crc_basic (read-crc) [262.842810] Subtest read-crc: SKIP (0.000s) [263.065553] [121/162] (803s left) kms_pipe_crc_basic (read-crc-frame-sequence) [263.574360] Subtest read-crc-frame-sequence: SKIP (0.000s) [263.798288] [122/162] (803s left) kms_pm_backlight (basic-brightness) [264.368368] Subtest basic-brightness: SKIP (0.000s) [264.613259] [123/162] (802s left) kms_pm_rpm (basic-pci-d3-state) [266.453115] Starting subtest: basic-pci-d3-state [266.672159] Subtest basic-pci-d3-state: SUCCESS (0.221s) [266.904185] [124/162] (800s left) kms_pm_rpm (basic-rte) [267.119902] Starting subtest: basic-rte [269.008428] Subtest basic-rte: SUCCESS (1.882s) [269.468732] [125/162] (798s left) kms_psr (psr-primary-page-flip) [270.006526] Subtest psr-primary-page-flip: SKIP (0.000s) [270.240912] [126/162] (797s left) kms_psr (psr-cursor-plane-move) [270.825254] Subtest psr-cursor-plane-move: SKIP (0.000s) [271.050566] [127/162] (797s left) kms_psr (psr-sprite-plane-onoff) [271.644188] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [271.862791] [128/162] (796s left) kms_psr (psr-primary-mmap-gtt) [272.442580] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [272.728469] [129/162] (795s left) kms_setmode (basic-clone-single-crtc) [272.967378] Starting subtest: basic-clone-single-crtc [272.987273] Subtest basic-clone-single-crtc: SKIP (0.000s) [273.211259] [130/162] (795s left) i915_pm_rps (basic-api) [273.494161] Starting subtest: basic-api [273.517455] Subtest basic-api: SUCCESS (0.020s) [273.763351] [131/162] (795s left) prime_self_import (basic-llseek-bad) [273.973120] Starting subtest: basic-llseek-bad [273.985832] Subtest basic-llseek-bad: SUCCESS (0.012s) [274.233622] [132/162] (794s left) prime_self_import (basic-llseek-size) [274.453745] Starting subtest: basic-llseek-size [274.466818] Subtest basic-llseek-size: SUCCESS (0.017s) [274.702241] [133/162] (794s left) prime_self_import (basic-with_fd_dup) [274.925862] Starting subtest: basic-with_fd_dup [274.949249] Subtest basic-with_fd_dup: SUCCESS (0.022s) [275.181165] [134/162] (794s left) prime_self_import (basic-with_one_bo) [275.394973] Starting subtest: basic-with_one_bo [275.422228] Subtest basic-with_one_bo: SUCCESS (0.025s) [275.670706] [135/162] (794s left) prime_self_import (basic-with_one_bo_two_files) [275.895092] Starting subtest: basic-with_one_bo_two_files [275.907704] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s) [276.152372] [136/162] (793s left) prime_self_import (basic-with_two_bos) [276.381689] Starting subtest: basic-with_two_bos [276.394934] Subtest basic-with_two_bos: SUCCESS (0.016s) [276.626860] [137/162] (793s left) prime_vgem (basic-fence-flip) [276.906642] Starting subtest: basic-fence-flip [277.256532] Subtest basic-fence-flip: SKIP (0.352s) [277.497846] [138/162] (792s left) prime_vgem (basic-fence-mmap) [277.762714] Starting subtest: basic-fence-mmap [277.886435] Subtest basic-fence-mmap: SUCCESS (0.120s) [278.126251] [139/162] (792s left) prime_vgem (basic-fence-read) [278.401853] Starting subtest: basic-fence-read [278.683745] Subtest basic-fence-read: SUCCESS (0.275s) [278.909156] [140/162] (791s left) prime_vgem (basic-gtt) [279.157126] Starting subtest: basic-gtt [279.205091] Subtest basic-gtt: SUCCESS (0.047s) [279.458516] [141/162] (791s left) prime_vgem (basic-read) [279.729465] Starting subtest: basic-read [279.845191] Subtest basic-read: SUCCESS (0.118s) [280.102777] [142/162] (791s left) prime_vgem (basic-write) [280.362226] Starting subtest: basic-write [280.529189] Subtest basic-write: SUCCESS (0.170s) [280.765225] [143/162] (790s left) vgem_basic (setversion) [280.991783] Starting subtest: setversion [281.000232] Subtest setversion: SUCCESS (0.000s) [281.212775] [144/162] (790s left) vgem_basic (create) [281.433267] Starting subtest: create [281.435813] Subtest create: SUCCESS (0.001s) [281.655847] [145/162] (790s left) vgem_basic (debugfs) [281.886349] Starting subtest: debugfs [281.890141] Subtest debugfs: SUCCESS (0.002s) [282.109769] [146/162] (790s left) vgem_basic (dmabuf-export) [282.341386] Starting subtest: dmabuf-export [282.347505] Subtest dmabuf-export: SUCCESS (0.011s) [282.603807] [147/162] (789s left) vgem_basic (dmabuf-fence) [282.824375] Starting subtest: dmabuf-fence [282.827265] Subtest dmabuf-fence: SUCCESS (0.003s) [283.051788] [148/162] (789s left) vgem_basic (dmabuf-fence-before) [283.273470] Starting subtest: dmabuf-fence-before [283.277263] Subtest dmabuf-fence-before: SUCCESS (0.002s) [283.506847] [149/162] (789s left) vgem_basic (dmabuf-mmap) [283.738846] Starting subtest: dmabuf-mmap [283.778160] Subtest dmabuf-mmap: SUCCESS (0.041s) [284.001851] [150/162] (789s left) vgem_basic (mmap) [284.250700] Starting subtest: mmap [284.273848] Subtest mmap: SUCCESS (0.034s) [284.499878] [151/162] (788s left) vgem_basic (second-client) [284.730182] Starting subtest: second-client [284.750247] Subtest second-client: SUCCESS (0.017s) [284.975998] [152/162] (788s left) vgem_basic (sysfs) [285.208247] Starting subtest: sysfs [285.210683] Subtest sysfs: SUCCESS (0.004s) [285.446701] [153/162] (788s left) core_hotunplug (unbind-rebind) [285.864585] Starting subtest: unbind-rebind [291.382266] Subtest unbind-rebind: SUCCESS (5.517s) [291.607813] [154/162] (782s left) vgem_basic (unload) [291.834183] Starting subtest: unload [321.074251] Subtest unload: SUCCESS (29.244s) [321.439828] [155/162] (752s left) i915_module_load (reload) [321.654510] Starting subtest: reload [329.054083] Subtest reload: SUCCESS (7.386s) [329.407098] [156/162] (745s left) gem_lmem_swapping (basic) [329.813604] Subtest basic: SKIP (0.000s) [330.002817] [157/162] (744s left) gem_lmem_swapping (parallel-random-engines) [330.273253] Subtest parallel-random-engines: SKIP (0.000s) [330.493336] [158/162] (744s left) gem_lmem_swapping (random-engines) [330.741298] Subtest random-engines: SKIP (0.000s) [330.944943] [159/162] (744s left) gem_lmem_swapping (verify-random) [331.184706] Subtest verify-random: SKIP (0.000s) [331.412454] [160/162] (743s left) i915_pm_rpm (module-reload) [333.310637] Starting subtest: module-reload [351.666361] Subtest module-reload: SUCCESS (18.359s) [351.819470] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [351.825300] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [351.838797] [161/162] (723s left) i915_selftest (live) [352.094283] Starting subtest: live [352.096470] Starting dynamic subtest: sanitycheck [358.094203] Dynamic subtest sanitycheck: SUCCESS (6.005s) [358.129298] Starting dynamic subtest: uncore [363.936950] Dynamic subtest uncore: SUCCESS (5.838s) [364.071211] Starting dynamic subtest: workarounds [370.198898] Dynamic subtest workarounds: SUCCESS (6.252s) [370.245999] Starting dynamic subtest: gt_engines [376.654751] Dynamic subtest gt_engines: SUCCESS (6.443s) [376.699496] Starting dynamic subtest: gt_timelines [414.129368] Dynamic subtest gt_timelines: SUCCESS (37.463s) [414.172037] Starting dynamic subtest: gt_contexts [420.330784] Dynamic subtest gt_contexts: SUCCESS (6.201s) [420.369336] Starting dynamic subtest: gt_lrc [429.813499] Dynamic subtest gt_lrc: SUCCESS (9.475s) [429.849090] Starting dynamic subtest: gt_mocs [435.446524] Dynamic subtest gt_mocs: SUCCESS (5.629s) [435.540311] Starting dynamic subtest: gt_pm [442.789683] Dynamic subtest gt_pm: SUCCESS (7.324s) [442.827075] Starting dynamic subtest: gt_heartbeat [448.589318] Dynamic subtest gt_heartbeat: SUCCESS (5.792s) [448.709273] Starting dynamic subtest: gt_tlb [455.442066] Dynamic subtest gt_tlb: SUCCESS (6.845s) [455.482215] Starting dynamic subtest: requests [467.776845] Dynamic subtest requests: SUCCESS (12.322s) [467.872351] Starting dynamic subtest: migrate [477.923868] Dynamic subtest migrate: SUCCESS (10.140s) [477.963329] Starting dynamic subtest: active [484.062889] Dynamic subtest active: SUCCESS (6.129s) [484.096504] Starting dynamic subtest: objects [491.576311] Dynamic subtest objects: SUCCESS (7.502s) [491.613404] Starting dynamic subtest: mman [504.832953] Dynamic subtest mman: SUCCESS (13.256s) [504.871820] Starting dynamic subtest: dmabuf [510.525870] Dynamic subtest dmabuf: SUCCESS (5.683s) [510.577971] Starting dynamic subtest: vma [516.110959] Dynamic subtest vma: SUCCESS (5.563s) [516.180207] Starting dynamic subtest: coherency [527.749186] Dynamic subtest coherency: SUCCESS (11.617s) [527.864050] Starting dynamic subtest: gtt [541.432674] Dynamic subtest gtt: SUCCESS (13.677s) [541.467127] Starting dynamic subtest: gem [548.714585] Dynamic subtest gem: SUCCESS (7.281s) [548.767658] Starting dynamic subtest: evict [562.665205] Dynamic subtest evict: SUCCESS (13.932s) [562.700454] Starting dynamic subtest: hugepages [569.019479] Dynamic subtest hugepages: SUCCESS (6.353s) [569.063190] Starting dynamic subtest: gem_contexts [603.604555] Dynamic subtest gem_contexts: SUCCESS (34.578s) [603.645263] Starting dynamic subtest: client [609.711190] Dynamic subtest client: SUCCESS (6.098s) [609.752683] Starting dynamic subtest: gem_migrate [615.723929] Dynamic subtest gem_migrate: SUCCESS (6.001s) [615.772465] Starting dynamic subtest: reset [629.962579] Dynamic subtest reset: SUCCESS (14.227s) [629.998119] Starting dynamic subtest: memory_region [635.827535] Dynamic subtest memory_region: SUCCESS (5.856s) [635.862409] Starting dynamic subtest: hangcheck [665.363401] Dynamic subtest hangcheck: SUCCESS (29.534s) [665.403762] Starting dynamic subtest: execlists [677.719482] Dynamic subtest execlists: SUCCESS (12.348s) [677.831647] Starting dynamic subtest: ring_submission [683.593295] Dynamic subtest ring_submission: SUCCESS (5.865s) [683.690480] Starting dynamic subtest: perf [689.820910] Dynamic subtest perf: SUCCESS (6.221s) [689.861679] Starting dynamic subtest: slpc [695.852206] Dynamic subtest slpc: SUCCESS (6.023s) [695.903249] Starting dynamic subtest: guc [702.006187] Dynamic subtest guc: SUCCESS (6.144s) [702.050763] Starting dynamic subtest: guc_multi_lrc [707.991820] Dynamic subtest guc_multi_lrc: SUCCESS (5.982s) [708.053729] Starting dynamic subtest: guc_hang [714.088399] Dynamic subtest guc_hang: SUCCESS (6.076s) [714.123094] Starting dynamic subtest: late_gt_pm [720.223209] Dynamic subtest late_gt_pm: SUCCESS (6.129s) [720.227075] Subtest live: SUCCESS (368.132s) [720.395379] [162/162] (355s left) dmabuf (all-tests) [720.632236] Starting subtest: all-tests [720.634396] Starting dynamic subtest: sanitycheck [720.696156] Dynamic subtest sanitycheck: SUCCESS (0.064s) [720.779509] Starting dynamic subtest: dma_fence [720.935065] Dynamic subtest dma_fence: SUCCESS (0.233s) [721.001743] Starting dynamic subtest: dma_fence_chain [721.006946] Dynamic subtest dma_fence_chain: SKIP (0.001s) [721.083443] Starting dynamic subtest: dma_fence_unwrap [721.086943] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s) [721.126115] Starting dynamic subtest: dma_resv [721.127871] Dynamic subtest dma_resv: SUCCESS (0.068s) [721.129606] Subtest all-tests: SUCCESS (0.471s) [721.264943] 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.