[81.387779] Initializing watchdogs [81.388252] /dev/watchdog0 [81.474678] [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.494765] [001/162] (960s left) i915_module_load (load) [81.759218] Starting subtest: load [87.628803] Subtest load: SUCCESS (5.694s) [88.086621] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [88.099348] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [88.110838] [002/162] (954s left) core_auth (basic-auth) [88.397467] Starting subtest: basic-auth [88.403587] Subtest basic-auth: SUCCESS (0.007s) [88.601805] [003/162] (954s left) core_debugfs (read-all-entries) [88.847777] Starting subtest: read-all-entries [88.859214] Subtest read-all-entries: SUCCESS (0.012s) [89.044586] [004/162] (953s left) core_sysfs (read-all-entries) [89.276150] Starting subtest: read-all-entries [89.288796] Subtest read-all-entries: SUCCESS (0.017s) [89.479894] [005/162] (953s left) fbdev (eof) [89.765895] Subtest eof: SKIP (0.000s) [89.932368] [006/162] (953s left) fbdev (info) [90.205007] Subtest info: SKIP (0.000s) [90.374255] [007/162] (952s left) fbdev (nullptr) [90.648181] Subtest nullptr: SKIP (0.000s) [90.813938] [008/162] (952s left) fbdev (read) [91.096197] Subtest read: SKIP (0.000s) [91.263944] [009/162] (952s left) fbdev (write) [91.553371] Subtest write: SKIP (0.000s) [91.730746] [010/162] (952s left) gem_basic (bad-close) [91.984652] Starting subtest: bad-close [91.991721] Subtest bad-close: SUCCESS (0.001s) [92.182313] [011/162] (951s left) gem_basic (create-close) [92.408592] Starting subtest: create-close [92.419231] Subtest create-close: SUCCESS (0.001s) [92.586924] [012/162] (951s left) gem_basic (create-fd-close) [92.822211] Starting subtest: create-fd-close [92.829569] Subtest create-fd-close: SUCCESS (0.001s) [93.002766] [013/162] (951s left) gem_busy (busy@all-engines) [93.299426] Starting subtest: busy [93.303195] Starting dynamic subtest: all-engines [93.469981] Dynamic subtest all-engines: SUCCESS (0.170s) [93.474241] Subtest busy: SUCCESS (0.172s) [93.993279] [014/162] (950s left) gem_close_race (basic-process) [94.310818] Starting subtest: basic-process [94.456783] Subtest basic-process: SUCCESS (0.147s) [94.763821] [015/162] (950s left) gem_close_race (basic-threads) [95.051449] Starting subtest: basic-threads [96.274870] Subtest basic-threads: SUCCESS (1.215s) [96.590551] [016/162] (948s left) gem_ctx_create (basic) [96.866264] Starting subtest: basic [96.871713] Subtest basic: SUCCESS (0.000s) [97.184267] [017/162] (947s left) gem_ctx_create (basic-files) [97.488398] Starting subtest: basic-files [99.552941] Subtest basic-files: SUCCESS (2.049s) [99.868174] [018/162] (945s left) gem_ctx_exec (basic) [100.119491] Starting subtest: basic [100.143984] Subtest basic: SUCCESS (0.022s) [100.357344] [019/162] (945s left) gem_exec_basic (basic) [100.659486] Starting subtest: basic [100.665678] Starting dynamic subtest: rcs0-smem [100.670331] Dynamic subtest rcs0-smem: SUCCESS (0.014s) [100.747321] Starting dynamic subtest: bcs0-smem [100.750695] Dynamic subtest bcs0-smem: SUCCESS (0.014s) [100.783904] Starting dynamic subtest: vcs0-smem [100.786756] Dynamic subtest vcs0-smem: SUCCESS (0.012s) [100.821702] Starting dynamic subtest: vecs0-smem [100.823465] Dynamic subtest vecs0-smem: SUCCESS (0.012s) [100.828895] Subtest basic: SUCCESS (0.077s) [101.055533] [020/162] (944s left) gem_exec_create (basic) [101.349614] Starting subtest: basic [101.351480] Starting dynamic subtest: smem [103.450654] Dynamic subtest smem: SUCCESS (2.087s) [103.453613] Subtest basic: SUCCESS (2.089s) [103.758452] [021/162] (942s left) gem_exec_fence (basic-busy) [104.192758] Starting subtest: basic-busy [104.196286] Starting dynamic subtest: rcs0 [104.225632] Dynamic subtest rcs0: SUCCESS (0.030s) [104.290419] Starting dynamic subtest: bcs0 [104.293757] Dynamic subtest bcs0: SUCCESS (0.032s) [104.327843] Starting dynamic subtest: vcs0 [104.331170] Dynamic subtest vcs0: SUCCESS (0.035s) [104.358786] Starting dynamic subtest: vecs0 [104.361959] Dynamic subtest vecs0: SUCCESS (0.022s) [104.363706] Subtest basic-busy: SUCCESS (0.133s) [105.257429] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [105.264258] [022/162] (940s left) gem_exec_fence (basic-wait) [105.704747] Starting subtest: basic-wait [105.709200] Starting dynamic subtest: rcs0 [105.741602] Dynamic subtest rcs0: SUCCESS (0.034s) [105.791689] Starting dynamic subtest: bcs0 [105.796505] Dynamic subtest bcs0: SUCCESS (0.039s) [105.833157] Starting dynamic subtest: vcs0 [105.837724] Dynamic subtest vcs0: SUCCESS (0.034s) [105.876306] Starting dynamic subtest: vecs0 [105.878168] Dynamic subtest vecs0: SUCCESS (0.030s) [105.879972] Subtest basic-wait: SUCCESS (0.145s) [106.625746] [023/162] (939s left) gem_exec_fence (basic-await) [107.075176] Starting subtest: basic-await [107.081731] Starting dynamic subtest: rcs0 [107.273978] Dynamic subtest rcs0: SUCCESS (0.198s) [107.309331] Starting dynamic subtest: bcs0 [107.510966] Dynamic subtest bcs0: SUCCESS (0.234s) [107.568237] Starting dynamic subtest: vcs0 [107.769295] Dynamic subtest vcs0: SUCCESS (0.254s) [107.800486] Starting dynamic subtest: vecs0 [107.962679] Dynamic subtest vecs0: SUCCESS (0.190s) [107.964849] Subtest basic-await: SUCCESS (0.889s) [108.760284] [024/162] (937s left) gem_exec_fence (nb-await) [109.196046] Starting subtest: nb-await [109.199327] Starting dynamic subtest: rcs0 [109.295435] Dynamic subtest rcs0: SUCCESS (0.095s) [109.335668] Starting dynamic subtest: bcs0 [109.385227] Dynamic subtest bcs0: SUCCESS (0.086s) [109.426910] Starting dynamic subtest: vcs0 [109.478901] Dynamic subtest vcs0: SUCCESS (0.088s) [109.520101] Starting dynamic subtest: vecs0 [109.567748] Dynamic subtest vecs0: SUCCESS (0.083s) [109.570148] Subtest nb-await: SUCCESS (0.368s) [110.366655] [025/162] (936s left) gem_exec_gttfill (basic) [110.651275] Starting subtest: basic [143.426455] Subtest basic: SUCCESS (32.762s) [143.813747] [026/162] (903s left) gem_exec_parallel (engines) [144.297073] Starting subtest: engines [144.301058] Starting dynamic subtest: basic [153.677269] Dynamic subtest basic: SUCCESS (9.385s) [153.718169] Starting dynamic subtest: contexts [164.532564] Dynamic subtest contexts: SUCCESS (10.852s) [164.575384] Starting dynamic subtest: fds [177.204160] Dynamic subtest fds: SUCCESS (12.669s) [177.246490] Starting dynamic subtest: userptr [183.940483] Dynamic subtest userptr: SUCCESS (6.732s) [183.942528] Subtest engines: SUCCESS (39.651s) [184.314968] [027/162] (862s left) gem_exec_store (basic) [184.596056] Starting subtest: basic [184.663553] Subtest basic: SUCCESS (0.069s) [185.001433] [028/162] (862s left) gem_flink_basic (bad-flink) [185.243752] Starting subtest: bad-flink [185.248440] Subtest bad-flink: SUCCESS (0.000s) [185.461748] [029/162] (862s left) gem_flink_basic (bad-open) [185.687337] Starting subtest: bad-open [185.692223] Subtest bad-open: SUCCESS (0.000s) [185.892717] [030/162] (861s left) gem_flink_basic (basic) [186.110969] Starting subtest: basic [186.114466] Subtest basic: SUCCESS (0.001s) [186.335883] [031/162] (861s left) gem_flink_basic (double-flink) [186.568624] Starting subtest: double-flink [186.573184] Subtest double-flink: SUCCESS (0.001s) [186.787595] [032/162] (861s left) gem_flink_basic (flink-lifetime) [187.013275] Starting subtest: flink-lifetime [187.021264] Subtest flink-lifetime: SUCCESS (0.009s) [187.235554] [033/162] (861s left) gem_huc_copy (huc-copy) [187.486315] Subtest huc-copy: SKIP (0.000s) [187.698387] [034/162] (860s left) gem_linear_blits (basic) [188.258840] Starting subtest: basic [188.312870] Subtest basic: SUCCESS (0.058s) [188.554202] [035/162] (860s left) gem_mmap (basic) [188.947167] Starting subtest: basic [188.965833] Subtest basic: SUCCESS (0.002s) [189.162972] [036/162] (859s left) gem_mmap_gtt (basic) [189.469261] Starting subtest: basic [189.478509] Subtest basic: SUCCESS (0.010s) [189.696779] [037/162] (859s left) gem_render_linear_blits (basic) [189.979196] Starting subtest: basic [190.125206] Subtest basic: SUCCESS (0.143s) [190.342916] [038/162] (859s left) gem_render_tiled_blits (basic) [190.593248] Starting subtest: basic [190.841205] Subtest basic: SUCCESS (0.232s) [191.072967] [039/162] (858s left) gem_ringfill (basic-all) [191.566904] Starting subtest: basic-all [192.906127] Subtest basic-all: SUCCESS (1.338s) [193.133530] [040/162] (856s left) gem_softpin (allocator-basic) [193.373746] Starting subtest: allocator-basic [193.822698] Subtest allocator-basic: SUCCESS (0.423s) [194.115353] [041/162] (856s left) gem_softpin (allocator-basic-reserve) [194.358494] Starting subtest: allocator-basic-reserve [194.791442] Subtest allocator-basic-reserve: SUCCESS (0.436s) [195.099391] [042/162] (855s left) gem_softpin (safe-alignment) [195.362545] Starting subtest: safe-alignment [195.405960] Subtest safe-alignment: SUCCESS (0.050s) [195.630432] [043/162] (854s left) gem_sync (basic-all) [195.910941] Starting subtest: basic-all [199.475268] Subtest basic-all: SUCCESS (3.563s) [199.865375] [044/162] (850s left) gem_sync (basic-each) [200.152054] Starting subtest: basic-each [202.954050] Subtest basic-each: SUCCESS (2.801s) [203.293384] [045/162] (847s left) gem_tiled_blits (basic) [203.749486] Starting subtest: basic [203.842245] Subtest basic: SUCCESS (0.091s) [204.092574] [046/162] (847s left) gem_tiled_fence_blits (basic) [204.768485] Starting subtest: basic [204.843384] Subtest basic: SUCCESS (0.070s) [205.088537] [047/162] (846s left) gem_tiled_pread_basic (basic) [205.478520] Starting subtest: basic [206.546920] Subtest basic: SUCCESS (1.064s) [206.758220] [048/162] (844s left) gem_wait (busy@all-engines) [207.059729] Starting subtest: busy [207.062444] Starting dynamic subtest: all-engines [207.598551] Dynamic subtest all-engines: SUCCESS (0.539s) [207.600470] Subtest busy: SUCCESS (0.545s) [208.011381] [049/162] (843s left) gem_wait (wait@all-engines) [208.316735] Starting subtest: wait [208.321872] Starting dynamic subtest: all-engines [209.360220] Dynamic subtest all-engines: SUCCESS (1.042s) [209.362984] Subtest wait: SUCCESS (1.043s) [209.767976] [050/162] (842s left) i915_getparams_basic (basic-eu-total) [210.022512] Starting subtest: basic-eu-total [210.029265] Subtest basic-eu-total: SUCCESS (0.000s) [210.228197] [051/162] (842s left) i915_getparams_basic (basic-subslice-total) [210.454426] Starting subtest: basic-subslice-total [210.462196] Subtest basic-subslice-total: SUCCESS (0.000s) [210.658508] [052/162] (841s left) i915_hangman (error-state-basic) [210.947248] Starting subtest: error-state-basic [210.985157] Subtest error-state-basic: SUCCESS (0.031s) [211.225773] [053/162] (841s left) i915_pciid [211.662443] [054/162] (841s left) intel_hwmon (hwmon-read) [211.891126] Subtest hwmon-read: SKIP (0.000s) [212.092381] [055/162] (841s left) intel_hwmon (hwmon-write) [212.320270] Subtest hwmon-write: SKIP (0.000s) [212.522764] [056/162] (840s left) kms_addfb_basic (addfb25-4-tiled) [213.080406] Starting subtest: addfb25-4-tiled [213.083491] Subtest addfb25-4-tiled: SUCCESS (0.002s) [213.309306] [057/162] (840s left) kms_addfb_basic (addfb25-bad-modifier) [213.874213] Starting subtest: addfb25-bad-modifier [213.877173] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [214.089768] [058/162] (839s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [214.662494] Starting subtest: addfb25-framebuffer-vs-set-tiling [214.665391] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s) [214.896979] [059/162] (839s left) kms_addfb_basic (addfb25-modifier-no-flag) [215.478403] Starting subtest: addfb25-modifier-no-flag [215.481522] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [215.697722] [060/162] (838s left) kms_addfb_basic (addfb25-x-tiled-legacy) [216.289415] Starting subtest: addfb25-x-tiled-legacy [216.292541] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [216.507077] [061/162] (837s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [217.084039] Starting subtest: addfb25-x-tiled-mismatch-legacy [217.088754] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [217.308989] [062/162] (837s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [217.911812] Starting subtest: addfb25-yf-tiled-legacy [217.914474] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [218.131492] [063/162] (836s left) kms_addfb_basic (addfb25-y-tiled-legacy) [218.727938] Starting subtest: addfb25-y-tiled-legacy [218.730543] Subtest addfb25-y-tiled-legacy: SUCCESS (0.003s) [218.944717] [064/162] (836s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [219.466240] Starting subtest: addfb25-y-tiled-small-legacy [219.472609] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [219.681709] [065/162] (835s left) kms_addfb_basic (bad-pitch-0) [219.920461] Starting subtest: bad-pitch-0 [219.922626] Subtest bad-pitch-0: SUCCESS (0.000s) [220.480965] [066/162] (834s left) kms_addfb_basic (bad-pitch-1024) [220.735566] Starting subtest: bad-pitch-1024 [220.738522] Subtest bad-pitch-1024: SUCCESS (0.000s) [221.430247] [067/162] (834s left) kms_addfb_basic (bad-pitch-128) [221.663270] Starting subtest: bad-pitch-128 [221.667242] Subtest bad-pitch-128: SUCCESS (0.000s) [222.267756] [068/162] (833s left) kms_addfb_basic (bad-pitch-256) [222.502130] Starting subtest: bad-pitch-256 [222.504215] Subtest bad-pitch-256: SUCCESS (0.000s) [223.088512] [069/162] (832s left) kms_addfb_basic (bad-pitch-32) [223.337274] Starting subtest: bad-pitch-32 [223.340360] Subtest bad-pitch-32: SUCCESS (0.000s) [223.868792] [070/162] (832s left) kms_addfb_basic (bad-pitch-63) [224.096615] Starting subtest: bad-pitch-63 [224.098617] Subtest bad-pitch-63: SUCCESS (0.000s) [224.661233] [071/162] (831s left) kms_addfb_basic (bad-pitch-65536) [224.898434] Starting subtest: bad-pitch-65536 [224.901631] Subtest bad-pitch-65536: SUCCESS (0.001s) [225.418930] [072/162] (831s left) kms_addfb_basic (bad-pitch-999) [225.656270] Starting subtest: bad-pitch-999 [225.660233] Subtest bad-pitch-999: SUCCESS (0.000s) [226.226905] [073/162] (830s left) kms_addfb_basic (basic) [226.461548] Starting subtest: basic [226.465233] Subtest basic: SUCCESS (0.000s) [227.048371] [074/162] (830s left) kms_addfb_basic (basic-x-tiled-legacy) [227.297335] Starting subtest: basic-x-tiled-legacy [227.299342] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [227.848111] [075/162] (829s left) kms_addfb_basic (basic-y-tiled-legacy) [228.091248] Starting subtest: basic-y-tiled-legacy [228.093668] Subtest basic-y-tiled-legacy: SUCCESS (0.003s) [228.605930] [076/162] (828s left) kms_addfb_basic (bo-too-small) [229.201479] Starting subtest: bo-too-small [229.204347] Subtest bo-too-small: SUCCESS (0.002s) [229.430995] [077/162] (828s left) kms_addfb_basic (bo-too-small-due-to-tiling) [230.032298] Starting subtest: bo-too-small-due-to-tiling [230.037459] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [230.247586] [078/162] (827s left) kms_addfb_basic (clobberred-modifier) [230.519563] Starting subtest: clobberred-modifier [230.526191] Subtest clobberred-modifier: SUCCESS (0.001s) [231.048732] [079/162] (827s left) kms_addfb_basic (framebuffer-vs-set-tiling) [231.289058] Starting subtest: framebuffer-vs-set-tiling [231.292233] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s) [231.873416] [080/162] (826s left) kms_addfb_basic (invalid-get-prop) [232.122957] Starting subtest: invalid-get-prop [232.128337] Subtest invalid-get-prop: SUCCESS (0.000s) [232.756383] [081/162] (825s left) kms_addfb_basic (invalid-get-prop-any) [232.986311] Starting subtest: invalid-get-prop-any [232.991230] Subtest invalid-get-prop-any: SUCCESS (0.000s) [233.567118] [082/162] (825s left) kms_addfb_basic (invalid-set-prop) [233.802206] Starting subtest: invalid-set-prop [233.806233] Subtest invalid-set-prop: SUCCESS (0.000s) [234.370874] [083/162] (824s left) kms_addfb_basic (invalid-set-prop-any) [234.605645] Starting subtest: invalid-set-prop-any [234.609319] Subtest invalid-set-prop-any: SUCCESS (0.000s) [235.168226] [084/162] (824s left) kms_addfb_basic (no-handle) [235.411520] Starting subtest: no-handle [235.414182] Subtest no-handle: SUCCESS (0.000s) [236.125880] [085/162] (823s left) kms_addfb_basic (size-max) [236.685373] Starting subtest: size-max [236.688399] Subtest size-max: SUCCESS (0.002s) [236.909906] [086/162] (822s left) kms_addfb_basic (small-bo) [237.447225] Starting subtest: small-bo [237.451229] Subtest small-bo: SUCCESS (0.000s) [237.673291] [087/162] (822s left) kms_addfb_basic (tile-pitch-mismatch) [237.915354] Starting subtest: tile-pitch-mismatch [237.920403] Subtest tile-pitch-mismatch: SUCCESS (0.003s) [238.507903] [088/162] (821s left) kms_addfb_basic (too-high) [239.062728] Starting subtest: too-high [239.065435] Subtest too-high: SUCCESS (0.006s) [239.288311] [089/162] (821s left) kms_addfb_basic (too-wide) [239.864316] Starting subtest: too-wide [239.867372] Subtest too-wide: SUCCESS (0.000s) [240.087912] [090/162] (820s left) kms_addfb_basic (unused-handle) [240.313536] Starting subtest: unused-handle [240.316774] Subtest unused-handle: SUCCESS (0.000s) [240.874264] [091/162] (819s left) kms_addfb_basic (unused-modifier) [241.095571] Starting subtest: unused-modifier [241.098046] Subtest unused-modifier: SUCCESS (0.000s) [241.654651] [092/162] (819s left) kms_addfb_basic (unused-offsets) [241.895283] Starting subtest: unused-offsets [241.898641] Subtest unused-offsets: SUCCESS (0.000s) [242.420956] [093/162] (818s left) kms_addfb_basic (unused-pitches) [242.652302] Starting subtest: unused-pitches [242.657493] Subtest unused-pitches: SUCCESS (0.001s) [243.248262] [094/162] (818s left) kms_busy (basic) [243.800381] Subtest basic: SKIP (0.000s) [244.017642] [095/162] (817s left) kms_prop_blob (basic) [244.238420] Starting subtest: basic [244.241163] Subtest basic: SUCCESS (0.000s) [244.448602] [096/162] (817s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [245.020207] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [245.225800] [097/162] (816s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [245.807181] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [246.002984] [098/162] (816s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [246.608216] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [246.802733] [099/162] (815s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [247.378195] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [247.584809] [100/162] (815s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [248.161631] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [248.367945] [101/162] (814s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [248.957836] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [249.155424] [102/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [249.717174] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [249.914543] [103/162] (813s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [250.472076] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [250.687973] [104/162] (812s left) kms_dsc (dsc-basic) [251.323182] Subtest dsc-basic: SKIP (0.000s) [251.536751] [105/162] (812s left) kms_flip (basic-flip-vs-dpms) [252.132731] Starting subtest: basic-flip-vs-dpms [252.142104] Subtest basic-flip-vs-dpms: SKIP (0.008s) [252.413897] [106/162] (811s left) kms_flip (basic-flip-vs-modeset) [253.024330] Starting subtest: basic-flip-vs-modeset [253.030148] Subtest basic-flip-vs-modeset: SKIP (0.006s) [253.290589] [107/162] (810s left) kms_flip (basic-flip-vs-wf_vblank) [253.822207] Starting subtest: basic-flip-vs-wf_vblank [253.831196] Subtest basic-flip-vs-wf_vblank: SKIP (0.007s) [254.092513] [108/162] (810s left) kms_flip (basic-plain-flip) [254.685133] Starting subtest: basic-plain-flip [254.699048] Subtest basic-plain-flip: SKIP (0.008s) [254.966535] [109/162] (809s left) kms_force_connector_basic (force-connector-state) [255.338236] Starting subtest: force-connector-state [256.057273] Subtest force-connector-state: SUCCESS (0.717s) [257.221571] [110/162] (807s left) kms_force_connector_basic (force-edid) [257.608251] Starting subtest: force-edid [257.932314] Subtest force-edid: SUCCESS (0.328s) [258.611157] [111/162] (806s left) kms_force_connector_basic (force-load-detect) [258.964365] Starting subtest: force-load-detect [258.971602] Subtest force-load-detect: SKIP (0.000s) [259.510837] [112/162] (805s left) kms_force_connector_basic (prune-stale-modes) [259.837524] Starting subtest: prune-stale-modes [260.194212] Subtest prune-stale-modes: SUCCESS (0.351s) [260.716727] [113/162] (804s left) kms_frontbuffer_tracking (basic) [261.321169] Subtest basic: SKIP (0.000s) [261.548351] [114/162] (804s left) kms_hdmi_inject (inject-audio) [261.783783] Starting subtest: inject-audio [262.260473] Subtest inject-audio: SUCCESS (0.477s) [262.774960] [115/162] (803s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [263.332386] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [263.549986] [116/162] (802s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [264.141878] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [264.366586] [117/162] (801s left) kms_pipe_crc_basic (hang-read-crc) [264.965551] Subtest hang-read-crc: SKIP (0.000s) [265.206345] [118/162] (801s left) kms_pipe_crc_basic (nonblocking-crc) [265.891131] Subtest nonblocking-crc: SKIP (0.000s) [266.116492] [119/162] (800s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [266.730913] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [266.957466] [120/162] (800s left) kms_pipe_crc_basic (read-crc) [267.581343] Subtest read-crc: SKIP (0.000s) [267.821887] [121/162] (799s left) kms_pipe_crc_basic (read-crc-frame-sequence) [268.346732] Subtest read-crc-frame-sequence: SKIP (0.000s) [268.586911] [122/162] (798s left) kms_pm_backlight (basic-brightness) [269.193152] Subtest basic-brightness: SKIP (0.000s) [269.433345] [123/162] (798s left) kms_pm_rpm (basic-pci-d3-state) [271.400663] Starting subtest: basic-pci-d3-state [271.623770] Subtest basic-pci-d3-state: SUCCESS (0.219s) [271.855516] [124/162] (796s left) kms_pm_rpm (basic-rte) [272.080303] Starting subtest: basic-rte [273.910886] Subtest basic-rte: SUCCESS (1.833s) [274.393597] [125/162] (793s left) kms_psr (psr-primary-page-flip) [275.006897] Subtest psr-primary-page-flip: SKIP (0.000s) [275.241922] [126/162] (793s left) kms_psr (psr-cursor-plane-move) [275.827786] Subtest psr-cursor-plane-move: SKIP (0.000s) [276.054499] [127/162] (792s left) kms_psr (psr-sprite-plane-onoff) [276.678777] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [276.903956] [128/162] (791s left) kms_psr (psr-primary-mmap-gtt) [277.469208] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [277.698192] [129/162] (791s left) kms_setmode (basic-clone-single-crtc) [277.941609] Starting subtest: basic-clone-single-crtc [277.954571] Subtest basic-clone-single-crtc: SKIP (0.000s) [278.189840] [130/162] (790s left) i915_pm_rps (basic-api) [278.474105] Starting subtest: basic-api [278.497361] Subtest basic-api: SUCCESS (0.021s) [278.753470] [131/162] (790s left) prime_self_import (basic-llseek-bad) [278.979667] Starting subtest: basic-llseek-bad [278.992345] Subtest basic-llseek-bad: SUCCESS (0.012s) [279.231700] [132/162] (790s left) prime_self_import (basic-llseek-size) [279.454766] Starting subtest: basic-llseek-size [279.469718] Subtest basic-llseek-size: SUCCESS (0.017s) [279.712763] [133/162] (790s left) prime_self_import (basic-with_fd_dup) [279.939088] Starting subtest: basic-with_fd_dup [279.950205] Subtest basic-with_fd_dup: SUCCESS (0.018s) [280.180721] [134/162] (789s left) prime_self_import (basic-with_one_bo) [280.400463] Starting subtest: basic-with_one_bo [280.423965] Subtest basic-with_one_bo: SUCCESS (0.021s) [280.665986] [135/162] (789s left) prime_self_import (basic-with_one_bo_two_files) [280.900395] Starting subtest: basic-with_one_bo_two_files [280.918275] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s) [281.146662] [136/162] (789s left) prime_self_import (basic-with_two_bos) [281.360189] Starting subtest: basic-with_two_bos [281.379196] Subtest basic-with_two_bos: SUCCESS (0.018s) [281.614626] [137/162] (789s left) prime_vgem (basic-fence-flip) [281.878720] Starting subtest: basic-fence-flip [282.151331] Subtest basic-fence-flip: SKIP (0.265s) [282.389502] [138/162] (788s left) prime_vgem (basic-fence-mmap) [282.668536] Starting subtest: basic-fence-mmap [282.813278] Subtest basic-fence-mmap: SUCCESS (0.144s) [283.058397] [139/162] (788s left) prime_vgem (basic-fence-read) [283.344265] Starting subtest: basic-fence-read [283.619178] Subtest basic-fence-read: SUCCESS (0.283s) [283.879887] [140/162] (787s left) prime_vgem (basic-gtt) [284.152498] Starting subtest: basic-gtt [284.212520] Subtest basic-gtt: SUCCESS (0.060s) [284.448645] [141/162] (787s left) prime_vgem (basic-read) [284.707285] Starting subtest: basic-read [284.844945] Subtest basic-read: SUCCESS (0.131s) [285.072672] [142/162] (786s left) prime_vgem (basic-write) [285.338096] Starting subtest: basic-write [285.516372] Subtest basic-write: SUCCESS (0.177s) [285.764655] [143/162] (786s left) vgem_basic (setversion) [286.010249] Starting subtest: setversion [286.015451] Subtest setversion: SUCCESS (0.000s) [286.229229] [144/162] (785s left) vgem_basic (create) [286.460169] Starting subtest: create [286.464236] Subtest create: SUCCESS (0.001s) [286.682135] [145/162] (785s left) vgem_basic (debugfs) [286.920431] Starting subtest: debugfs [286.924201] Subtest debugfs: SUCCESS (0.002s) [287.140552] [146/162] (785s left) vgem_basic (dmabuf-export) [287.374085] Starting subtest: dmabuf-export [287.396515] Subtest dmabuf-export: SUCCESS (0.017s) [287.623377] [147/162] (785s left) vgem_basic (dmabuf-fence) [287.858499] Starting subtest: dmabuf-fence [287.860541] Subtest dmabuf-fence: SUCCESS (0.004s) [288.085758] [148/162] (784s left) vgem_basic (dmabuf-fence-before) [288.323186] Starting subtest: dmabuf-fence-before [288.326415] Subtest dmabuf-fence-before: SUCCESS (0.002s) [288.543970] [149/162] (784s left) vgem_basic (dmabuf-mmap) [288.771989] Starting subtest: dmabuf-mmap [288.811170] Subtest dmabuf-mmap: SUCCESS (0.043s) [289.029129] [150/162] (784s left) vgem_basic (mmap) [289.265816] Starting subtest: mmap [289.292925] Subtest mmap: SUCCESS (0.032s) [289.517451] [151/162] (784s left) vgem_basic (second-client) [289.763525] Starting subtest: second-client [289.780585] Subtest second-client: SUCCESS (0.020s) [290.005197] [152/162] (783s left) vgem_basic (sysfs) [290.236144] Starting subtest: sysfs [290.241218] Subtest sysfs: SUCCESS (0.003s) [290.453852] [153/162] (783s left) core_hotunplug (unbind-rebind) [290.861261] Starting subtest: unbind-rebind [296.372206] Subtest unbind-rebind: SUCCESS (5.506s) [296.585309] [154/162] (777s left) vgem_basic (unload) [296.801151] Starting subtest: unload [325.986567] Subtest unload: SUCCESS (29.185s) [326.367884] [155/162] (748s left) i915_module_load (reload) [326.584230] Starting subtest: reload [334.115069] Subtest reload: SUCCESS (7.529s) [334.561711] [156/162] (740s left) gem_lmem_swapping (basic) [334.860345] Subtest basic: SKIP (0.000s) [335.067853] [157/162] (740s left) gem_lmem_swapping (parallel-random-engines) [335.361359] Subtest parallel-random-engines: SKIP (0.000s) [335.589589] [158/162] (739s left) gem_lmem_swapping (random-engines) [335.848800] Subtest random-engines: SKIP (0.000s) [336.054817] [159/162] (739s left) gem_lmem_swapping (verify-random) [336.310304] Subtest verify-random: SKIP (0.000s) [336.522422] [160/162] (739s left) i915_pm_rpm (module-reload) [338.443699] Starting subtest: module-reload [357.661987] Subtest module-reload: SUCCESS (19.222s) [357.808399] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [357.814252] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [357.821446] [161/162] (718s left) i915_selftest (live) [358.081325] Starting subtest: live [358.083524] Starting dynamic subtest: sanitycheck [364.130944] Dynamic subtest sanitycheck: SUCCESS (6.055s) [364.164626] Starting dynamic subtest: uncore [369.931990] Dynamic subtest uncore: SUCCESS (5.798s) [369.971724] Starting dynamic subtest: workarounds [376.676687] Dynamic subtest workarounds: SUCCESS (6.735s) [376.714791] Starting dynamic subtest: gt_engines [383.365551] Dynamic subtest gt_engines: SUCCESS (6.683s) [383.403979] Starting dynamic subtest: gt_timelines [423.066045] Dynamic subtest gt_timelines: SUCCESS (39.693s) [423.106807] Starting dynamic subtest: gt_contexts [429.397758] Dynamic subtest gt_contexts: SUCCESS (6.324s) [429.435720] Starting dynamic subtest: gt_lrc [439.021406] Dynamic subtest gt_lrc: SUCCESS (9.617s) [439.058913] Starting dynamic subtest: gt_mocs [444.679302] Dynamic subtest gt_mocs: SUCCESS (5.654s) [444.821276] Starting dynamic subtest: gt_pm [451.938874] Dynamic subtest gt_pm: SUCCESS (7.248s) [451.981835] Starting dynamic subtest: gt_heartbeat [458.089095] Dynamic subtest gt_heartbeat: SUCCESS (6.140s) [458.127382] Starting dynamic subtest: gt_tlb [464.775723] Dynamic subtest gt_tlb: SUCCESS (6.682s) [464.815740] Starting dynamic subtest: requests [477.600332] Dynamic subtest requests: SUCCESS (12.816s) [477.638903] Starting dynamic subtest: migrate [488.295836] Dynamic subtest migrate: SUCCESS (10.690s) [488.334471] Starting dynamic subtest: active [494.275590] Dynamic subtest active: SUCCESS (5.972s) [494.364845] Starting dynamic subtest: objects [501.892634] Dynamic subtest objects: SUCCESS (7.604s) [501.930844] Starting dynamic subtest: mman [515.169068] Dynamic subtest mman: SUCCESS (13.272s) [515.206628] Starting dynamic subtest: dmabuf [521.490910] Dynamic subtest dmabuf: SUCCESS (6.311s) [521.532390] Starting dynamic subtest: vma [527.418305] Dynamic subtest vma: SUCCESS (5.909s) [527.454949] Starting dynamic subtest: coherency [539.048499] Dynamic subtest coherency: SUCCESS (11.630s) [539.092052] Starting dynamic subtest: gtt [553.536640] Dynamic subtest gtt: SUCCESS (14.483s) [553.581902] Starting dynamic subtest: gem [560.827092] Dynamic subtest gem: SUCCESS (7.281s) [560.869932] Starting dynamic subtest: evict [575.455098] Dynamic subtest evict: SUCCESS (14.621s) [575.496254] Starting dynamic subtest: hugepages [582.254558] Dynamic subtest hugepages: SUCCESS (6.791s) [582.292914] Starting dynamic subtest: gem_contexts [616.504440] Dynamic subtest gem_contexts: SUCCESS (34.242s) [616.546187] Starting dynamic subtest: client [622.575956] Dynamic subtest client: SUCCESS (6.063s) [622.617931] Starting dynamic subtest: gem_migrate [628.384722] Dynamic subtest gem_migrate: SUCCESS (5.799s) [628.423451] Starting dynamic subtest: reset [642.928049] Dynamic subtest reset: SUCCESS (14.538s) [642.970035] Starting dynamic subtest: memory_region [648.933979] Dynamic subtest memory_region: SUCCESS (5.994s) [648.979158] Starting dynamic subtest: hangcheck [678.632294] Dynamic subtest hangcheck: SUCCESS (29.685s) [678.681212] Starting dynamic subtest: execlists [691.117736] Dynamic subtest execlists: SUCCESS (12.480s) [691.157416] Starting dynamic subtest: ring_submission [697.492247] Dynamic subtest ring_submission: SUCCESS (6.366s) [697.546181] Starting dynamic subtest: perf [703.729229] Dynamic subtest perf: SUCCESS (6.225s) [703.835204] Starting dynamic subtest: slpc [709.814995] Dynamic subtest slpc: SUCCESS (6.074s) [709.851436] Starting dynamic subtest: guc [715.761873] Dynamic subtest guc: SUCCESS (5.930s) [715.936225] Starting dynamic subtest: guc_multi_lrc [721.820462] Dynamic subtest guc_multi_lrc: SUCCESS (6.063s) [721.862134] Starting dynamic subtest: guc_hang [728.045342] Dynamic subtest guc_hang: SUCCESS (6.219s) [728.087279] Starting dynamic subtest: late_gt_pm [733.946448] Dynamic subtest late_gt_pm: SUCCESS (5.893s) [733.956822] Subtest live: SUCCESS (375.872s) [734.172867] [162/162] (342s left) dmabuf (all-tests) [734.412241] Starting subtest: all-tests [734.420231] Starting dynamic subtest: sanitycheck [734.473247] Dynamic subtest sanitycheck: SUCCESS (0.059s) [734.587422] Starting dynamic subtest: dma_fence [734.675658] Dynamic subtest dma_fence: SUCCESS (0.195s) [734.750916] Starting dynamic subtest: dma_fence_chain [734.755210] Dynamic subtest dma_fence_chain: SKIP (0.001s) [734.788664] Starting dynamic subtest: dma_fence_unwrap [734.807514] Dynamic subtest dma_fence_unwrap: SUCCESS (0.115s) [734.850525] Starting dynamic subtest: dma_resv [734.928817] Dynamic subtest dma_resv: SUCCESS (0.109s) [734.936657] Subtest all-tests: SUCCESS (0.528s) [735.089136] 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.