[89.041441] Initializing watchdogs [89.041885] /dev/watchdog0 [89.127629] [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 [89.149297] [001/162] (960s left) i915_module_load (load) [90.178306] Starting subtest: load [95.316752] Subtest load: SUCCESS (5.120s) [95.676924] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [95.696820] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [95.715843] [002/162] (954s left) core_auth (basic-auth) [96.069050] Starting subtest: basic-auth [96.086474] Subtest basic-auth: SUCCESS (0.012s) [96.361556] [003/162] (953s left) core_debugfs (read-all-entries) [96.598994] Starting subtest: read-all-entries [96.608978] Subtest read-all-entries: SUCCESS (0.012s) [96.810802] [004/162] (953s left) core_sysfs (read-all-entries) [97.029261] Starting subtest: read-all-entries [97.044933] Subtest read-all-entries: SUCCESS (0.018s) [97.218983] [005/162] (953s left) fbdev (eof) [97.476322] Subtest eof: SKIP (0.000s) [97.634763] [006/162] (953s left) fbdev (info) [97.901520] Subtest info: SKIP (0.000s) [98.057274] [007/162] (952s left) fbdev (nullptr) [98.316794] Subtest nullptr: SKIP (0.000s) [98.471858] [008/162] (952s left) fbdev (read) [98.730868] Subtest read: SKIP (0.000s) [98.892578] [009/162] (952s left) fbdev (write) [99.144985] Subtest write: SKIP (0.000s) [99.309558] [010/162] (952s left) gem_basic (bad-close) [99.556144] Starting subtest: bad-close [99.562703] Subtest bad-close: SUCCESS (0.000s) [99.730736] [011/162] (951s left) gem_basic (create-close) [99.951351] Starting subtest: create-close [99.954827] Subtest create-close: SUCCESS (0.001s) [100.133440] [012/162] (951s left) gem_basic (create-fd-close) [100.356566] Starting subtest: create-fd-close [100.362482] Subtest create-fd-close: SUCCESS (0.001s) [100.525981] [013/162] (951s left) gem_busy (busy@all-engines) [100.806233] Starting subtest: busy [100.807961] Starting dynamic subtest: all-engines [100.978188] Dynamic subtest all-engines: SUCCESS (0.171s) [100.981425] Subtest busy: SUCCESS (0.173s) [101.529931] [014/162] (950s left) gem_close_race (basic-process) [101.817435] Starting subtest: basic-process [101.934551] Subtest basic-process: SUCCESS (0.121s) [102.261618] [015/162] (950s left) gem_close_race (basic-threads) [102.551282] Starting subtest: basic-threads [103.768644] Subtest basic-threads: SUCCESS (1.214s) [104.076509] [016/162] (948s left) gem_ctx_create (basic) [104.336800] Starting subtest: basic [104.339294] Subtest basic: SUCCESS (0.000s) [104.637337] [017/162] (948s left) gem_ctx_create (basic-files) [104.916746] Starting subtest: basic-files [107.024242] Subtest basic-files: SUCCESS (2.110s) [107.326511] [018/162] (945s left) gem_ctx_exec (basic) [107.569812] Starting subtest: basic [107.588545] Subtest basic: SUCCESS (0.018s) [107.786310] [019/162] (945s left) gem_exec_basic (basic) [108.034160] Starting subtest: basic [108.038819] Starting dynamic subtest: rcs0-smem [108.043300] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [108.092534] Starting dynamic subtest: bcs0-smem [108.095520] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [108.120918] Starting dynamic subtest: vcs0-smem [108.125094] Dynamic subtest vcs0-smem: SUCCESS (0.025s) [108.154927] Starting dynamic subtest: vecs0-smem [108.158490] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [108.160490] Subtest basic: SUCCESS (0.047s) [108.403373] [020/162] (944s left) gem_exec_create (basic) [108.674589] Starting subtest: basic [108.678592] Starting dynamic subtest: smem [110.761510] Dynamic subtest smem: SUCCESS (2.083s) [110.763708] Subtest basic: SUCCESS (2.085s) [111.059794] [021/162] (942s left) gem_exec_fence (basic-busy) [111.484790] Starting subtest: basic-busy [111.487328] Starting dynamic subtest: rcs0 [111.528222] Dynamic subtest rcs0: SUCCESS (0.041s) [111.553235] Starting dynamic subtest: bcs0 [111.576480] Dynamic subtest bcs0: SUCCESS (0.041s) [111.601371] Starting dynamic subtest: vcs0 [111.630986] Dynamic subtest vcs0: SUCCESS (0.051s) [111.657055] Starting dynamic subtest: vecs0 [111.672971] Dynamic subtest vecs0: SUCCESS (0.042s) [111.676642] Subtest basic-busy: SUCCESS (0.195s) [112.609250] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [112.620863] [022/162] (941s left) gem_exec_fence (basic-wait) [113.041979] Starting subtest: basic-wait [113.043794] Starting dynamic subtest: rcs0 [113.077131] Dynamic subtest rcs0: SUCCESS (0.034s) [113.105179] Starting dynamic subtest: bcs0 [113.120666] Dynamic subtest bcs0: SUCCESS (0.038s) [113.149180] Starting dynamic subtest: vcs0 [113.163063] Dynamic subtest vcs0: SUCCESS (0.039s) [113.190777] Starting dynamic subtest: vecs0 [113.204893] Dynamic subtest vecs0: SUCCESS (0.037s) [113.210140] Subtest basic-wait: SUCCESS (0.167s) [113.987379] [023/162] (939s left) gem_exec_fence (basic-await) [114.404661] Starting subtest: basic-await [114.407283] Starting dynamic subtest: rcs0 [114.611648] Dynamic subtest rcs0: SUCCESS (0.204s) [114.638906] Starting dynamic subtest: bcs0 [114.797415] Dynamic subtest bcs0: SUCCESS (0.184s) [114.822919] Starting dynamic subtest: vcs0 [114.986702] Dynamic subtest vcs0: SUCCESS (0.187s) [115.013706] Starting dynamic subtest: vecs0 [115.179644] Dynamic subtest vecs0: SUCCESS (0.188s) [115.181814] Subtest basic-await: SUCCESS (0.776s) [115.944643] [024/162] (938s left) gem_exec_fence (nb-await) [116.390567] Starting subtest: nb-await [116.394102] Starting dynamic subtest: rcs0 [116.491720] Dynamic subtest rcs0: SUCCESS (0.102s) [116.524390] Starting dynamic subtest: bcs0 [116.599287] Dynamic subtest bcs0: SUCCESS (0.099s) [116.627621] Starting dynamic subtest: vcs0 [116.701668] Dynamic subtest vcs0: SUCCESS (0.098s) [116.729877] Starting dynamic subtest: vecs0 [116.807670] Dynamic subtest vecs0: SUCCESS (0.106s) [116.809558] Subtest nb-await: SUCCESS (0.421s) [117.643252] [025/162] (936s left) gem_exec_gttfill (basic) [117.912719] Starting subtest: basic [151.470598] Subtest basic: SUCCESS (33.552s) [151.817461] [026/162] (902s left) gem_exec_parallel (engines) [152.257269] Starting subtest: engines [152.262217] Starting dynamic subtest: basic [160.685486] Dynamic subtest basic: SUCCESS (8.426s) [160.717737] Starting dynamic subtest: contexts [171.671800] Dynamic subtest contexts: SUCCESS (10.984s) [171.702590] Starting dynamic subtest: fds [184.911657] Dynamic subtest fds: SUCCESS (13.236s) [184.948933] Starting dynamic subtest: userptr [191.448408] Dynamic subtest userptr: SUCCESS (6.514s) [191.450935] Subtest engines: SUCCESS (39.192s) [191.863744] [027/162] (862s left) gem_exec_store (basic) [192.219742] Starting subtest: basic [192.320469] Subtest basic: SUCCESS (0.099s) [192.659712] [028/162] (862s left) gem_flink_basic (bad-flink) [192.884969] Starting subtest: bad-flink [192.888642] Subtest bad-flink: SUCCESS (0.000s) [193.121900] [029/162] (862s left) gem_flink_basic (bad-open) [193.335699] Starting subtest: bad-open [193.338445] Subtest bad-open: SUCCESS (0.000s) [193.532766] [030/162] (861s left) gem_flink_basic (basic) [193.754391] Starting subtest: basic [193.757466] Subtest basic: SUCCESS (0.000s) [193.970461] [031/162] (861s left) gem_flink_basic (double-flink) [194.181960] Starting subtest: double-flink [194.185921] Subtest double-flink: SUCCESS (0.000s) [194.403731] [032/162] (861s left) gem_flink_basic (flink-lifetime) [194.624690] Starting subtest: flink-lifetime [194.634872] Subtest flink-lifetime: SUCCESS (0.008s) [194.848416] [033/162] (861s left) gem_huc_copy (huc-copy) [195.090040] Subtest huc-copy: SKIP (0.000s) [195.284483] [034/162] (860s left) gem_linear_blits (basic) [195.826425] Starting subtest: basic [195.871444] Subtest basic: SUCCESS (0.044s) [196.112494] [035/162] (860s left) gem_mmap (basic) [196.485468] Starting subtest: basic [196.499458] Subtest basic: SUCCESS (0.003s) [196.689829] [036/162] (859s left) gem_mmap_gtt (basic) [196.908187] Starting subtest: basic [196.915693] Subtest basic: SUCCESS (0.008s) [197.118172] [037/162] (859s left) gem_render_linear_blits (basic) [197.358380] Starting subtest: basic [197.482388] Subtest basic: SUCCESS (0.116s) [197.693637] [038/162] (859s left) gem_render_tiled_blits (basic) [197.935710] Starting subtest: basic [198.105418] Subtest basic: SUCCESS (0.161s) [198.306209] [039/162] (858s left) gem_ringfill (basic-all) [198.793668] Starting subtest: basic-all [200.110476] Subtest basic-all: SUCCESS (1.314s) [200.335189] [040/162] (857s left) gem_softpin (allocator-basic) [200.568906] Starting subtest: allocator-basic [200.984585] Subtest allocator-basic: SUCCESS (0.404s) [201.248520] [041/162] (856s left) gem_softpin (allocator-basic-reserve) [201.480215] Starting subtest: allocator-basic-reserve [201.874669] Subtest allocator-basic-reserve: SUCCESS (0.393s) [202.146429] [042/162] (855s left) gem_softpin (safe-alignment) [202.396771] Starting subtest: safe-alignment [202.450504] Subtest safe-alignment: SUCCESS (0.049s) [202.680296] [043/162] (855s left) gem_sync (basic-all) [202.986269] Starting subtest: basic-all [206.347624] Subtest basic-all: SUCCESS (3.361s) [206.686421] [044/162] (851s left) gem_sync (basic-each) [206.947165] Starting subtest: basic-each [209.955315] Subtest basic-each: SUCCESS (3.010s) [210.298376] [045/162] (848s left) gem_tiled_blits (basic) [210.753360] Starting subtest: basic [210.842572] Subtest basic: SUCCESS (0.089s) [211.076668] [046/162] (847s left) gem_tiled_fence_blits (basic) [211.708698] Starting subtest: basic [211.779614] Subtest basic: SUCCESS (0.077s) [212.017152] [047/162] (846s left) gem_tiled_pread_basic (basic) [212.405642] Starting subtest: basic [213.486752] Subtest basic: SUCCESS (1.083s) [213.692429] [048/162] (845s left) gem_wait (busy@all-engines) [213.985634] Starting subtest: busy [213.988781] Starting dynamic subtest: all-engines [214.523800] Dynamic subtest all-engines: SUCCESS (0.537s) [214.526818] Subtest busy: SUCCESS (0.542s) [214.951617] [049/162] (844s left) gem_wait (wait@all-engines) [215.232825] Starting subtest: wait [215.236686] Starting dynamic subtest: all-engines [216.275829] Dynamic subtest all-engines: SUCCESS (1.046s) [216.278677] Subtest wait: SUCCESS (1.048s) [216.690994] [050/162] (842s left) i915_getparams_basic (basic-eu-total) [216.911170] Starting subtest: basic-eu-total [216.915197] Subtest basic-eu-total: SUCCESS (0.000s) [217.113460] [051/162] (842s left) i915_getparams_basic (basic-subslice-total) [217.337691] Starting subtest: basic-subslice-total [217.344648] Subtest basic-subslice-total: SUCCESS (0.000s) [217.537670] [052/162] (842s left) i915_hangman (error-state-basic) [217.801849] Starting subtest: error-state-basic [217.839152] Subtest error-state-basic: SUCCESS (0.045s) [218.127425] [053/162] (842s left) i915_pciid [218.541316] [054/162] (841s left) intel_hwmon (hwmon-read) [218.757676] Subtest hwmon-read: SKIP (0.000s) [219.016919] [055/162] (841s left) intel_hwmon (hwmon-write) [219.240106] Subtest hwmon-write: SKIP (0.000s) [219.440164] [056/162] (841s left) kms_addfb_basic (addfb25-4-tiled) [220.051537] Starting subtest: addfb25-4-tiled [220.055189] Subtest addfb25-4-tiled: SUCCESS (0.003s) [220.266061] [057/162] (840s left) kms_addfb_basic (addfb25-bad-modifier) [220.814840] Starting subtest: addfb25-bad-modifier [220.818884] Subtest addfb25-bad-modifier: SUCCESS (0.002s) [221.033644] [058/162] (840s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [221.613413] Starting subtest: addfb25-framebuffer-vs-set-tiling [221.615774] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [221.839538] [059/162] (839s left) kms_addfb_basic (addfb25-modifier-no-flag) [222.499527] Starting subtest: addfb25-modifier-no-flag [222.502393] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [222.705254] [060/162] (838s left) kms_addfb_basic (addfb25-x-tiled-legacy) [223.232868] Starting subtest: addfb25-x-tiled-legacy [223.235270] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [223.447795] [061/162] (838s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [224.001375] Starting subtest: addfb25-x-tiled-mismatch-legacy [224.004422] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [224.209375] [062/162] (837s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [224.780335] Starting subtest: addfb25-yf-tiled-legacy [224.782465] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s) [225.001410] [063/162] (837s left) kms_addfb_basic (addfb25-y-tiled-legacy) [225.523942] Starting subtest: addfb25-y-tiled-legacy [225.526840] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [225.778678] [064/162] (836s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [226.309558] Starting subtest: addfb25-y-tiled-small-legacy [226.316070] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [226.532540] [065/162] (836s left) kms_addfb_basic (bad-pitch-0) [226.754884] Starting subtest: bad-pitch-0 [226.758466] Subtest bad-pitch-0: SUCCESS (0.000s) [227.300329] [066/162] (835s left) kms_addfb_basic (bad-pitch-1024) [227.518675] Starting subtest: bad-pitch-1024 [227.522620] Subtest bad-pitch-1024: SUCCESS (0.000s) [228.051967] [067/162] (835s left) kms_addfb_basic (bad-pitch-128) [228.270711] Starting subtest: bad-pitch-128 [228.275060] Subtest bad-pitch-128: SUCCESS (0.000s) [228.817730] [068/162] (834s left) kms_addfb_basic (bad-pitch-256) [229.034034] Starting subtest: bad-pitch-256 [229.037569] Subtest bad-pitch-256: SUCCESS (0.000s) [229.541802] [069/162] (833s left) kms_addfb_basic (bad-pitch-32) [229.774844] Starting subtest: bad-pitch-32 [229.779295] Subtest bad-pitch-32: SUCCESS (0.000s) [230.395822] [070/162] (833s left) kms_addfb_basic (bad-pitch-63) [230.622895] Starting subtest: bad-pitch-63 [230.627667] Subtest bad-pitch-63: SUCCESS (0.001s) [231.209971] [071/162] (832s left) kms_addfb_basic (bad-pitch-65536) [231.440419] Starting subtest: bad-pitch-65536 [231.443070] Subtest bad-pitch-65536: SUCCESS (0.001s) [232.008938] [072/162] (832s left) kms_addfb_basic (bad-pitch-999) [232.223352] Starting subtest: bad-pitch-999 [232.225431] Subtest bad-pitch-999: SUCCESS (0.000s) [232.755215] [073/162] (831s left) kms_addfb_basic (basic) [232.986617] Starting subtest: basic [232.990140] Subtest basic: SUCCESS (0.000s) [233.568248] [074/162] (830s left) kms_addfb_basic (basic-x-tiled-legacy) [233.802208] Starting subtest: basic-x-tiled-legacy [233.805297] Subtest basic-x-tiled-legacy: SUCCESS (0.002s) [234.371549] [075/162] (830s left) kms_addfb_basic (basic-y-tiled-legacy) [234.592557] Starting subtest: basic-y-tiled-legacy [234.595183] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [235.162348] [076/162] (829s left) kms_addfb_basic (bo-too-small) [235.724788] Starting subtest: bo-too-small [235.728934] Subtest bo-too-small: SUCCESS (0.002s) [235.966855] [077/162] (829s left) kms_addfb_basic (bo-too-small-due-to-tiling) [236.505291] Starting subtest: bo-too-small-due-to-tiling [236.507445] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s) [236.726416] [078/162] (828s left) kms_addfb_basic (clobberred-modifier) [236.950724] Starting subtest: clobberred-modifier [236.952785] Subtest clobberred-modifier: SUCCESS (0.000s) [237.625660] [079/162] (827s left) kms_addfb_basic (framebuffer-vs-set-tiling) [237.856402] Starting subtest: framebuffer-vs-set-tiling [237.858217] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [238.430404] [080/162] (827s left) kms_addfb_basic (invalid-get-prop) [238.658414] Starting subtest: invalid-get-prop [238.662116] Subtest invalid-get-prop: SUCCESS (0.000s) [239.212819] [081/162] (826s left) kms_addfb_basic (invalid-get-prop-any) [239.437709] Starting subtest: invalid-get-prop-any [239.443160] Subtest invalid-get-prop-any: SUCCESS (0.000s) [239.961453] [082/162] (826s left) kms_addfb_basic (invalid-set-prop) [240.230977] Starting subtest: invalid-set-prop [240.232789] Subtest invalid-set-prop: SUCCESS (0.000s) [240.780325] [083/162] (825s left) kms_addfb_basic (invalid-set-prop-any) [241.002783] Starting subtest: invalid-set-prop-any [241.004743] Subtest invalid-set-prop-any: SUCCESS (0.000s) [241.519145] [084/162] (825s left) kms_addfb_basic (no-handle) [241.746784] Starting subtest: no-handle [241.749368] Subtest no-handle: SUCCESS (0.000s) [242.359630] [085/162] (824s left) kms_addfb_basic (size-max) [242.911754] Starting subtest: size-max [242.916947] Subtest size-max: SUCCESS (0.001s) [243.128237] [086/162] (823s left) kms_addfb_basic (small-bo) [243.711406] Starting subtest: small-bo [243.713469] Subtest small-bo: SUCCESS (0.000s) [243.952242] [087/162] (823s left) kms_addfb_basic (tile-pitch-mismatch) [244.178180] Starting subtest: tile-pitch-mismatch [244.180206] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [244.727780] [088/162] (822s left) kms_addfb_basic (too-high) [245.279788] Starting subtest: too-high [245.284465] Subtest too-high: SUCCESS (0.005s) [245.512381] [089/162] (822s left) kms_addfb_basic (too-wide) [246.094076] Starting subtest: too-wide [246.098048] Subtest too-wide: SUCCESS (0.001s) [246.304400] [090/162] (821s left) kms_addfb_basic (unused-handle) [246.517933] Starting subtest: unused-handle [246.522640] Subtest unused-handle: SUCCESS (0.000s) [247.107730] [091/162] (820s left) kms_addfb_basic (unused-modifier) [247.332618] Starting subtest: unused-modifier [247.336246] Subtest unused-modifier: SUCCESS (0.000s) [247.868927] [092/162] (820s left) kms_addfb_basic (unused-offsets) [248.091109] Starting subtest: unused-offsets [248.094477] Subtest unused-offsets: SUCCESS (0.000s) [248.688621] [093/162] (819s left) kms_addfb_basic (unused-pitches) [248.910161] Starting subtest: unused-pitches [248.913835] Subtest unused-pitches: SUCCESS (0.000s) [249.425907] [094/162] (819s left) kms_busy (basic) [250.015239] Subtest basic: SKIP (0.000s) [250.215368] [095/162] (818s left) kms_prop_blob (basic) [250.517228] Starting subtest: basic [250.520444] Subtest basic: SUCCESS (0.000s) [250.715834] [096/162] (818s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [251.266100] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [251.449537] [097/162] (817s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [252.017508] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [252.297691] [098/162] (817s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [252.862416] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [253.071308] [099/162] (816s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [253.655123] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [253.853717] [100/162] (816s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [254.385899] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [254.581766] [101/162] (815s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [255.182578] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [255.378557] [102/162] (815s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [255.924186] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [256.123380] [103/162] (814s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [256.644890] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [256.845196] [104/162] (813s left) kms_dsc (dsc-basic) [257.401680] Subtest dsc-basic: SKIP (0.000s) [257.601765] [105/162] (813s left) kms_flip (basic-flip-vs-dpms) [258.178740] Starting subtest: basic-flip-vs-dpms [258.194274] Subtest basic-flip-vs-dpms: SKIP (0.011s) [258.451204] [106/162] (812s left) kms_flip (basic-flip-vs-modeset) [259.020653] Starting subtest: basic-flip-vs-modeset [259.033314] Subtest basic-flip-vs-modeset: SKIP (0.010s) [259.312956] [107/162] (812s left) kms_flip (basic-flip-vs-wf_vblank) [259.841783] Starting subtest: basic-flip-vs-wf_vblank [259.846528] Subtest basic-flip-vs-wf_vblank: SKIP (0.008s) [260.098932] [108/162] (811s left) kms_flip (basic-plain-flip) [260.637166] Starting subtest: basic-plain-flip [260.646462] Subtest basic-plain-flip: SKIP (0.008s) [260.902753] [109/162] (810s left) kms_force_connector_basic (force-connector-state) [261.223277] Starting subtest: force-connector-state [261.942961] Subtest force-connector-state: SUCCESS (0.711s) [262.882183] [110/162] (809s left) kms_force_connector_basic (force-edid) [263.266362] Starting subtest: force-edid [263.488378] Subtest force-edid: SUCCESS (0.226s) [264.129753] [111/162] (808s left) kms_force_connector_basic (force-load-detect) [264.526903] Starting subtest: force-load-detect [264.535704] Subtest force-load-detect: SKIP (0.000s) [264.999531] [112/162] (807s left) kms_force_connector_basic (prune-stale-modes) [265.336128] Starting subtest: prune-stale-modes [265.553992] Subtest prune-stale-modes: SUCCESS (0.220s) [266.180938] [113/162] (806s left) kms_frontbuffer_tracking (basic) [266.637964] Subtest basic: SKIP (0.000s) [266.860166] [114/162] (806s left) kms_hdmi_inject (inject-audio) [267.209695] Starting subtest: inject-audio [267.647128] Subtest inject-audio: SUCCESS (0.501s) [268.086823] [115/162] (805s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [268.665560] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [268.896701] [116/162] (804s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [269.407721] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [269.620104] [117/162] (803s left) kms_pipe_crc_basic (hang-read-crc) [270.135245] Subtest hang-read-crc: SKIP (0.000s) [270.388923] [118/162] (803s left) kms_pipe_crc_basic (nonblocking-crc) [270.959751] Subtest nonblocking-crc: SKIP (0.000s) [271.230134] [119/162] (802s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [271.815272] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [272.039269] [120/162] (802s left) kms_pipe_crc_basic (read-crc) [272.627595] Subtest read-crc: SKIP (0.000s) [272.849402] [121/162] (801s left) kms_pipe_crc_basic (read-crc-frame-sequence) [273.430435] Subtest read-crc-frame-sequence: SKIP (0.000s) [273.630303] [122/162] (801s left) kms_pm_backlight (basic-brightness) [274.167559] Subtest basic-brightness: SKIP (0.000s) [274.389370] [123/162] (800s left) kms_pm_rpm (basic-pci-d3-state) [276.255774] Starting subtest: basic-pci-d3-state [276.476694] Subtest basic-pci-d3-state: SUCCESS (0.223s) [276.699093] [124/162] (798s left) kms_pm_rpm (basic-rte) [276.913143] Starting subtest: basic-rte [278.796304] Subtest basic-rte: SUCCESS (1.878s) [279.244582] [125/162] (796s left) kms_psr (psr-primary-page-flip) [279.768154] Subtest psr-primary-page-flip: SKIP (0.000s) [280.013531] [126/162] (795s left) kms_psr (psr-cursor-plane-move) [280.589331] Subtest psr-cursor-plane-move: SKIP (0.000s) [280.802664] [127/162] (794s left) kms_psr (psr-sprite-plane-onoff) [281.370766] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [281.586449] [128/162] (794s left) kms_psr (psr-primary-mmap-gtt) [282.157743] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [282.493988] [129/162] (793s left) kms_setmode (basic-clone-single-crtc) [282.724218] Starting subtest: basic-clone-single-crtc [282.731576] Subtest basic-clone-single-crtc: SKIP (0.001s) [282.939487] [130/162] (793s left) i915_pm_rps (basic-api) [283.211989] Starting subtest: basic-api [283.230107] Subtest basic-api: SUCCESS (0.019s) [283.465770] [131/162] (793s left) prime_self_import (basic-llseek-bad) [283.686530] Starting subtest: basic-llseek-bad [283.698729] Subtest basic-llseek-bad: SUCCESS (0.012s) [283.933925] [132/162] (792s left) prime_self_import (basic-llseek-size) [284.134441] Starting subtest: basic-llseek-size [284.154667] Subtest basic-llseek-size: SUCCESS (0.019s) [284.382772] [133/162] (792s left) prime_self_import (basic-with_fd_dup) [284.591784] Starting subtest: basic-with_fd_dup [284.605714] Subtest basic-with_fd_dup: SUCCESS (0.016s) [284.828923] [134/162] (792s left) prime_self_import (basic-with_one_bo) [285.043125] Starting subtest: basic-with_one_bo [285.057417] Subtest basic-with_one_bo: SUCCESS (0.016s) [285.290816] [135/162] (792s left) prime_self_import (basic-with_one_bo_two_files) [285.503651] Starting subtest: basic-with_one_bo_two_files [285.520245] Subtest basic-with_one_bo_two_files: SUCCESS (0.020s) [285.777837] [136/162] (791s left) prime_self_import (basic-with_two_bos) [285.991749] Starting subtest: basic-with_two_bos [286.012654] Subtest basic-with_two_bos: SUCCESS (0.017s) [286.250417] [137/162] (791s left) prime_vgem (basic-fence-flip) [286.520744] Starting subtest: basic-fence-flip [286.888318] Subtest basic-fence-flip: SKIP (0.362s) [287.132964] [138/162] (790s left) prime_vgem (basic-fence-mmap) [287.395773] Starting subtest: basic-fence-mmap [287.514221] Subtest basic-fence-mmap: SUCCESS (0.120s) [287.757408] [139/162] (790s left) prime_vgem (basic-fence-read) [288.009765] Starting subtest: basic-fence-read [288.304761] Subtest basic-fence-read: SUCCESS (0.297s) [288.557389] [140/162] (789s left) prime_vgem (basic-gtt) [288.828408] Starting subtest: basic-gtt [288.875535] Subtest basic-gtt: SUCCESS (0.042s) [289.108694] [141/162] (789s left) prime_vgem (basic-read) [289.379696] Starting subtest: basic-read [289.504494] Subtest basic-read: SUCCESS (0.123s) [289.751732] [142/162] (789s left) prime_vgem (basic-write) [290.011663] Starting subtest: basic-write [290.177235] Subtest basic-write: SUCCESS (0.168s) [290.412423] [143/162] (788s left) vgem_basic (setversion) [290.637605] Starting subtest: setversion [290.642833] Subtest setversion: SUCCESS (0.000s) [290.858581] [144/162] (788s left) vgem_basic (create) [291.081319] Starting subtest: create [291.085821] Subtest create: SUCCESS (0.001s) [291.296718] [145/162] (788s left) vgem_basic (debugfs) [291.516960] Starting subtest: debugfs [291.521328] Subtest debugfs: SUCCESS (0.002s) [291.750598] [146/162] (787s left) vgem_basic (dmabuf-export) [291.972381] Starting subtest: dmabuf-export [291.984932] Subtest dmabuf-export: SUCCESS (0.012s) [292.208721] [147/162] (787s left) vgem_basic (dmabuf-fence) [292.435260] Starting subtest: dmabuf-fence [292.437182] Subtest dmabuf-fence: SUCCESS (0.005s) [292.655386] [148/162] (787s left) vgem_basic (dmabuf-fence-before) [292.888429] Starting subtest: dmabuf-fence-before [292.890407] Subtest dmabuf-fence-before: SUCCESS (0.002s) [293.100923] [149/162] (787s left) vgem_basic (dmabuf-mmap) [293.333134] Starting subtest: dmabuf-mmap [293.377695] Subtest dmabuf-mmap: SUCCESS (0.045s) [293.593734] [150/162] (786s left) vgem_basic (mmap) [293.817785] Starting subtest: mmap [293.852072] Subtest mmap: SUCCESS (0.035s) [294.070591] [151/162] (786s left) vgem_basic (second-client) [294.295893] Starting subtest: second-client [294.310399] Subtest second-client: SUCCESS (0.020s) [294.526785] [152/162] (786s left) vgem_basic (sysfs) [294.754711] Starting subtest: sysfs [294.758756] Subtest sysfs: SUCCESS (0.006s) [295.008349] [153/162] (786s left) core_hotunplug (unbind-rebind) [295.410276] Starting subtest: unbind-rebind [300.575654] Subtest unbind-rebind: SUCCESS (5.159s) [300.790931] [154/162] (780s left) vgem_basic (unload) [301.014350] Starting subtest: unload [330.245226] Subtest unload: SUCCESS (29.218s) [330.640337] [155/162] (750s left) i915_module_load (reload) [330.849717] Starting subtest: reload [337.987795] Subtest reload: SUCCESS (7.121s) [338.421724] [156/162] (743s left) gem_lmem_swapping (basic) [338.758154] Subtest basic: SKIP (0.000s) [338.957513] [157/162] (743s left) gem_lmem_swapping (parallel-random-engines) [339.204747] Subtest parallel-random-engines: SKIP (0.000s) [339.401323] [158/162] (743s left) gem_lmem_swapping (random-engines) [339.647294] Subtest random-engines: SKIP (0.000s) [339.842697] [159/162] (742s left) gem_lmem_swapping (verify-random) [340.090898] Subtest verify-random: SKIP (0.000s) [340.294459] [160/162] (742s left) i915_pm_rpm (module-reload) [342.191711] Starting subtest: module-reload [359.957098] Subtest module-reload: SUCCESS (17.767s) [360.095927] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [360.101622] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [360.113508] [161/162] (722s left) i915_selftest (live) [360.357068] Starting subtest: live [360.359684] Starting dynamic subtest: sanitycheck [365.999635] Dynamic subtest sanitycheck: SUCCESS (5.648s) [366.058557] Starting dynamic subtest: uncore [371.711190] Dynamic subtest uncore: SUCCESS (5.698s) [371.745201] Starting dynamic subtest: workarounds [377.713530] Dynamic subtest workarounds: SUCCESS (5.996s) [377.755703] Starting dynamic subtest: gt_engines [383.840311] Dynamic subtest gt_engines: SUCCESS (6.118s) [383.875978] Starting dynamic subtest: gt_timelines [420.827124] Dynamic subtest gt_timelines: SUCCESS (36.973s) [420.886677] Starting dynamic subtest: gt_contexts [426.571383] Dynamic subtest gt_contexts: SUCCESS (5.730s) [426.611448] Starting dynamic subtest: gt_lrc [436.065257] Dynamic subtest gt_lrc: SUCCESS (9.486s) [436.108069] Starting dynamic subtest: gt_mocs [441.722755] Dynamic subtest gt_mocs: SUCCESS (5.642s) [441.784914] Starting dynamic subtest: gt_pm [448.687168] Dynamic subtest gt_pm: SUCCESS (6.955s) [448.724108] Starting dynamic subtest: gt_heartbeat [454.178916] Dynamic subtest gt_heartbeat: SUCCESS (5.485s) [454.210440] Starting dynamic subtest: gt_tlb [460.445156] Dynamic subtest gt_tlb: SUCCESS (6.258s) [460.476569] Starting dynamic subtest: requests [472.535732] Dynamic subtest requests: SUCCESS (12.086s) [472.569959] Starting dynamic subtest: migrate [482.705876] Dynamic subtest migrate: SUCCESS (10.161s) [482.736225] Starting dynamic subtest: active [488.416283] Dynamic subtest active: SUCCESS (5.703s) [488.481561] Starting dynamic subtest: objects [495.810238] Dynamic subtest objects: SUCCESS (7.387s) [495.846222] Starting dynamic subtest: mman [508.434050] Dynamic subtest mman: SUCCESS (12.619s) [508.479987] Starting dynamic subtest: dmabuf [513.986088] Dynamic subtest dmabuf: SUCCESS (5.540s) [514.029895] Starting dynamic subtest: vma [519.591091] Dynamic subtest vma: SUCCESS (5.605s) [519.665112] Starting dynamic subtest: coherency [531.478627] Dynamic subtest coherency: SUCCESS (11.879s) [531.523692] Starting dynamic subtest: gtt [545.042336] Dynamic subtest gtt: SUCCESS (13.558s) [545.081740] Starting dynamic subtest: gem [551.995892] Dynamic subtest gem: SUCCESS (6.941s) [552.037319] Starting dynamic subtest: evict [565.766793] Dynamic subtest evict: SUCCESS (13.754s) [565.805471] Starting dynamic subtest: hugepages [572.130538] Dynamic subtest hugepages: SUCCESS (6.357s) [572.167271] Starting dynamic subtest: gem_contexts [607.005251] Dynamic subtest gem_contexts: SUCCESS (34.868s) [607.045711] Starting dynamic subtest: client [612.816581] Dynamic subtest client: SUCCESS (5.797s) [612.956607] Starting dynamic subtest: gem_migrate [618.601907] Dynamic subtest gem_migrate: SUCCESS (5.734s) [618.684270] Starting dynamic subtest: reset [632.277659] Dynamic subtest reset: SUCCESS (13.667s) [632.325510] Starting dynamic subtest: memory_region [637.977473] Dynamic subtest memory_region: SUCCESS (5.684s) [638.049919] Starting dynamic subtest: hangcheck [667.319910] Dynamic subtest hangcheck: SUCCESS (29.332s) [667.358236] Starting dynamic subtest: execlists [679.423589] Dynamic subtest execlists: SUCCESS (12.093s) [679.454325] Starting dynamic subtest: ring_submission [685.005356] Dynamic subtest ring_submission: SUCCESS (5.577s) [685.089186] Starting dynamic subtest: perf [690.966281] Dynamic subtest perf: SUCCESS (5.952s) [691.029422] Starting dynamic subtest: slpc [696.780213] Dynamic subtest slpc: SUCCESS (5.800s) [696.844344] Starting dynamic subtest: guc [702.407628] Dynamic subtest guc: SUCCESS (5.619s) [702.518094] Starting dynamic subtest: guc_multi_lrc [708.147298] Dynamic subtest guc_multi_lrc: SUCCESS (5.723s) [708.247896] Starting dynamic subtest: guc_hang [713.713165] Dynamic subtest guc_hang: SUCCESS (5.547s) [713.801177] Starting dynamic subtest: late_gt_pm [719.462899] Dynamic subtest late_gt_pm: SUCCESS (5.730s) [719.478321] Subtest live: SUCCESS (359.114s) [719.649527] [162/162] (363s left) dmabuf (all-tests) [719.882735] Starting subtest: all-tests [719.884664] Starting dynamic subtest: sanitycheck [719.933081] Dynamic subtest sanitycheck: SUCCESS (0.052s) [719.998101] Starting dynamic subtest: dma_fence [720.275953] Dynamic subtest dma_fence: SUCCESS (0.329s) [720.334588] Starting dynamic subtest: dma_fence_chain [720.340135] Dynamic subtest dma_fence_chain: SKIP (0.001s) [720.370815] Starting dynamic subtest: dma_fence_unwrap [720.401894] Dynamic subtest dma_fence_unwrap: SUCCESS (0.104s) [720.451425] Starting dynamic subtest: dma_resv [720.528185] Dynamic subtest dma_resv: SUCCESS (0.117s) [720.537777] Subtest all-tests: SUCCESS (0.657s) [720.683870] 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.