[36.246895] Initializing watchdogs [36.247025] /dev/watchdog0 [36.260781] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4682 Intel Alderlake_s (Gen12) Alder Lake-S GT1 [UHD Graphics 730] [36.277323] [001/161] (960s left) i915_module_load (load) [36.340706] Starting subtest: load [37.612244] Subtest load: SUCCESS (1.281s) [37.664587] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [37.665332] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [37.675776] [002/161] (959s left) core_auth (basic-auth) [37.769030] Starting subtest: basic-auth [37.782276] Subtest basic-auth: SUCCESS (0.001s) [37.862286] [003/161] (959s left) debugfs_test (read_all_entries) [37.937409] Starting subtest: read_all_entries [38.106518] Subtest read_all_entries: SUCCESS (0.170s) [38.258168] [004/161] (958s left) debugfs_test (basic-hwmon) [38.341451] Starting subtest: basic-hwmon [38.364097] Subtest basic-hwmon: SKIP (0.000s) [38.476474] [005/161] (958s left) debugfs_test (sysfs) [38.563026] Starting subtest: sysfs [38.569210] Subtest sysfs: SUCCESS (0.018s) [38.744694] [006/161] (958s left) fbdev (eof) [38.816685] Starting subtest: eof [38.825457] Subtest eof: SUCCESS (0.000s) [38.897358] [007/161] (958s left) fbdev (info) [38.970328] Starting subtest: info [38.986637] Subtest info: SUCCESS (0.000s) [39.071062] [008/161] (958s left) fbdev (nullptr) [39.139179] Starting subtest: nullptr [39.145448] Subtest nullptr: SUCCESS (0.000s) [39.211168] [009/161] (958s left) fbdev (read) [39.279715] Starting subtest: read [40.921220] Subtest read: SUCCESS (1.634s) [40.997488] [010/161] (956s left) fbdev (write) [41.070815] Starting subtest: write [42.183218] Subtest write: SUCCESS (1.105s) [42.247843] [011/161] (955s left) gem_basic (bad-close) [42.308378] Starting subtest: bad-close [42.321256] Subtest bad-close: SUCCESS (0.000s) [42.389720] [012/161] (954s left) gem_basic (create-close) [42.442975] Starting subtest: create-close [42.455661] Subtest create-close: SUCCESS (0.000s) [42.580788] [013/161] (954s left) gem_basic (create-fd-close) [42.634151] Starting subtest: create-fd-close [42.647092] Subtest create-fd-close: SUCCESS (0.000s) [42.737443] [014/161] (954s left) gem_busy (busy@all-engines) [42.800927] Starting subtest: busy [42.807014] Starting dynamic subtest: all-engines [42.826164] Dynamic subtest all-engines: SUCCESS (0.024s) [42.832787] Subtest busy: SUCCESS (0.024s) [43.230302] [015/161] (954s left) gem_close_race (basic-process) [43.290033] Starting subtest: basic-process [43.336360] Subtest basic-process: SUCCESS (0.051s) [43.539880] [016/161] (953s left) gem_close_race (basic-threads) [43.592242] Starting subtest: basic-threads [44.883513] Subtest basic-threads: SUCCESS (1.288s) [45.098652] [017/161] (952s left) gem_ctx_create (basic) [45.161351] Starting subtest: basic [45.169900] Subtest basic: SUCCESS (0.000s) [45.372398] [018/161] (952s left) gem_ctx_create (basic-files) [45.443755] Starting subtest: basic-files [47.465354] Subtest basic-files: SUCCESS (2.009s) [47.656936] [019/161] (950s left) gem_ctx_exec (basic) [47.747517] Starting subtest: basic [47.754425] Subtest basic: SUCCESS (0.003s) [47.885804] [020/161] (949s left) gem_exec_basic (basic) [47.954407] Starting subtest: basic [47.967630] Starting dynamic subtest: rcs0-smem [47.976404] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [48.004414] Starting dynamic subtest: bcs0-smem [48.017738] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [48.049769] Starting dynamic subtest: vcs0-smem [48.059874] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [48.076513] Starting dynamic subtest: vecs0-smem [48.093713] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [48.100026] Subtest basic: SUCCESS (0.002s) [48.177832] [021/161] (949s left) gem_exec_create (basic) [48.262043] Starting subtest: basic [48.270803] Starting dynamic subtest: smem [50.345574] Dynamic subtest smem: SUCCESS (2.080s) [50.358761] Subtest basic: SUCCESS (2.080s) [50.557559] [022/161] (947s left) gem_exec_fence (basic-busy) [50.758072] Starting subtest: basic-busy [50.766714] Starting dynamic subtest: rcs0 [50.839046] Dynamic subtest rcs0: SUCCESS (0.080s) [50.863920] Starting dynamic subtest: bcs0 [50.886855] Dynamic subtest bcs0: SUCCESS (0.049s) [50.901261] Starting dynamic subtest: vcs0 [50.921667] Dynamic subtest vcs0: SUCCESS (0.043s) [50.943826] Starting dynamic subtest: vecs0 [50.964675] Dynamic subtest vecs0: SUCCESS (0.043s) [50.971462] Subtest basic-busy: SUCCESS (0.217s) [51.458346] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [51.465017] [023/161] (946s left) gem_exec_fence (basic-wait) [51.627971] Starting subtest: basic-wait [51.634484] Starting dynamic subtest: rcs0 [51.683071] Dynamic subtest rcs0: SUCCESS (0.054s) [51.706396] Starting dynamic subtest: bcs0 [51.719993] Dynamic subtest bcs0: SUCCESS (0.037s) [51.743734] Starting dynamic subtest: vcs0 [51.760898] Dynamic subtest vcs0: SUCCESS (0.040s) [51.781716] Starting dynamic subtest: vecs0 [51.810946] Dynamic subtest vecs0: SUCCESS (0.049s) [51.817776] Subtest basic-wait: SUCCESS (0.183s) [52.290710] [024/161] (945s left) gem_exec_fence (basic-await) [52.478476] Starting subtest: basic-await [52.495098] Starting dynamic subtest: rcs0 [52.555226] Dynamic subtest rcs0: SUCCESS (0.074s) [52.578988] Starting dynamic subtest: bcs0 [52.627169] Dynamic subtest bcs0: SUCCESS (0.079s) [52.648449] Starting dynamic subtest: vcs0 [52.714339] Dynamic subtest vcs0: SUCCESS (0.079s) [52.738133] Starting dynamic subtest: vecs0 [52.799940] Dynamic subtest vecs0: SUCCESS (0.085s) [52.806789] Subtest basic-await: SUCCESS (0.320s) [53.248373] [025/161] (944s left) gem_exec_fence (nb-await) [53.432996] Starting subtest: nb-await [53.449505] Starting dynamic subtest: rcs0 [53.487419] Dynamic subtest rcs0: SUCCESS (0.058s) [53.521725] Starting dynamic subtest: bcs0 [53.545047] Dynamic subtest bcs0: SUCCESS (0.058s) [53.573140] Starting dynamic subtest: vcs0 [53.600593] Dynamic subtest vcs0: SUCCESS (0.061s) [53.632871] Starting dynamic subtest: vecs0 [53.664732] Dynamic subtest vecs0: SUCCESS (0.061s) [53.678143] Subtest nb-await: SUCCESS (0.240s) [54.145500] [026/161] (943s left) gem_exec_gttfill (basic) [54.232940] Starting subtest: basic [58.009846] Subtest basic: SUCCESS (3.772s) [58.186354] [027/161] (939s left) gem_exec_parallel (engines) [58.294308] Starting subtest: engines [58.300516] Starting dynamic subtest: basic [59.669100] Dynamic subtest basic: SUCCESS (1.394s) [59.694648] Starting dynamic subtest: contexts [61.248476] Dynamic subtest contexts: SUCCESS (1.567s) [61.267772] Starting dynamic subtest: fds [62.893572] Dynamic subtest fds: SUCCESS (1.652s) [62.913126] Starting dynamic subtest: userptr [64.299744] Dynamic subtest userptr: SUCCESS (1.406s) [64.305935] Subtest engines: SUCCESS (6.021s) [64.502850] [028/161] (933s left) gem_exec_store (basic) [64.623802] Starting subtest: basic [64.659116] Subtest basic: SUCCESS (0.080s) [64.868076] [029/161] (933s left) gem_flink_basic (bad-flink) [64.965156] Starting subtest: bad-flink [64.971902] Subtest bad-flink: SUCCESS (0.000s) [65.038934] [030/161] (933s left) gem_flink_basic (bad-open) [65.128251] Starting subtest: bad-open [65.135037] Subtest bad-open: SUCCESS (0.000s) [65.218653] [031/161] (933s left) gem_flink_basic (basic) [65.308075] Starting subtest: basic [65.314768] Subtest basic: SUCCESS (0.000s) [65.421244] [032/161] (932s left) gem_flink_basic (double-flink) [65.495281] Starting subtest: double-flink [65.511890] Subtest double-flink: SUCCESS (0.000s) [65.610854] [033/161] (932s left) gem_flink_basic (flink-lifetime) [65.697028] Starting subtest: flink-lifetime [65.710363] Subtest flink-lifetime: SUCCESS (0.001s) [65.804356] [034/161] (932s left) gem_huc_copy (huc-copy) [65.894097] Starting subtest: huc-copy [65.900785] Subtest huc-copy: SUCCESS (0.002s) [66.010057] [035/161] (932s left) gem_linear_blits (basic) [66.135283] Starting subtest: basic [66.157155] Subtest basic: SUCCESS (0.007s) [66.277905] [036/161] (932s left) gem_mmap (basic) [66.371850] Starting subtest: basic [66.434684] Subtest basic: SUCCESS (0.001s) [66.500852] [037/161] (932s left) gem_mmap_gtt (basic) [66.585073] Starting subtest: basic [66.593757] Subtest basic: SUCCESS (0.001s) [66.686649] [038/161] (932s left) gem_render_linear_blits (basic) [66.740839] Starting subtest: basic [66.773935] Subtest basic: SUCCESS (0.024s) [66.836168] [039/161] (931s left) gem_render_tiled_blits (basic) [66.893379] Starting subtest: basic [66.931748] Subtest basic: SUCCESS (0.042s) [67.218755] [040/161] (931s left) gem_ringfill (basic-all) [67.659253] Starting subtest: basic-all [68.786503] Subtest basic-all: SUCCESS (1.125s) [68.929058] [041/161] (929s left) gem_softpin (allocator-basic) [69.009296] Starting subtest: allocator-basic [69.048624] Subtest allocator-basic: SUCCESS (0.050s) [69.205232] [042/161] (929s left) gem_softpin (allocator-basic-reserve) [69.285108] Starting subtest: allocator-basic-reserve [69.322101] Subtest allocator-basic-reserve: SUCCESS (0.055s) [69.493866] [043/161] (929s left) gem_softpin (safe-alignment) [69.573846] Starting subtest: safe-alignment [69.587462] Subtest safe-alignment: SUCCESS (0.007s) [69.738644] [044/161] (929s left) gem_sync (basic-all) [69.895910] Starting subtest: basic-all [71.964582] Subtest basic-all: SUCCESS (2.157s) [72.170856] [045/161] (926s left) gem_sync (basic-each) [72.340793] Starting subtest: basic-each [74.317654] Subtest basic-each: SUCCESS (2.068s) [74.522058] [046/161] (924s left) gem_tiled_blits (basic) [74.632412] Starting subtest: basic [74.638702] Subtest basic: SUCCESS (0.009s) [74.797547] [047/161] (924s left) gem_tiled_fence_blits (basic) [74.945727] Starting subtest: basic [74.954487] Subtest basic: SUCCESS (0.012s) [75.096977] [048/161] (924s left) gem_tiled_pread_basic [75.303458] [049/161] (924s left) gem_wait (busy@all-engines) [75.396852] Starting subtest: busy [75.405596] Starting dynamic subtest: all-engines [75.941941] Dynamic subtest all-engines: SUCCESS (0.557s) [75.955222] Subtest busy: SUCCESS (0.558s) [76.168192] [050/161] (923s left) gem_wait (wait@all-engines) [76.242145] Starting subtest: wait [76.258676] Starting dynamic subtest: all-engines [77.288341] Dynamic subtest all-engines: SUCCESS (1.050s) [77.301855] Subtest wait: SUCCESS (1.050s) [77.551023] [051/161] (921s left) i915_getparams_basic (basic-eu-total) [77.630123] Starting subtest: basic-eu-total [77.655176] Subtest basic-eu-total: SUCCESS (0.000s) [77.729138] [052/161] (921s left) i915_getparams_basic (basic-subslice-total) [77.803495] Starting subtest: basic-subslice-total [77.826699] Subtest basic-subslice-total: SUCCESS (0.000s) [77.905660] [053/161] (921s left) i915_hangman (error-state-basic) [77.974068] Starting subtest: error-state-basic [78.060999] Subtest error-state-basic: SUCCESS (0.092s) [78.171832] [054/161] (921s left) i915_pciid [78.347341] [055/161] (921s left) kms_addfb_basic (addfb25-4-tiled) [78.485894] Starting subtest: addfb25-4-tiled [78.502527] Subtest addfb25-4-tiled: SUCCESS (0.000s) [78.624736] [056/161] (921s left) kms_addfb_basic (addfb25-bad-modifier) [78.766540] Starting subtest: addfb25-bad-modifier [78.772759] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [78.894393] [057/161] (920s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [79.034426] Starting subtest: addfb25-framebuffer-vs-set-tiling [79.051090] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.165853] [058/161] (920s left) kms_addfb_basic (addfb25-modifier-no-flag) [79.310309] Starting subtest: addfb25-modifier-no-flag [79.321905] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [79.434109] [059/161] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy) [79.578404] Starting subtest: addfb25-x-tiled-legacy [79.586534] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [79.723996] [060/161] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [79.879822] Starting subtest: addfb25-x-tiled-mismatch-legacy [79.886194] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [80.008718] [061/161] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [80.144835] Starting subtest: addfb25-yf-tiled-legacy [80.161352] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [80.249172] [062/161] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy) [80.387227] Starting subtest: addfb25-y-tiled-legacy [80.403737] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [80.489892] [063/161] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [80.633065] Starting subtest: addfb25-y-tiled-small-legacy [80.644725] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [80.750622] [064/161] (919s left) kms_addfb_basic (bad-pitch-0) [80.830805] Starting subtest: bad-pitch-0 [80.839413] Subtest bad-pitch-0: SUCCESS (0.000s) [81.021790] [065/161] (919s left) kms_addfb_basic (bad-pitch-1024) [81.095435] Starting subtest: bad-pitch-1024 [81.112057] Subtest bad-pitch-1024: SUCCESS (0.000s) [81.297287] [066/161] (919s left) kms_addfb_basic (bad-pitch-128) [81.386145] Starting subtest: bad-pitch-128 [81.396125] Subtest bad-pitch-128: SUCCESS (0.000s) [81.567044] [067/161] (918s left) kms_addfb_basic (bad-pitch-256) [81.641041] Starting subtest: bad-pitch-256 [81.657528] Subtest bad-pitch-256: SUCCESS (0.000s) [81.827347] [068/161] (918s left) kms_addfb_basic (bad-pitch-32) [81.887081] Starting subtest: bad-pitch-32 [81.893734] Subtest bad-pitch-32: SUCCESS (0.000s) [82.083927] [069/161] (918s left) kms_addfb_basic (bad-pitch-63) [82.142935] Starting subtest: bad-pitch-63 [82.149280] Subtest bad-pitch-63: SUCCESS (0.000s) [82.326726] [070/161] (918s left) kms_addfb_basic (bad-pitch-65536) [82.382666] Starting subtest: bad-pitch-65536 [82.388907] Subtest bad-pitch-65536: SUCCESS (0.000s) [82.557608] [071/161] (918s left) kms_addfb_basic (bad-pitch-999) [82.613020] Starting subtest: bad-pitch-999 [82.619775] Subtest bad-pitch-999: SUCCESS (0.000s) [82.806938] [072/161] (917s left) kms_addfb_basic (basic) [82.862398] Starting subtest: basic [82.869365] Subtest basic: SUCCESS (0.000s) [83.062066] [073/161] (917s left) kms_addfb_basic (basic-x-tiled-legacy) [83.116060] Starting subtest: basic-x-tiled-legacy [83.122570] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [83.311038] [074/161] (917s left) kms_addfb_basic (basic-y-tiled-legacy) [83.366541] Starting subtest: basic-y-tiled-legacy [83.373532] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [83.558731] [075/161] (917s left) kms_addfb_basic (bo-too-small) [83.690329] Starting subtest: bo-too-small [83.702471] Subtest bo-too-small: SUCCESS (0.000s) [83.827686] [076/161] (917s left) kms_addfb_basic (bo-too-small-due-to-tiling) [83.972596] Starting subtest: bo-too-small-due-to-tiling [83.989194] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [84.112672] [077/161] (916s left) kms_addfb_basic (clobberred-modifier) [84.201278] Starting subtest: clobberred-modifier [84.211015] Subtest clobberred-modifier: SUCCESS (0.000s) [84.418375] [078/161] (916s left) kms_addfb_basic (framebuffer-vs-set-tiling) [84.491963] Starting subtest: framebuffer-vs-set-tiling [84.506178] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.686035] [079/161] (916s left) kms_addfb_basic (invalid-get-prop) [84.761134] Starting subtest: invalid-get-prop [84.777591] Subtest invalid-get-prop: SUCCESS (0.000s) [84.961997] [080/161] (916s left) kms_addfb_basic (invalid-get-prop-any) [85.043781] Starting subtest: invalid-get-prop-any [85.052532] Subtest invalid-get-prop-any: SUCCESS (0.000s) [85.217668] [081/161] (915s left) kms_addfb_basic (invalid-set-prop) [85.271573] Starting subtest: invalid-set-prop [85.277892] Subtest invalid-set-prop: SUCCESS (0.000s) [85.461356] [082/161] (915s left) kms_addfb_basic (invalid-set-prop-any) [85.516668] Starting subtest: invalid-set-prop-any [85.522937] Subtest invalid-set-prop-any: SUCCESS (0.000s) [85.717925] [083/161] (915s left) kms_addfb_basic (no-handle) [85.771884] Starting subtest: no-handle [85.778159] Subtest no-handle: SUCCESS (0.000s) [85.989445] [084/161] (915s left) kms_addfb_basic (size-max) [86.120273] Starting subtest: size-max [86.126484] Subtest size-max: SUCCESS (0.000s) [86.257270] [085/161] (915s left) kms_addfb_basic (small-bo) [86.413150] Starting subtest: small-bo [86.426544] Subtest small-bo: SUCCESS (0.000s) [86.532150] [086/161] (914s left) kms_addfb_basic (tile-pitch-mismatch) [86.609615] Starting subtest: tile-pitch-mismatch [86.615870] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [86.782815] [087/161] (914s left) kms_addfb_basic (too-high) [86.911467] Starting subtest: too-high [86.927923] Subtest too-high: SUCCESS (0.001s) [87.014208] [088/161] (914s left) kms_addfb_basic (too-wide) [87.160937] Starting subtest: too-wide [87.169771] Subtest too-wide: SUCCESS (0.000s) [87.289497] [089/161] (914s left) kms_addfb_basic (unused-handle) [87.343948] Starting subtest: unused-handle [87.350135] Subtest unused-handle: SUCCESS (0.000s) [87.527824] [090/161] (914s left) kms_addfb_basic (unused-modifier) [87.585140] Starting subtest: unused-modifier [87.591790] Subtest unused-modifier: SUCCESS (0.000s) [87.795884] [091/161] (913s left) kms_addfb_basic (unused-offsets) [87.848819] Starting subtest: unused-offsets [87.855222] Subtest unused-offsets: SUCCESS (0.000s) [88.058344] [092/161] (913s left) kms_addfb_basic (unused-pitches) [88.135741] Starting subtest: unused-pitches [88.149048] Subtest unused-pitches: SUCCESS (0.000s) [88.317329] [093/161] (913s left) kms_busy (basic) [88.476110] Starting subtest: basic [88.482287] Starting dynamic subtest: flip [89.256895] Dynamic subtest flip: SUCCESS (0.784s) [89.273480] Starting dynamic subtest: modeset [90.056481] Dynamic subtest modeset: SUCCESS (0.808s) [90.062798] Subtest basic: SUCCESS (1.594s) [90.312094] [094/161] (911s left) kms_prop_blob (basic) [90.367917] Starting subtest: basic [90.374439] Subtest basic: SUCCESS (0.000s) [90.442024] [095/161] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [90.566726] Starting subtest: basic-busy-flip-before-cursor-atomic [90.578947] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [90.667430] [096/161] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [90.802571] Starting subtest: basic-busy-flip-before-cursor-legacy [90.825593] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [90.907579] [097/161] (911s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [91.047894] Starting subtest: basic-flip-after-cursor-atomic [92.058546] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.011s) [92.256776] [098/161] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [92.394049] Starting subtest: basic-flip-after-cursor-legacy [93.411893] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.018s) [93.639222] [099/161] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [93.776888] Starting subtest: basic-flip-after-cursor-varying-size [94.797134] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.021s) [94.994714] [100/161] (907s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [95.125793] Starting subtest: basic-flip-before-cursor-atomic [96.150978] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.020s) [96.360869] [101/161] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [96.482655] Starting subtest: basic-flip-before-cursor-legacy [97.496351] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.018s) [97.695594] [102/161] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [97.817846] Starting subtest: basic-flip-before-cursor-varying-size [98.844787] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.021s) [99.047862] [103/161] (903s left) kms_dsc (dsc-basic) [99.164386] Starting subtest: dsc-basic [99.229839] Subtest dsc-basic: SKIP (0.001s) [99.318101] [104/161] (902s left) kms_flip (basic-flip-vs-dpms) [99.459107] Starting subtest: basic-flip-vs-dpms [99.475516] Starting dynamic subtest: A-DP1 [100.364074] Dynamic subtest A-DP1: SUCCESS (0.922s) [100.383498] Starting dynamic subtest: B-DP1 [101.068615] Dynamic subtest B-DP1: SUCCESS (0.695s) [101.079431] Starting dynamic subtest: C-DP1 [101.758481] Dynamic subtest C-DP1: SUCCESS (0.689s) [101.769734] Starting dynamic subtest: D-DP1 [102.455904] Dynamic subtest D-DP1: SUCCESS (0.701s) [102.467080] Starting dynamic subtest: A-HDMI-A2 [103.173179] Dynamic subtest A-HDMI-A2: SUCCESS (0.712s) [103.190950] Starting dynamic subtest: B-HDMI-A2 [103.940166] Dynamic subtest B-HDMI-A2: SUCCESS (0.764s) [103.957669] Starting dynamic subtest: C-HDMI-A2 [104.705979] Dynamic subtest C-HDMI-A2: SUCCESS (0.769s) [104.716869] Starting dynamic subtest: D-HDMI-A2 [105.482541] Dynamic subtest D-HDMI-A2: SUCCESS (0.776s) [105.493979] Subtest basic-flip-vs-dpms: SUCCESS (6.042s) [105.729287] [105/161] (896s left) kms_flip (basic-flip-vs-modeset) [105.868947] Starting subtest: basic-flip-vs-modeset [105.885529] Starting dynamic subtest: A-DP1 [106.822854] Dynamic subtest A-DP1: SUCCESS (0.959s) [106.846074] Starting dynamic subtest: B-DP1 [107.534063] Dynamic subtest B-DP1: SUCCESS (0.717s) [107.550690] Starting dynamic subtest: C-DP1 [108.261793] Dynamic subtest C-DP1: SUCCESS (0.725s) [108.278407] Starting dynamic subtest: D-DP1 [108.974102] Dynamic subtest D-DP1: SUCCESS (0.713s) [108.990722] Starting dynamic subtest: A-HDMI-A2 [109.721880] Dynamic subtest A-HDMI-A2: SUCCESS (0.740s) [109.733031] Starting dynamic subtest: B-HDMI-A2 [110.392221] Dynamic subtest B-HDMI-A2: SUCCESS (0.667s) [110.403153] Starting dynamic subtest: C-HDMI-A2 [111.055395] Dynamic subtest C-HDMI-A2: SUCCESS (0.665s) [111.066695] Starting dynamic subtest: D-HDMI-A2 [111.734321] Dynamic subtest D-HDMI-A2: SUCCESS (0.669s) [111.743148] Subtest basic-flip-vs-modeset: SUCCESS (5.872s) [111.940162] [106/161] (890s left) kms_flip (basic-flip-vs-wf_vblank) [112.099440] Starting subtest: basic-flip-vs-wf_vblank [112.105633] Starting dynamic subtest: A-DP1 [113.239891] Dynamic subtest A-DP1: SUCCESS (1.153s) [113.256815] Starting dynamic subtest: B-DP1 [114.262624] Dynamic subtest B-DP1: SUCCESS (1.031s) [114.273578] Starting dynamic subtest: C-DP1 [115.297654] Dynamic subtest C-DP1: SUCCESS (1.031s) [115.309175] Starting dynamic subtest: D-DP1 [116.333092] Dynamic subtest D-DP1: SUCCESS (1.033s) [116.344087] Starting dynamic subtest: A-HDMI-A2 [117.372226] Dynamic subtest A-HDMI-A2: SUCCESS (1.038s) [117.387126] Starting dynamic subtest: B-HDMI-A2 [118.394082] Dynamic subtest B-HDMI-A2: SUCCESS (1.014s) [118.405611] Starting dynamic subtest: C-HDMI-A2 [119.432409] Dynamic subtest C-HDMI-A2: SUCCESS (1.021s) [119.443654] Starting dynamic subtest: D-HDMI-A2 [120.440378] Dynamic subtest D-HDMI-A2: SUCCESS (1.019s) [120.450106] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.362s) [120.750071] [107/161] (881s left) kms_flip (basic-plain-flip) [120.903622] Starting subtest: basic-plain-flip [120.909866] Starting dynamic subtest: A-DP1 [121.766517] Dynamic subtest A-DP1: SUCCESS (0.885s) [121.785811] Starting dynamic subtest: B-DP1 [122.534948] Dynamic subtest B-DP1: SUCCESS (0.762s) [122.545714] Starting dynamic subtest: C-DP1 [123.303434] Dynamic subtest C-DP1: SUCCESS (0.763s) [123.314785] Starting dynamic subtest: D-DP1 [124.050949] Dynamic subtest D-DP1: SUCCESS (0.750s) [124.062185] Starting dynamic subtest: A-HDMI-A2 [124.838212] Dynamic subtest A-HDMI-A2: SUCCESS (0.787s) [124.855708] Starting dynamic subtest: B-HDMI-A2 [125.591588] Dynamic subtest B-HDMI-A2: SUCCESS (0.752s) [125.603834] Starting dynamic subtest: C-HDMI-A2 [126.341790] Dynamic subtest C-HDMI-A2: SUCCESS (0.748s) [126.355184] Starting dynamic subtest: D-HDMI-A2 [127.096597] Dynamic subtest D-HDMI-A2: SUCCESS (0.753s) [127.102872] Subtest basic-plain-flip: SUCCESS (6.221s) [127.443035] [108/161] (875s left) kms_force_connector_basic (force-connector-state) [127.576608] Starting subtest: force-connector-state [128.070360] Subtest force-connector-state: SUCCESS (0.499s) [128.454155] [109/161] (874s left) kms_force_connector_basic (force-edid) [128.595804] Starting subtest: force-edid [128.635585] Subtest force-edid: SUCCESS (0.030s) [128.924101] [110/161] (873s left) kms_force_connector_basic (force-load-detect) [129.061614] Starting subtest: force-load-detect [129.084187] Subtest force-load-detect: SKIP (0.000s) [129.286316] [111/161] (873s left) kms_force_connector_basic (prune-stale-modes) [129.424725] Starting subtest: prune-stale-modes [129.464525] Subtest prune-stale-modes: SUCCESS (0.031s) [129.775104] [112/161] (872s left) kms_frontbuffer_tracking (basic) [129.954073] Starting subtest: basic [133.884198] Subtest basic: SUCCESS (3.971s) [134.088562] [113/161] (868s left) kms_hdmi_inject (inject-audio) [134.322764] Starting subtest: inject-audio [134.449773] Subtest inject-audio: SUCCESS (0.128s) [134.767685] [114/161] (868s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [134.909297] Starting subtest: compare-crc-sanitycheck-xr24 [134.920829] Starting dynamic subtest: pipe-A-DP-1 [135.538317] Dynamic subtest pipe-A-DP-1: SUCCESS (0.639s) [135.554817] Starting dynamic subtest: pipe-B-HDMI-A-2 [135.939048] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.384s) [135.956798] Starting dynamic subtest: pipe-C-DP-1 [136.345761] Dynamic subtest pipe-C-DP-1: SUCCESS (0.406s) [136.362436] Starting dynamic subtest: pipe-D-DP-1 [136.753470] Dynamic subtest pipe-D-DP-1: SUCCESS (0.413s) [136.759621] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.854s) [136.995643] [115/161] (865s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [137.128947] Starting subtest: compare-crc-sanitycheck-nv12 [137.139300] Starting dynamic subtest: pipe-A-DP-1 [137.889494] Dynamic subtest pipe-A-DP-1: SUCCESS (0.761s) [137.906024] Starting dynamic subtest: pipe-B-HDMI-A-2 [138.415722] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.523s) [138.432276] Starting dynamic subtest: pipe-C-DP-1 [138.927471] Dynamic subtest pipe-C-DP-1: SUCCESS (0.513s) [138.938822] Starting dynamic subtest: pipe-D-DP-1 [139.441639] Dynamic subtest pipe-D-DP-1: SUCCESS (0.512s) [139.450375] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.320s) [139.672914] [116/161] (863s left) kms_pipe_crc_basic (hang-read-crc) [139.810864] Starting subtest: hang-read-crc [139.824290] Starting dynamic subtest: pipe-A-DP-1 [141.201307] Dynamic subtest pipe-A-DP-1: SUCCESS (1.389s) [141.223132] Starting dynamic subtest: pipe-B-HDMI-A-2 [142.292145] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.091s) [142.303693] Starting dynamic subtest: pipe-C-DP-1 [143.427015] Dynamic subtest pipe-C-DP-1: SUCCESS (1.123s) [143.443625] Starting dynamic subtest: pipe-D-DP-1 [144.570627] Dynamic subtest pipe-D-DP-1: SUCCESS (1.148s) [144.576813] Subtest hang-read-crc: SUCCESS (4.762s) [144.759163] [117/161] (858s left) kms_pipe_crc_basic (nonblocking-crc) [144.907473] Starting subtest: nonblocking-crc [144.916230] Starting dynamic subtest: pipe-A-DP-1 [145.734064] Dynamic subtest pipe-A-DP-1: SUCCESS (0.833s) [145.745431] Starting dynamic subtest: pipe-B-HDMI-A-2 [146.305835] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.568s) [146.325350] Starting dynamic subtest: pipe-C-DP-1 [146.914392] Dynamic subtest pipe-C-DP-1: SUCCESS (0.598s) [146.936187] Starting dynamic subtest: pipe-D-DP-1 [147.495978] Dynamic subtest pipe-D-DP-1: SUCCESS (0.592s) [147.512580] Subtest nonblocking-crc: SUCCESS (2.602s) [147.681694] [118/161] (855s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [147.823983] Starting subtest: nonblocking-crc-frame-sequence [147.840463] Starting dynamic subtest: pipe-A-DP-1 [148.674355] Dynamic subtest pipe-A-DP-1: SUCCESS (0.857s) [148.688344] Starting dynamic subtest: pipe-B-HDMI-A-2 [149.261343] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.587s) [149.274967] Starting dynamic subtest: pipe-C-DP-1 [149.882382] Dynamic subtest pipe-C-DP-1: SUCCESS (0.609s) [149.904386] Starting dynamic subtest: pipe-D-DP-1 [150.454807] Dynamic subtest pipe-D-DP-1: SUCCESS (0.577s) [150.463511] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.642s) [150.647039] [119/161] (852s left) kms_pipe_crc_basic (read-crc) [150.798361] Starting subtest: read-crc [150.804487] Starting dynamic subtest: pipe-A-DP-1 [151.573441] Dynamic subtest pipe-A-DP-1: SUCCESS (0.775s) [151.591294] Starting dynamic subtest: pipe-B-HDMI-A-2 [152.077009] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.504s) [152.098936] Starting dynamic subtest: pipe-C-DP-1 [152.599406] Dynamic subtest pipe-C-DP-1: SUCCESS (0.518s) [152.621294] Starting dynamic subtest: pipe-D-DP-1 [153.109142] Dynamic subtest pipe-D-DP-1: SUCCESS (0.510s) [153.117848] Subtest read-crc: SUCCESS (2.318s) [153.286511] [120/161] (849s left) kms_pipe_crc_basic (read-crc-frame-sequence) [153.424832] Starting subtest: read-crc-frame-sequence [153.441420] Starting dynamic subtest: pipe-A-DP-1 [154.188740] Dynamic subtest pipe-A-DP-1: SUCCESS (0.769s) [154.199754] Starting dynamic subtest: pipe-B-HDMI-A-2 [154.716495] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.522s) [154.738249] Starting dynamic subtest: pipe-C-DP-1 [155.246099] Dynamic subtest pipe-C-DP-1: SUCCESS (0.521s) [155.262586] Starting dynamic subtest: pipe-D-DP-1 [155.774022] Dynamic subtest pipe-D-DP-1: SUCCESS (0.526s) [155.780309] Subtest read-crc-frame-sequence: SUCCESS (2.349s) [155.946051] [121/161] (847s left) kms_pm_backlight (basic-brightness) [156.104220] Subtest basic-brightness: SKIP (0.000s) [156.173331] [122/161] (847s left) kms_pm_rpm (basic-pci-d3-state) [157.668572] Starting subtest: basic-pci-d3-state [157.986821] Subtest basic-pci-d3-state: SUCCESS (0.315s) [158.254234] [123/161] (845s left) kms_pm_rpm (basic-rte) [158.317762] Starting subtest: basic-rte [160.074538] Subtest basic-rte: SUCCESS (1.761s) [160.624570] [124/161] (842s left) kms_psr (psr-primary-page-flip) [160.787427] Subtest psr-primary-page-flip: SKIP (0.000s) [160.860342] [125/161] (842s left) kms_psr (psr-cursor-plane-move) [161.021094] Subtest psr-cursor-plane-move: SKIP (0.000s) [161.104394] [126/161] (842s left) kms_psr (psr-sprite-plane-onoff) [161.262773] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [161.345036] [127/161] (842s left) kms_psr (psr-primary-mmap-gtt) [161.500293] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [161.556305] [128/161] (842s left) kms_setmode (basic-clone-single-crtc) [161.613567] Starting subtest: basic-clone-single-crtc [161.819179] Subtest basic-clone-single-crtc: SKIP (0.204s) [162.037736] [129/161] (841s left) i915_pm_rps (basic-api) [162.094781] Starting subtest: basic-api [162.101099] Subtest basic-api: SUCCESS (0.001s) [162.179591] [130/161] (841s left) prime_self_import (basic-llseek-bad) [162.229680] Starting subtest: basic-llseek-bad [162.242319] Subtest basic-llseek-bad: SUCCESS (0.001s) [162.374253] [131/161] (841s left) prime_self_import (basic-llseek-size) [162.438867] Starting subtest: basic-llseek-size [162.462112] Subtest basic-llseek-size: SUCCESS (0.003s) [162.586221] [132/161] (841s left) prime_self_import (basic-with_fd_dup) [162.672952] Starting subtest: basic-with_fd_dup [162.696222] Subtest basic-with_fd_dup: SUCCESS (0.003s) [162.837578] [133/161] (841s left) prime_self_import (basic-with_one_bo) [162.903651] Starting subtest: basic-with_one_bo [162.925739] Subtest basic-with_one_bo: SUCCESS (0.004s) [163.039847] [134/161] (841s left) prime_self_import (basic-with_one_bo_two_files) [163.115820] Starting subtest: basic-with_one_bo_two_files [163.135930] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [163.241985] [135/161] (840s left) prime_self_import (basic-with_two_bos) [163.310478] Starting subtest: basic-with_two_bos [163.332656] Subtest basic-with_two_bos: SUCCESS (0.005s) [163.440985] [136/161] (840s left) prime_vgem (basic-fence-flip) [163.554291] Starting subtest: basic-fence-flip [164.037830] Subtest basic-fence-flip: SUCCESS (0.486s) [164.201650] [137/161] (840s left) prime_vgem (basic-fence-mmap) [164.307833] Starting subtest: basic-fence-mmap [164.330304] Subtest basic-fence-mmap: SUCCESS (0.021s) [164.492478] [138/161] (839s left) prime_vgem (basic-fence-read) [164.610924] Starting subtest: basic-fence-read [164.632943] Subtest basic-fence-read: SKIP (0.007s) [164.762128] [139/161] (839s left) prime_vgem (basic-gtt) [164.871240] Starting subtest: basic-gtt [164.877860] Subtest basic-gtt: SUCCESS (0.007s) [165.041431] [140/161] (839s left) prime_vgem (basic-read) [165.145953] Starting subtest: basic-read [165.174093] Subtest basic-read: SKIP (0.007s) [165.357983] [141/161] (839s left) prime_vgem (basic-write) [165.469084] Starting subtest: basic-write [165.492322] Subtest basic-write: SKIP (0.007s) [165.600332] [142/161] (838s left) vgem_basic (setversion) [165.696401] Starting subtest: setversion [165.716064] Subtest setversion: SUCCESS (0.000s) [165.789231] [143/161] (838s left) vgem_basic (create) [165.868655] Starting subtest: create [165.875522] Subtest create: SUCCESS (0.000s) [165.954216] [144/161] (838s left) vgem_basic (debugfs) [166.034634] Starting subtest: debugfs [166.041671] Subtest debugfs: SUCCESS (0.001s) [166.109180] [145/161] (838s left) vgem_basic (dmabuf-export) [166.174470] Starting subtest: dmabuf-export [166.189165] Subtest dmabuf-export: SUCCESS (0.014s) [166.318244] [146/161] (838s left) vgem_basic (dmabuf-fence) [166.397093] Starting subtest: dmabuf-fence [166.403806] Subtest dmabuf-fence: SUCCESS (0.001s) [166.477252] [147/161] (838s left) vgem_basic (dmabuf-fence-before) [166.557430] Starting subtest: dmabuf-fence-before [166.564894] Subtest dmabuf-fence-before: SUCCESS (0.000s) [166.621348] [148/161] (838s left) vgem_basic (dmabuf-mmap) [166.691961] Starting subtest: dmabuf-mmap [166.699130] Subtest dmabuf-mmap: SUCCESS (0.009s) [166.778936] [149/161] (838s left) vgem_basic (mmap) [166.850394] Starting subtest: mmap [166.866775] Subtest mmap: SUCCESS (0.009s) [166.924013] [150/161] (838s left) vgem_basic (second-client) [167.026352] Starting subtest: second-client [167.048321] Subtest second-client: SUCCESS (0.034s) [167.128982] [151/161] (837s left) vgem_basic (sysfs) [167.201432] Starting subtest: sysfs [167.210244] Subtest sysfs: SUCCESS (0.000s) [167.267812] [152/161] (837s left) core_hotunplug (unbind-rebind) [167.390544] Starting subtest: unbind-rebind [170.885139] Subtest unbind-rebind: SUCCESS (3.485s) [170.963985] [153/161] (834s left) vgem_basic (unload) [171.033144] Starting subtest: unload [200.230749] Subtest unload: SUCCESS (29.181s) [200.350331] [154/161] (804s left) i915_module_load (reload) [200.419526] Starting subtest: reload [202.717930] Subtest reload: SUCCESS (2.309s) [202.804748] [155/161] (802s left) gem_lmem_swapping (basic) [202.894560] Subtest basic: SKIP (0.000s) [202.956434] [156/161] (802s left) gem_lmem_swapping (parallel-random-engines) [203.037146] Subtest parallel-random-engines: SKIP (0.000s) [203.112938] [157/161] (802s left) gem_lmem_swapping (random-engines) [203.203398] Subtest random-engines: SKIP (0.000s) [203.283347] [158/161] (802s left) gem_lmem_swapping (verify-random) [203.373968] Subtest verify-random: SKIP (0.000s) [203.448524] [159/161] (802s left) i915_pm_rpm (module-reload) [205.133441] Starting subtest: module-reload [217.279667] Killing the test because the kernel is tainted. [337.945180] Timeout. Killing the current test with SIGKILL. [338.946742] Child refuses to die, tainted 0x2e0. Aborting. [338.959921] Closing watchdogs