[42.703559] Initializing watchdogs [42.703702] /dev/watchdog0 [42.743023] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) [42.751535] [001/161] (960s left) i915_module_load (load) [43.068279] Starting subtest: load [47.589224] Subtest load: SUCCESS (4.520s) [47.684360] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [47.688158] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [47.695941] [002/161] (955s left) core_auth (basic-auth) [47.807713] Starting subtest: basic-auth [47.808952] Subtest basic-auth: SUCCESS (0.002s) [47.965507] [003/161] (955s left) debugfs_test (read_all_entries) [48.080076] Starting subtest: read_all_entries [48.190214] Subtest read_all_entries: SUCCESS (0.110s) [48.420228] [004/161] (955s left) debugfs_test (basic-hwmon) [48.558619] Starting subtest: basic-hwmon [48.561906] Subtest basic-hwmon: SKIP (0.000s) [48.739023] [005/161] (954s left) debugfs_test (sysfs) [48.846306] Starting subtest: sysfs [48.963879] Subtest sysfs: SUCCESS (0.116s) [49.154743] [006/161] (954s left) fbdev (eof) [49.255556] Starting subtest: eof [49.256772] Subtest eof: SUCCESS (0.001s) [49.369830] [007/161] (954s left) fbdev (info) [49.465175] Starting subtest: info [49.466344] Subtest info: SUCCESS (0.000s) [49.590629] [008/161] (954s left) fbdev (nullptr) [49.687469] Starting subtest: nullptr [49.688561] Subtest nullptr: SUCCESS (0.000s) [49.805037] [009/161] (954s left) fbdev (read) [49.903956] Starting subtest: read [56.976900] Subtest read: SUCCESS (7.064s) [57.090183] [010/161] (946s left) fbdev (write) [57.204380] Starting subtest: write [61.022523] Subtest write: SUCCESS (3.773s) [61.108183] [011/161] (943s left) gem_basic (bad-close) [61.208639] Starting subtest: bad-close [61.211306] Subtest bad-close: SUCCESS (0.000s) [61.341123] [012/161] (942s left) gem_basic (create-close) [61.444788] Starting subtest: create-close [61.447033] Subtest create-close: SUCCESS (0.000s) [61.594961] [013/161] (942s left) gem_basic (create-fd-close) [61.695440] Starting subtest: create-fd-close [61.697810] Subtest create-fd-close: SUCCESS (0.000s) [61.842187] [014/161] (942s left) gem_busy (busy@all-engines) [61.965501] Starting subtest: busy [61.967192] Starting dynamic subtest: all-engines [62.053531] Dynamic subtest all-engines: SUCCESS (0.087s) [62.054762] Subtest busy: SUCCESS (0.088s) [62.507946] [015/161] (941s left) gem_close_race (basic-process) [62.635040] Starting subtest: basic-process [62.712513] Subtest basic-process: SUCCESS (0.077s) [62.960764] [016/161] (941s left) gem_close_race (basic-threads) [63.087139] Starting subtest: basic-threads [64.287672] Subtest basic-threads: SUCCESS (1.200s) [64.576470] [017/161] (940s left) gem_ctx_create (basic) [64.700281] Starting subtest: basic [64.701416] Subtest basic: SUCCESS (0.000s) [64.959908] [018/161] (939s left) gem_ctx_create (basic-files) [65.083784] Starting subtest: basic-files [67.115244] Subtest basic-files: SUCCESS (2.031s) [67.406608] [019/161] (937s left) gem_ctx_exec (basic) [67.510239] Starting subtest: basic [67.516794] Subtest basic: SUCCESS (0.006s) [67.696969] [020/161] (937s left) gem_exec_basic (basic) [67.811373] Starting subtest: basic [67.812621] Starting dynamic subtest: rcs0-smem [67.813780] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [67.831255] Starting dynamic subtest: bcs0-smem [67.832391] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [67.848607] Starting dynamic subtest: vcs0-smem [67.849733] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [67.865923] Starting dynamic subtest: vecs0-smem [67.866993] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [67.868097] Subtest basic: SUCCESS (0.007s) [68.078021] [021/161] (936s left) gem_exec_create (basic) [68.201533] Starting subtest: basic [68.203179] Starting dynamic subtest: smem [70.248920] Dynamic subtest smem: SUCCESS (2.047s) [70.255734] Subtest basic: SUCCESS (2.048s) [70.551306] [022/161] (934s left) gem_exec_fence (basic-busy) [70.813742] Starting subtest: basic-busy [70.815293] Starting dynamic subtest: rcs0 [70.840669] Dynamic subtest rcs0: SUCCESS (0.027s) [70.858568] Starting dynamic subtest: bcs0 [70.870446] Dynamic subtest bcs0: SUCCESS (0.029s) [70.888806] Starting dynamic subtest: vcs0 [70.896379] Dynamic subtest vcs0: SUCCESS (0.026s) [70.914163] Starting dynamic subtest: vecs0 [70.918369] Dynamic subtest vecs0: SUCCESS (0.022s) [70.919576] Subtest basic-busy: SUCCESS (0.105s) [71.605852] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [71.609549] [023/161] (933s left) gem_exec_fence (basic-wait) [71.890773] Starting subtest: basic-wait [71.892348] Starting dynamic subtest: rcs0 [72.334902] Dynamic subtest rcs0: SUCCESS (0.446s) [72.353636] Starting dynamic subtest: bcs0 [72.581019] Dynamic subtest bcs0: SUCCESS (0.245s) [72.600525] Starting dynamic subtest: vcs0 [72.685992] Dynamic subtest vcs0: SUCCESS (0.101s) [72.704922] Starting dynamic subtest: vecs0 [72.993899] Dynamic subtest vecs0: SUCCESS (0.310s) [72.995359] Subtest basic-wait: SUCCESS (1.106s) [73.770039] [024/161] (931s left) gem_exec_fence (basic-await) [74.128569] Starting subtest: basic-await [74.130410] Starting dynamic subtest: rcs0 [74.275984] Dynamic subtest rcs0: SUCCESS (0.150s) [74.297702] Starting dynamic subtest: bcs0 [74.404353] Dynamic subtest bcs0: SUCCESS (0.127s) [74.426777] Starting dynamic subtest: vcs0 [74.538693] Dynamic subtest vcs0: SUCCESS (0.132s) [74.558157] Starting dynamic subtest: vecs0 [74.654745] Dynamic subtest vecs0: SUCCESS (0.116s) [74.656692] Subtest basic-await: SUCCESS (0.528s) [75.303654] [025/161] (930s left) gem_exec_fence (nb-await) [75.561263] Starting subtest: nb-await [75.562436] Starting dynamic subtest: rcs0 [75.633732] Dynamic subtest rcs0: SUCCESS (0.071s) [75.655402] Starting dynamic subtest: bcs0 [75.701691] Dynamic subtest bcs0: SUCCESS (0.067s) [75.737162] Starting dynamic subtest: vcs0 [75.780977] Dynamic subtest vcs0: SUCCESS (0.076s) [75.823322] Starting dynamic subtest: vecs0 [75.858569] Dynamic subtest vecs0: SUCCESS (0.078s) [75.860898] Subtest nb-await: SUCCESS (0.296s) [76.483492] [026/161] (929s left) gem_exec_gttfill (basic) [76.607613] Starting subtest: basic [89.722571] Subtest basic: SUCCESS (13.106s) [89.974883] [027/161] (915s left) gem_exec_parallel (engines) [90.171832] Starting subtest: engines [90.173131] Starting dynamic subtest: basic [92.890559] Dynamic subtest basic: SUCCESS (2.684s) [92.911463] Starting dynamic subtest: contexts [101.032701] Dynamic subtest contexts: SUCCESS (8.166s) [101.070484] Starting dynamic subtest: fds [106.407293] Dynamic subtest fds: SUCCESS (5.382s) [106.440155] Starting dynamic subtest: userptr [109.103708] Dynamic subtest userptr: SUCCESS (2.662s) [109.105620] Subtest engines: SUCCESS (18.897s) [109.350680] [028/161] (896s left) gem_exec_store (basic) [109.473274] Starting subtest: basic [109.528677] Subtest basic: SUCCESS (0.056s) [109.792368] [029/161] (896s left) gem_flink_basic (bad-flink) [109.893615] Starting subtest: bad-flink [109.894775] Subtest bad-flink: SUCCESS (0.000s) [110.035791] [030/161] (895s left) gem_flink_basic (bad-open) [110.134169] Starting subtest: bad-open [110.135520] Subtest bad-open: SUCCESS (0.000s) [110.288141] [031/161] (895s left) gem_flink_basic (basic) [110.387100] Starting subtest: basic [110.388251] Subtest basic: SUCCESS (0.000s) [110.553380] [032/161] (895s left) gem_flink_basic (double-flink) [110.651893] Starting subtest: double-flink [110.653084] Subtest double-flink: SUCCESS (0.000s) [110.820148] [033/161] (895s left) gem_flink_basic (flink-lifetime) [110.918123] Starting subtest: flink-lifetime [110.920759] Subtest flink-lifetime: SUCCESS (0.002s) [111.084969] [034/161] (895s left) gem_huc_copy (huc-copy) [111.195241] Starting subtest: huc-copy [111.197828] Subtest huc-copy: SKIP (0.000s) [111.371844] [035/161] (895s left) gem_linear_blits (basic) [111.612882] Starting subtest: basic [111.635402] Subtest basic: SUCCESS (0.024s) [111.830124] [036/161] (894s left) gem_mmap (basic) [112.005099] Starting subtest: basic [112.010180] Subtest basic: SUCCESS (0.001s) [112.171189] [037/161] (894s left) gem_mmap_gtt (basic) [112.270089] Starting subtest: basic [112.271513] Subtest basic: SUCCESS (0.001s) [112.417245] [038/161] (894s left) gem_render_linear_blits (basic) [112.526746] Starting subtest: basic [112.583093] Subtest basic: SUCCESS (0.056s) [112.698124] [039/161] (894s left) gem_render_tiled_blits (basic) [112.804203] Starting subtest: basic [112.870349] Subtest basic: SUCCESS (0.066s) [113.002775] [040/161] (893s left) gem_ringfill (basic-all) [113.318869] Starting subtest: basic-all [114.573132] Subtest basic-all: SUCCESS (1.246s) [114.706481] [041/161] (892s left) gem_softpin (allocator-basic) [114.813555] Starting subtest: allocator-basic [114.999147] Subtest allocator-basic: SUCCESS (0.177s) [115.170280] [042/161] (891s left) gem_softpin (allocator-basic-reserve) [115.276279] Starting subtest: allocator-basic-reserve [115.467066] Subtest allocator-basic-reserve: SUCCESS (0.182s) [115.636632] [043/161] (891s left) gem_softpin (safe-alignment) [115.744797] Starting subtest: safe-alignment [115.764249] Subtest safe-alignment: SUCCESS (0.019s) [115.936830] [044/161] (891s left) gem_sync (basic-all) [116.060702] Starting subtest: basic-all [118.511632] Subtest basic-all: SUCCESS (2.418s) [118.754450] [045/161] (888s left) gem_sync (basic-each) [118.880306] Starting subtest: basic-each [121.046817] Subtest basic-each: SUCCESS (2.167s) [121.359506] [046/161] (886s left) gem_tiled_blits (basic) [121.551100] Starting subtest: basic [121.585836] Subtest basic: SUCCESS (0.035s) [121.806910] [047/161] (885s left) gem_tiled_fence_blits (basic) [122.094436] Starting subtest: basic [122.127380] Subtest basic: SUCCESS (0.033s) [122.345688] [048/161] (885s left) gem_tiled_pread_basic [122.937938] [049/161] (884s left) gem_wait (busy@all-engines) [123.074042] Starting subtest: busy [123.075480] Starting dynamic subtest: all-engines [123.593252] Dynamic subtest all-engines: SUCCESS (0.516s) [123.594400] Subtest busy: SUCCESS (0.517s) [123.885916] [050/161] (883s left) gem_wait (wait@all-engines) [124.020279] Starting subtest: wait [124.021613] Starting dynamic subtest: all-engines [125.054500] Dynamic subtest all-engines: SUCCESS (1.027s) [125.055567] Subtest wait: SUCCESS (1.028s) [125.354834] [051/161] (882s left) i915_getparams_basic (basic-eu-total) [125.454646] Starting subtest: basic-eu-total [125.457076] Subtest basic-eu-total: SUCCESS (0.000s) [125.604755] [052/161] (882s left) i915_getparams_basic (basic-subslice-total) [125.703233] Starting subtest: basic-subslice-total [125.705606] Subtest basic-subslice-total: SUCCESS (0.000s) [125.853959] [053/161] (882s left) i915_hangman (error-state-basic) [125.975053] Starting subtest: error-state-basic [125.987892] Subtest error-state-basic: SUCCESS (0.013s) [126.134833] [054/161] (882s left) i915_pciid [126.393651] [055/161] (881s left) kms_addfb_basic (addfb25-4-tiled) [126.554617] Starting subtest: addfb25-4-tiled [126.555952] Subtest addfb25-4-tiled: SUCCESS (0.000s) [126.742854] [056/161] (881s left) kms_addfb_basic (addfb25-bad-modifier) [126.896113] Starting subtest: addfb25-bad-modifier [126.897330] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [127.084488] [057/161] (881s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [127.234194] Starting subtest: addfb25-framebuffer-vs-set-tiling [127.235370] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [127.407951] [058/161] (881s left) kms_addfb_basic (addfb25-modifier-no-flag) [127.560115] Starting subtest: addfb25-modifier-no-flag [127.561277] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [127.718345] [059/161] (880s left) kms_addfb_basic (addfb25-x-tiled-legacy) [127.870173] Starting subtest: addfb25-x-tiled-legacy [127.871380] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [128.050138] [060/161] (880s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [128.202419] Starting subtest: addfb25-x-tiled-mismatch-legacy [128.203617] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [128.372390] [061/161] (880s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [128.527408] Starting subtest: addfb25-yf-tiled-legacy [128.528478] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [128.689182] [062/161] (880s left) kms_addfb_basic (addfb25-y-tiled-legacy) [128.841544] Starting subtest: addfb25-y-tiled-legacy [128.842607] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [129.011914] [063/161] (880s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [129.166553] Starting subtest: addfb25-y-tiled-small-legacy [129.167684] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [129.344525] [064/161] (879s left) kms_addfb_basic (bad-pitch-0) [129.444445] Starting subtest: bad-pitch-0 [129.445534] Subtest bad-pitch-0: SUCCESS (0.000s) [129.652900] [065/161] (879s left) kms_addfb_basic (bad-pitch-1024) [129.749766] Starting subtest: bad-pitch-1024 [129.751097] Subtest bad-pitch-1024: SUCCESS (0.000s) [129.979634] [066/161] (879s left) kms_addfb_basic (bad-pitch-128) [130.078125] Starting subtest: bad-pitch-128 [130.079264] Subtest bad-pitch-128: SUCCESS (0.000s) [130.300141] [067/161] (879s left) kms_addfb_basic (bad-pitch-256) [130.399410] Starting subtest: bad-pitch-256 [130.400526] Subtest bad-pitch-256: SUCCESS (0.000s) [130.630806] [068/161] (878s left) kms_addfb_basic (bad-pitch-32) [130.729409] Starting subtest: bad-pitch-32 [130.730513] Subtest bad-pitch-32: SUCCESS (0.000s) [130.955165] [069/161] (878s left) kms_addfb_basic (bad-pitch-63) [131.053379] Starting subtest: bad-pitch-63 [131.054460] Subtest bad-pitch-63: SUCCESS (0.000s) [131.287317] [070/161] (878s left) kms_addfb_basic (bad-pitch-65536) [131.388549] Starting subtest: bad-pitch-65536 [131.389648] Subtest bad-pitch-65536: SUCCESS (0.000s) [131.618756] [071/161] (878s left) kms_addfb_basic (bad-pitch-999) [131.719907] Starting subtest: bad-pitch-999 [131.721139] Subtest bad-pitch-999: SUCCESS (0.000s) [131.948429] [072/161] (877s left) kms_addfb_basic (basic) [132.049597] Starting subtest: basic [132.050685] Subtest basic: SUCCESS (0.000s) [132.275616] [073/161] (877s left) kms_addfb_basic (basic-x-tiled-legacy) [132.377385] Starting subtest: basic-x-tiled-legacy [132.378499] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [132.604932] [074/161] (877s left) kms_addfb_basic (basic-y-tiled-legacy) [132.705343] Starting subtest: basic-y-tiled-legacy [132.706463] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [132.921683] [075/161] (877s left) kms_addfb_basic (bo-too-small) [133.071992] Starting subtest: bo-too-small [133.073289] Subtest bo-too-small: SUCCESS (0.001s) [133.241694] [076/161] (877s left) kms_addfb_basic (bo-too-small-due-to-tiling) [133.392821] Starting subtest: bo-too-small-due-to-tiling [133.394084] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [133.554713] [077/161] (876s left) kms_addfb_basic (clobberred-modifier) [133.653341] Starting subtest: clobberred-modifier [133.654451] Subtest clobberred-modifier: SUCCESS (0.000s) [133.852316] [078/161] (876s left) kms_addfb_basic (framebuffer-vs-set-tiling) [133.953494] Starting subtest: framebuffer-vs-set-tiling [133.954573] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [134.173132] [079/161] (876s left) kms_addfb_basic (invalid-get-prop) [134.271606] Starting subtest: invalid-get-prop [134.272916] Subtest invalid-get-prop: SUCCESS (0.000s) [134.491182] [080/161] (876s left) kms_addfb_basic (invalid-get-prop-any) [134.589864] Starting subtest: invalid-get-prop-any [134.591193] Subtest invalid-get-prop-any: SUCCESS (0.000s) [134.805500] [081/161] (875s left) kms_addfb_basic (invalid-set-prop) [134.906615] Starting subtest: invalid-set-prop [134.907741] Subtest invalid-set-prop: SUCCESS (0.000s) [135.126837] [082/161] (875s left) kms_addfb_basic (invalid-set-prop-any) [135.228307] Starting subtest: invalid-set-prop-any [135.229452] Subtest invalid-set-prop-any: SUCCESS (0.000s) [135.444470] [083/161] (875s left) kms_addfb_basic (no-handle) [135.542742] Starting subtest: no-handle [135.544051] Subtest no-handle: SUCCESS (0.000s) [135.762720] [084/161] (875s left) kms_addfb_basic (size-max) [135.914823] Starting subtest: size-max [135.916059] Subtest size-max: SUCCESS (0.000s) [136.069296] [085/161] (875s left) kms_addfb_basic (small-bo) [136.221873] Starting subtest: small-bo [136.223279] Subtest small-bo: SUCCESS (0.000s) [136.419478] [086/161] (874s left) kms_addfb_basic (tile-pitch-mismatch) [136.518466] Starting subtest: tile-pitch-mismatch [136.519531] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [136.737489] [087/161] (874s left) kms_addfb_basic (too-high) [136.888834] Starting subtest: too-high [136.892101] Subtest too-high: SUCCESS (0.002s) [137.056978] [088/161] (874s left) kms_addfb_basic (too-wide) [137.210773] Starting subtest: too-wide [137.211961] Subtest too-wide: SUCCESS (0.000s) [137.394750] [089/161] (874s left) kms_addfb_basic (unused-handle) [137.496110] Starting subtest: unused-handle [137.497211] Subtest unused-handle: SUCCESS (0.000s) [137.734394] [090/161] (873s left) kms_addfb_basic (unused-modifier) [137.832649] Starting subtest: unused-modifier [137.833752] Subtest unused-modifier: SUCCESS (0.000s) [138.037808] [091/161] (873s left) kms_addfb_basic (unused-offsets) [138.137737] Starting subtest: unused-offsets [138.139147] Subtest unused-offsets: SUCCESS (0.000s) [138.367480] [092/161] (873s left) kms_addfb_basic (unused-pitches) [138.465790] Starting subtest: unused-pitches [138.467140] Subtest unused-pitches: SUCCESS (0.000s) [138.695415] [093/161] (873s left) kms_busy (basic) [138.852500] Starting subtest: basic [138.854839] Starting dynamic subtest: flip [139.848225] Dynamic subtest flip: SUCCESS (0.992s) [139.878521] Starting dynamic subtest: modeset [143.567881] Dynamic subtest modeset: SUCCESS (3.719s) [143.569694] Subtest basic: SUCCESS (4.715s) [144.555840] [094/161] (867s left) kms_prop_blob (basic) [144.656155] Starting subtest: basic [144.657356] Subtest basic: SUCCESS (0.000s) [144.805796] [095/161] (867s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [144.956527] Starting subtest: basic-busy-flip-before-cursor-atomic [144.958750] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [145.107195] [096/161] (867s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [145.258506] Starting subtest: basic-busy-flip-before-cursor-legacy [145.260705] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [145.404599] [097/161] (866s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [145.557721] Starting subtest: basic-flip-after-cursor-atomic [146.816315] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.258s) [147.737649] [098/161] (864s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [147.893312] Starting subtest: basic-flip-after-cursor-legacy [149.151627] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.256s) [150.072426] [099/161] (862s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [150.224521] Starting subtest: basic-flip-after-cursor-varying-size [151.483502] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.258s) [152.406744] [100/161] (860s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [152.561564] Starting subtest: basic-flip-before-cursor-atomic [153.802062] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.239s) [154.744865] [101/161] (857s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [154.897470] Starting subtest: basic-flip-before-cursor-legacy [156.140637] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.241s) [157.080531] [102/161] (855s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [157.234460] Starting subtest: basic-flip-before-cursor-varying-size [158.487693] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.252s) [159.420892] [103/161] (853s left) kms_dsc (dsc-basic) [159.568832] Starting subtest: dsc-basic [159.574338] Subtest dsc-basic: SKIP (0.001s) [159.725610] [104/161] (853s left) kms_flip (basic-flip-vs-dpms) [159.879500] Starting subtest: basic-flip-vs-dpms [159.882519] Starting dynamic subtest: A-eDP1 [162.724281] Dynamic subtest A-eDP1: SUCCESS (2.841s) [162.766190] Starting dynamic subtest: B-eDP1 [165.083670] Dynamic subtest B-eDP1: SUCCESS (2.355s) [165.122431] Starting dynamic subtest: C-eDP1 [167.449296] Dynamic subtest C-eDP1: SUCCESS (2.361s) [167.451382] Subtest basic-flip-vs-dpms: SUCCESS (7.570s) [168.412649] [105/161] (844s left) kms_flip (basic-flip-vs-modeset) [168.566810] Starting subtest: basic-flip-vs-modeset [168.568953] Starting dynamic subtest: A-eDP1 [171.386608] Dynamic subtest A-eDP1: SUCCESS (2.817s) [171.424339] Starting dynamic subtest: B-eDP1 [173.751462] Dynamic subtest B-eDP1: SUCCESS (2.361s) [173.796290] Starting dynamic subtest: C-eDP1 [176.106392] Dynamic subtest C-eDP1: SUCCESS (2.351s) [176.111220] Subtest basic-flip-vs-modeset: SUCCESS (7.543s) [177.095347] [106/161] (836s left) kms_flip (basic-flip-vs-wf_vblank) [177.247044] Starting subtest: basic-flip-vs-wf_vblank [177.249269] Starting dynamic subtest: A-eDP1 [179.562604] Dynamic subtest A-eDP1: SUCCESS (2.312s) [179.588954] Starting dynamic subtest: B-eDP1 [181.882825] Dynamic subtest B-eDP1: SUCCESS (2.317s) [181.906507] Starting dynamic subtest: C-eDP1 [184.218361] Dynamic subtest C-eDP1: SUCCESS (2.334s) [184.221500] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.975s) [185.600215] [107/161] (827s left) kms_flip (basic-plain-flip) [185.752252] Starting subtest: basic-plain-flip [185.754210] Starting dynamic subtest: A-eDP1 [187.784393] Dynamic subtest A-eDP1: SUCCESS (2.029s) [187.813774] Starting dynamic subtest: B-eDP1 [189.790434] Dynamic subtest B-eDP1: SUCCESS (2.003s) [189.814537] Starting dynamic subtest: C-eDP1 [191.813525] Dynamic subtest C-eDP1: SUCCESS (2.021s) [191.816328] Subtest basic-plain-flip: SUCCESS (6.065s) [193.163151] [108/161] (820s left) kms_force_connector_basic (force-connector-state) [193.289945] Starting subtest: force-connector-state [194.134472] Subtest force-connector-state: SUCCESS (0.844s) [195.139751] [109/161] (818s left) kms_force_connector_basic (force-edid) [195.266127] Starting subtest: force-edid [195.546672] Subtest force-edid: SUCCESS (0.280s) [195.826081] [110/161] (817s left) kms_force_connector_basic (force-load-detect) [195.951097] Starting subtest: force-load-detect [195.953414] Subtest force-load-detect: SKIP (0.000s) [196.162675] [111/161] (817s left) kms_force_connector_basic (prune-stale-modes) [196.287116] Starting subtest: prune-stale-modes [196.623482] Subtest prune-stale-modes: SUCCESS (0.335s) [196.908213] [112/161] (816s left) kms_frontbuffer_tracking (basic) [197.067953] Starting subtest: basic [201.058034] Subtest basic: SUCCESS (3.988s) [201.289339] [113/161] (812s left) kms_hdmi_inject (inject-audio) [201.719903] Starting subtest: inject-audio [202.041455] Subtest inject-audio: SUCCESS (0.325s) [202.698483] [114/161] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [202.853982] Starting subtest: compare-crc-sanitycheck-xr24 [202.855171] Starting dynamic subtest: pipe-A-eDP-1 [203.646525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.789s) [203.690871] Starting dynamic subtest: pipe-B-eDP-1 [204.973294] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.319s) [205.012658] Starting dynamic subtest: pipe-C-eDP-1 [206.319231] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s) [206.320410] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.466s) [207.292882] [115/161] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [207.444832] Starting subtest: compare-crc-sanitycheck-nv12 [207.446058] Starting dynamic subtest: pipe-A-eDP-1 [208.535718] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.088s) [208.582794] Starting dynamic subtest: pipe-B-eDP-1 [209.920998] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s) [209.957922] Starting dynamic subtest: pipe-C-eDP-1 [211.320658] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s) [211.322525] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.877s) [212.233093] [116/161] (801s left) kms_pipe_crc_basic (hang-read-crc) [212.385108] Starting subtest: hang-read-crc [212.386389] Starting dynamic subtest: pipe-A-eDP-1 [214.850486] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.460s) [214.898696] Starting dynamic subtest: pipe-B-eDP-1 [217.854712] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.999s) [217.901431] Starting dynamic subtest: pipe-C-eDP-1 [220.786210] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.920s) [220.787878] Subtest hang-read-crc: SUCCESS (8.400s) [221.695869] [117/161] (792s left) kms_pipe_crc_basic (nonblocking-crc) [221.852229] Starting subtest: nonblocking-crc [221.853364] Starting dynamic subtest: pipe-A-eDP-1 [222.855154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.998s) [222.903547] Starting dynamic subtest: pipe-B-eDP-1 [224.443794] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.582s) [224.481939] Starting dynamic subtest: pipe-C-eDP-1 [226.006454] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.555s) [226.008378] Subtest nonblocking-crc: SUCCESS (4.157s) [226.959033] [118/161] (787s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [227.112135] Starting subtest: nonblocking-crc-frame-sequence [227.113242] Starting dynamic subtest: pipe-A-eDP-1 [228.115497] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.001s) [228.161975] Starting dynamic subtest: pipe-B-eDP-1 [229.704223] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.577s) [229.749837] Starting dynamic subtest: pipe-C-eDP-1 [231.262500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.550s) [231.264533] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.150s) [232.222286] [119/161] (782s left) kms_pipe_crc_basic (read-crc) [232.378111] Starting subtest: read-crc [232.379358] Starting dynamic subtest: pipe-A-eDP-1 [233.311811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.931s) [233.360716] Starting dynamic subtest: pipe-B-eDP-1 [234.794172] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s) [234.836978] Starting dynamic subtest: pipe-C-eDP-1 [236.250339] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.448s) [236.252165] Subtest read-crc: SUCCESS (3.874s) [237.164633] [120/161] (777s left) kms_pipe_crc_basic (read-crc-frame-sequence) [237.320280] Starting subtest: read-crc-frame-sequence [237.321376] Starting dynamic subtest: pipe-A-eDP-1 [238.253436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.931s) [238.305881] Starting dynamic subtest: pipe-B-eDP-1 [239.750079] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.488s) [239.777510] Starting dynamic subtest: pipe-C-eDP-1 [241.317989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.560s) [241.319860] Subtest read-crc-frame-sequence: SUCCESS (3.997s) [242.215862] [121/161] (772s left) kms_pm_backlight (basic-brightness) [242.370435] Starting subtest: basic-brightness [242.486736] Starting dynamic subtest: eDP-1 [243.039234] Dynamic subtest eDP-1: SUCCESS (0.551s) [243.042385] Subtest basic-brightness: SUCCESS (0.669s) [244.004500] [122/161] (770s left) kms_pm_rpm (basic-pci-d3-state) [245.815879] Starting subtest: basic-pci-d3-state [246.408406] Subtest basic-pci-d3-state: SUCCESS (0.596s) [246.647923] [123/161] (768s left) kms_pm_rpm (basic-rte) [246.746159] Starting subtest: basic-rte [249.032957] Subtest basic-rte: SUCCESS (2.284s) [250.337821] [124/161] (764s left) kms_psr (psr-primary-page-flip) [250.494402] Starting subtest: psr-primary-page-flip [250.495509] Starting dynamic subtest: eDP-1 [254.405562] Dynamic subtest eDP-1: SUCCESS (3.908s) [254.407461] Subtest psr-primary-page-flip: SUCCESS (3.912s) [255.366363] [125/161] (759s left) kms_psr (psr-cursor-plane-move) [255.523375] Starting subtest: psr-cursor-plane-move [255.524474] Starting dynamic subtest: eDP-1 [259.217742] Dynamic subtest eDP-1: SUCCESS (3.693s) [259.218979] Subtest psr-cursor-plane-move: SUCCESS (3.696s) [260.207820] [126/161] (754s left) kms_psr (psr-sprite-plane-onoff) [260.363284] Starting subtest: psr-sprite-plane-onoff [260.364413] Starting dynamic subtest: eDP-1 [264.363760] Dynamic subtest eDP-1: SUCCESS (3.995s) [264.364975] Subtest psr-sprite-plane-onoff: SUCCESS (3.999s) [265.254061] [127/161] (749s left) kms_psr (psr-primary-mmap-gtt) [265.410373] Starting subtest: psr-primary-mmap-gtt [265.411498] Starting dynamic subtest: eDP-1 [269.345554] Dynamic subtest eDP-1: SUCCESS (3.929s) [269.348445] Subtest psr-primary-mmap-gtt: SUCCESS (3.933s) [270.307583] [128/161] (745s left) kms_setmode (basic-clone-single-crtc) [270.411124] Starting subtest: basic-clone-single-crtc [270.414432] Subtest basic-clone-single-crtc: SKIP (0.000s) [270.556570] [129/161] (744s left) i915_pm_rps (basic-api) [270.666965] Starting subtest: basic-api [270.671788] Subtest basic-api: SUCCESS (0.005s) [270.838916] [130/161] (744s left) prime_self_import (basic-llseek-bad) [270.939549] Starting subtest: basic-llseek-bad [270.944775] Subtest basic-llseek-bad: SUCCESS (0.004s) [271.122733] [131/161] (744s left) prime_self_import (basic-llseek-size) [271.219543] Starting subtest: basic-llseek-size [271.224456] Subtest basic-llseek-size: SUCCESS (0.006s) [271.390728] [132/161] (744s left) prime_self_import (basic-with_fd_dup) [271.489074] Starting subtest: basic-with_fd_dup [271.494293] Subtest basic-with_fd_dup: SUCCESS (0.005s) [271.656699] [133/161] (744s left) prime_self_import (basic-with_one_bo) [271.752093] Starting subtest: basic-with_one_bo [271.759379] Subtest basic-with_one_bo: SUCCESS (0.006s) [271.906173] [134/161] (743s left) prime_self_import (basic-with_one_bo_two_files) [272.003536] Starting subtest: basic-with_one_bo_two_files [272.009306] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s) [272.172329] [135/161] (743s left) prime_self_import (basic-with_two_bos) [272.270421] Starting subtest: basic-with_two_bos [272.276470] Subtest basic-with_two_bos: SUCCESS (0.005s) [272.440792] [136/161] (743s left) prime_vgem (basic-fence-flip) [272.576372] Starting subtest: basic-fence-flip [273.153782] Subtest basic-fence-flip: SUCCESS (0.577s) [273.323375] [137/161] (742s left) prime_vgem (basic-fence-mmap) [273.459035] Starting subtest: basic-fence-mmap [273.513833] Subtest basic-fence-mmap: SUCCESS (0.054s) [273.673986] [138/161] (742s left) prime_vgem (basic-fence-read) [273.809637] Starting subtest: basic-fence-read [273.908426] Subtest basic-fence-read: SUCCESS (0.101s) [274.056233] [139/161] (742s left) prime_vgem (basic-gtt) [274.182237] Starting subtest: basic-gtt [274.207926] Subtest basic-gtt: SUCCESS (0.026s) [274.354922] [140/161] (742s left) prime_vgem (basic-read) [274.491563] Starting subtest: basic-read [274.538435] Subtest basic-read: SUCCESS (0.047s) [274.704246] [141/161] (741s left) prime_vgem (basic-write) [274.832910] Starting subtest: basic-write [274.897667] Subtest basic-write: SUCCESS (0.065s) [275.056142] [142/161] (741s left) vgem_basic (setversion) [275.173917] Starting subtest: setversion [275.176123] Subtest setversion: SUCCESS (0.000s) [275.307667] [143/161] (741s left) vgem_basic (create) [275.423544] Starting subtest: create [275.424896] Subtest create: SUCCESS (0.000s) [275.556902] [144/161] (741s left) vgem_basic (debugfs) [275.673758] Starting subtest: debugfs [275.676461] Subtest debugfs: SUCCESS (0.001s) [275.804738] [145/161] (741s left) vgem_basic (dmabuf-export) [275.922386] Starting subtest: dmabuf-export [275.927402] Subtest dmabuf-export: SUCCESS (0.004s) [276.090765] [146/161] (740s left) vgem_basic (dmabuf-fence) [276.205145] Starting subtest: dmabuf-fence [276.206425] Subtest dmabuf-fence: SUCCESS (0.001s) [276.344772] [147/161] (740s left) vgem_basic (dmabuf-fence-before) [276.457455] Starting subtest: dmabuf-fence-before [276.458612] Subtest dmabuf-fence-before: SUCCESS (0.001s) [276.589847] [148/161] (740s left) vgem_basic (dmabuf-mmap) [276.705113] Starting subtest: dmabuf-mmap [276.730266] Subtest dmabuf-mmap: SUCCESS (0.025s) [276.871423] [149/161] (740s left) vgem_basic (mmap) [276.988433] Starting subtest: mmap [277.005185] Subtest mmap: SUCCESS (0.016s) [277.138431] [150/161] (740s left) vgem_basic (second-client) [277.257734] Starting subtest: second-client [277.290554] Subtest second-client: SUCCESS (0.034s) [277.423615] [151/161] (740s left) vgem_basic (sysfs) [277.538435] Starting subtest: sysfs [277.539633] Subtest sysfs: SUCCESS (0.001s) [277.671281] [152/161] (739s left) core_hotunplug (unbind-rebind) [277.856474] Starting subtest: unbind-rebind [282.831278] Subtest unbind-rebind: SUCCESS (4.976s) [282.930445] [153/161] (734s left) vgem_basic (unload) [283.033232] Starting subtest: unload [312.187281] Subtest unload: SUCCESS (29.142s) [312.385787] [154/161] (705s left) i915_module_load (reload) [312.486457] Starting subtest: reload [317.326940] Subtest reload: SUCCESS (4.840s) [317.429931] [155/161] (700s left) gem_lmem_swapping (basic) [317.563924] Subtest basic: SKIP (0.000s) [317.677919] [156/161] (700s left) gem_lmem_swapping (parallel-random-engines) [317.786850] Subtest parallel-random-engines: SKIP (0.000s) [317.892200] [157/161] (700s left) gem_lmem_swapping (random-engines) [318.002132] Subtest random-engines: SKIP (0.000s) [318.107974] [158/161] (700s left) gem_lmem_swapping (verify-random) [318.215889] Subtest verify-random: SKIP (0.000s) [318.323718] [159/161] (700s left) i915_pm_rpm (module-reload) [330.782262] Starting subtest: module-reload [364.172536] Subtest module-reload: SUCCESS (33.382s) [364.236699] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [364.239941] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [364.243676] [160/161] (654s left) i915_selftest (live) [364.352531] Starting subtest: live [364.353728] Starting dynamic subtest: sanitycheck [367.647299] Dynamic subtest sanitycheck: SUCCESS (3.284s) [367.668938] Starting dynamic subtest: uncore [370.889205] Dynamic subtest uncore: SUCCESS (3.236s) [370.910288] Starting dynamic subtest: workarounds [374.458458] Dynamic subtest workarounds: SUCCESS (3.564s) [374.480498] Starting dynamic subtest: gt_engines [378.209652] Dynamic subtest gt_engines: SUCCESS (3.746s) [378.231115] Starting dynamic subtest: gt_timelines [391.344333] Dynamic subtest gt_timelines: SUCCESS (13.129s) [391.365640] Starting dynamic subtest: gt_contexts [394.801927] Dynamic subtest gt_contexts: SUCCESS (3.452s) [394.823523] Starting dynamic subtest: gt_lrc [400.357428] Dynamic subtest gt_lrc: SUCCESS (5.558s) [400.384880] Starting dynamic subtest: gt_mocs [403.784176] Dynamic subtest gt_mocs: SUCCESS (3.414s) [403.806037] Starting dynamic subtest: gt_pm [413.043308] Dynamic subtest gt_pm: SUCCESS (9.254s) [413.064717] Starting dynamic subtest: gt_heartbeat [416.359657] Dynamic subtest gt_heartbeat: SUCCESS (3.311s) [416.381353] Starting dynamic subtest: gt_tlb [420.839639] Dynamic subtest gt_tlb: SUCCESS (4.475s) [420.861107] Starting dynamic subtest: requests [430.170678] Dynamic subtest requests: SUCCESS (9.326s) [430.192024] Starting dynamic subtest: migrate [436.123882] Dynamic subtest migrate: SUCCESS (5.956s) [436.151565] Starting dynamic subtest: active [439.435591] Dynamic subtest active: SUCCESS (3.298s) [439.456921] Starting dynamic subtest: objects [443.952526] Dynamic subtest objects: SUCCESS (4.512s) [443.974138] Starting dynamic subtest: mman [451.851460] Dynamic subtest mman: SUCCESS (7.894s) [451.873042] Starting dynamic subtest: dmabuf [455.281786] Dynamic subtest dmabuf: SUCCESS (3.425s) [455.303422] Starting dynamic subtest: vma [458.508572] Dynamic subtest vma: SUCCESS (3.222s) [458.529979] Starting dynamic subtest: coherency [464.043308] Dynamic subtest coherency: SUCCESS (5.529s) [464.064743] Starting dynamic subtest: gtt [475.320844] Dynamic subtest gtt: SUCCESS (11.274s) [475.342631] Starting dynamic subtest: gem [478.987692] Dynamic subtest gem: SUCCESS (3.662s) [479.009619] Starting dynamic subtest: evict [484.442301] Dynamic subtest evict: SUCCESS (5.450s) [484.463984] Starting dynamic subtest: hugepages [493.868451] Dynamic subtest hugepages: SUCCESS (9.421s) [493.889923] Starting dynamic subtest: gem_contexts [510.913799] Dynamic subtest gem_contexts: SUCCESS (17.040s) [510.935386] Starting dynamic subtest: client [514.189740] Dynamic subtest client: SUCCESS (3.272s) [514.211648] Starting dynamic subtest: gem_migrate [517.460161] Dynamic subtest gem_migrate: SUCCESS (3.265s) [517.495221] Starting dynamic subtest: reset [523.925991] Dynamic subtest reset: SUCCESS (6.461s) [523.947966] Starting dynamic subtest: memory_region [527.197274] Dynamic subtest memory_region: SUCCESS (3.266s) [527.219318] Starting dynamic subtest: hangcheck [553.421607] Dynamic subtest hangcheck: SUCCESS (26.219s) [553.443387] Starting dynamic subtest: execlists [565.552854] Dynamic subtest execlists: SUCCESS (12.126s) [565.574589] Starting dynamic subtest: ring_submission [568.819638] Dynamic subtest ring_submission: SUCCESS (3.261s) [568.841413] Starting dynamic subtest: perf [572.286327] Dynamic subtest perf: SUCCESS (3.463s) [572.308662] Starting dynamic subtest: slpc [575.586381] Dynamic subtest slpc: SUCCESS (3.295s) [575.608707] Starting dynamic subtest: guc [578.875784] Dynamic subtest guc: SUCCESS (3.284s) [578.898114] Starting dynamic subtest: guc_multi_lrc [582.156711] Dynamic subtest guc_multi_lrc: SUCCESS (3.275s) [582.178993] Starting dynamic subtest: guc_hang [585.408880] Dynamic subtest guc_hang: SUCCESS (3.247s) [585.430578] Starting dynamic subtest: late_gt_pm [588.750930] Dynamic subtest late_gt_pm: SUCCESS (3.337s) [588.752467] Subtest live: SUCCESS (224.387s) [588.824262] [161/161] (429s left) dmabuf (all-tests) [588.927805] Starting subtest: all-tests [588.929632] Starting dynamic subtest: sanitycheck [589.004883] Dynamic subtest sanitycheck: SUCCESS (0.075s) [589.029776] Starting dynamic subtest: dma_fence [589.285103] Dynamic subtest dma_fence: SUCCESS (0.266s) [589.303627] Starting dynamic subtest: dma_fence_chain [603.985226] Dynamic subtest dma_fence_chain: SUCCESS (14.695s) [604.003093] Starting dynamic subtest: dma_fence_unwrap [604.078935] Dynamic subtest dma_fence_unwrap: SUCCESS (0.098s) [604.103835] Starting dynamic subtest: dma_resv [604.184903] Dynamic subtest dma_resv: SUCCESS (0.101s) [604.191793] Subtest all-tests: SUCCESS (15.259s) [604.261477] Closing watchdogs Done.