[27.080494] Initializing watchdogs [27.080658] /dev/watchdog0 [27.100404] [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] [27.116733] [001/162] (960s left) i915_module_load (load) [27.190206] Starting subtest: load [28.305619] Subtest load: SUCCESS (1.116s) [28.363761] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [28.364461] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [28.377877] [002/162] (959s left) core_auth (basic-auth) [28.467388] Starting subtest: basic-auth [28.477247] Subtest basic-auth: SUCCESS (0.001s) [28.549852] [003/162] (959s left) core_debugfs (read-all-entries) [28.630039] Starting subtest: read-all-entries [28.695867] Subtest read-all-entries: SUCCESS (0.079s) [28.841673] [004/162] (958s left) core_sysfs (read-all-entries) [28.921479] Starting subtest: read-all-entries [28.930117] Subtest read-all-entries: SUCCESS (0.003s) [29.005236] [005/162] (958s left) fbdev (eof) [29.076112] Starting subtest: eof [29.089392] Subtest eof: SUCCESS (0.002s) [29.184105] [006/162] (958s left) fbdev (info) [29.247467] Starting subtest: info [29.260845] Subtest info: SUCCESS (0.000s) [29.336467] [007/162] (958s left) fbdev (nullptr) [29.411073] Starting subtest: nullptr [29.427645] Subtest nullptr: SUCCESS (0.000s) [29.515819] [008/162] (958s left) fbdev (read) [29.581077] Starting subtest: read [31.193273] Subtest read: SUCCESS (1.609s) [31.268951] [009/162] (956s left) fbdev (write) [31.337658] Starting subtest: write [32.436518] Subtest write: SUCCESS (1.093s) [32.516623] [010/162] (955s left) gem_basic (bad-close) [32.584471] Starting subtest: bad-close [32.607623] Subtest bad-close: SUCCESS (0.000s) [32.675368] [011/162] (955s left) gem_basic (create-close) [32.731604] Starting subtest: create-close [32.757919] Subtest create-close: SUCCESS (0.000s) [32.842619] [012/162] (955s left) gem_basic (create-fd-close) [32.926916] Starting subtest: create-fd-close [32.950141] Subtest create-fd-close: SUCCESS (0.000s) [33.055097] [013/162] (955s left) gem_busy (busy@all-engines) [33.126626] Starting subtest: busy [33.143026] Starting dynamic subtest: all-engines [33.149227] Dynamic subtest all-engines: SUCCESS (0.018s) [33.165802] Subtest busy: SUCCESS (0.018s) [33.529463] [014/162] (954s left) gem_close_race (basic-process) [33.610120] Starting subtest: basic-process [33.656143] Subtest basic-process: SUCCESS (0.058s) [33.878528] [015/162] (954s left) gem_close_race (basic-threads) [33.954720] Starting subtest: basic-threads [35.218643] Subtest basic-threads: SUCCESS (1.264s) [35.416340] [016/162] (953s left) gem_ctx_create (basic) [35.488175] Starting subtest: basic [35.504720] Subtest basic: SUCCESS (0.000s) [35.692430] [017/162] (952s left) gem_ctx_create (basic-files) [35.779465] Starting subtest: basic-files [37.782566] Subtest basic-files: SUCCESS (2.007s) [38.022463] [018/162] (950s left) gem_ctx_exec (basic) [38.109617] Starting subtest: basic [38.116302] Subtest basic: SUCCESS (0.005s) [38.246777] [019/162] (950s left) gem_exec_basic (basic) [38.317603] Starting subtest: basic [38.330716] Starting dynamic subtest: rcs0-smem [38.339542] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [38.374226] Starting dynamic subtest: bcs0-smem [38.380905] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [38.406100] Starting dynamic subtest: vcs0-smem [38.419544] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [38.443867] Starting dynamic subtest: vecs0-smem [38.453548] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [38.467062] Subtest basic: SUCCESS (0.002s) [38.534190] [020/162] (950s left) gem_exec_create (basic) [38.624183] Starting subtest: basic [38.630837] Starting dynamic subtest: smem [40.677264] Dynamic subtest smem: SUCCESS (2.064s) [40.693857] Subtest basic: SUCCESS (2.064s) [40.889193] [021/162] (947s left) gem_exec_fence (basic-busy) [41.063160] Starting subtest: basic-busy [41.079549] Starting dynamic subtest: rcs0 [41.130213] Dynamic subtest rcs0: SUCCESS (0.068s) [41.165540] Starting dynamic subtest: bcs0 [41.188950] Dynamic subtest bcs0: SUCCESS (0.042s) [41.219160] Starting dynamic subtest: vcs0 [41.242351] Dynamic subtest vcs0: SUCCESS (0.049s) [41.271135] Starting dynamic subtest: vecs0 [41.291592] Dynamic subtest vecs0: SUCCESS (0.041s) [41.299918] Subtest basic-busy: SUCCESS (0.203s) [41.753517] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [41.767167] [022/162] (947s left) gem_exec_fence (basic-wait) [41.961265] Starting subtest: basic-wait [41.977883] Starting dynamic subtest: rcs0 [42.030352] Dynamic subtest rcs0: SUCCESS (0.078s) [42.045082] Starting dynamic subtest: bcs0 [42.081838] Dynamic subtest bcs0: SUCCESS (0.054s) [42.106476] Starting dynamic subtest: vcs0 [42.125850] Dynamic subtest vcs0: SUCCESS (0.043s) [42.148136] Starting dynamic subtest: vecs0 [42.164876] Dynamic subtest vecs0: SUCCESS (0.038s) [42.171645] Subtest basic-wait: SUCCESS (0.216s) [42.660465] [023/162] (946s left) gem_exec_fence (basic-await) [42.826790] Starting subtest: basic-await [42.833284] Starting dynamic subtest: rcs0 [42.903989] Dynamic subtest rcs0: SUCCESS (0.075s) [42.918936] Starting dynamic subtest: bcs0 [42.983878] Dynamic subtest bcs0: SUCCESS (0.073s) [42.998234] Starting dynamic subtest: vcs0 [43.061177] Dynamic subtest vcs0: SUCCESS (0.075s) [43.078969] Starting dynamic subtest: vecs0 [43.130411] Dynamic subtest vecs0: SUCCESS (0.076s) [43.143908] Subtest basic-await: SUCCESS (0.302s) [43.615562] [024/162] (945s left) gem_exec_fence (nb-await) [43.804249] Starting subtest: nb-await [43.812958] Starting dynamic subtest: rcs0 [43.865824] Dynamic subtest rcs0: SUCCESS (0.063s) [43.896459] Starting dynamic subtest: bcs0 [43.919590] Dynamic subtest bcs0: SUCCESS (0.058s) [43.947701] Starting dynamic subtest: vcs0 [43.979205] Dynamic subtest vcs0: SUCCESS (0.062s) [44.006986] Starting dynamic subtest: vecs0 [44.037964] Dynamic subtest vecs0: SUCCESS (0.058s) [44.051351] Subtest nb-await: SUCCESS (0.244s) [44.532400] [025/162] (944s left) gem_exec_gttfill (basic) [44.607429] Starting subtest: basic [46.860946] Subtest basic: SUCCESS (2.255s) [47.096425] [026/162] (942s left) gem_exec_parallel (engines) [47.211338] Starting subtest: engines [47.224842] Starting dynamic subtest: basic [48.594177] Dynamic subtest basic: SUCCESS (1.383s) [48.616248] Starting dynamic subtest: contexts [50.309790] Dynamic subtest contexts: SUCCESS (1.703s) [50.329011] Starting dynamic subtest: fds [51.913867] Dynamic subtest fds: SUCCESS (1.620s) [51.926334] Starting dynamic subtest: userptr [53.260794] Dynamic subtest userptr: SUCCESS (1.341s) [53.269619] Subtest engines: SUCCESS (6.048s) [53.475061] [027/162] (935s left) gem_exec_store (basic) [53.585614] Starting subtest: basic [53.617481] Subtest basic: SUCCESS (0.082s) [53.840281] [028/162] (935s left) gem_flink_basic (bad-flink) [53.904766] Starting subtest: bad-flink [53.911703] Subtest bad-flink: SUCCESS (0.000s) [53.987875] [029/162] (935s left) gem_flink_basic (bad-open) [54.052297] Starting subtest: bad-open [54.068771] Subtest bad-open: SUCCESS (0.000s) [54.145705] [030/162] (935s left) gem_flink_basic (basic) [54.221906] Starting subtest: basic [54.235241] Subtest basic: SUCCESS (0.000s) [54.327109] [031/162] (935s left) gem_flink_basic (double-flink) [54.394812] Starting subtest: double-flink [54.401524] Subtest double-flink: SUCCESS (0.000s) [54.550792] [032/162] (935s left) gem_flink_basic (flink-lifetime) [54.621532] Starting subtest: flink-lifetime [54.632949] Subtest flink-lifetime: SUCCESS (0.003s) [54.747609] [033/162] (934s left) gem_huc_copy (huc-copy) [54.826247] Starting subtest: huc-copy [54.839598] Subtest huc-copy: SUCCESS (0.002s) [54.953215] [034/162] (934s left) gem_linear_blits (basic) [55.065969] Starting subtest: basic [55.076510] Subtest basic: SUCCESS (0.005s) [55.227258] [035/162] (934s left) gem_mmap (basic) [55.332084] Starting subtest: basic [55.388458] Subtest basic: SUCCESS (0.001s) [55.458936] [036/162] (934s left) gem_mmap_gtt (basic) [55.531257] Starting subtest: basic [55.547628] Subtest basic: SUCCESS (0.001s) [55.628742] [037/162] (934s left) gem_render_linear_blits (basic) [55.690274] Starting subtest: basic [55.751842] Subtest basic: SUCCESS (0.022s) [55.813177] [038/162] (934s left) gem_render_tiled_blits (basic) [55.879095] Starting subtest: basic [55.944800] Subtest basic: SUCCESS (0.017s) [56.012192] [039/162] (934s left) gem_ringfill (basic-all) [56.265986] Starting subtest: basic-all [57.382195] Subtest basic-all: SUCCESS (1.110s) [57.539771] [040/162] (932s left) gem_softpin (allocator-basic) [57.628991] Starting subtest: allocator-basic [57.672646] Subtest allocator-basic: SUCCESS (0.057s) [57.830644] [041/162] (932s left) gem_softpin (allocator-basic-reserve) [57.920179] Starting subtest: allocator-basic-reserve [57.948118] Subtest allocator-basic-reserve: SUCCESS (0.054s) [58.130669] [042/162] (932s left) gem_softpin (safe-alignment) [58.222475] Starting subtest: safe-alignment [58.229338] Subtest safe-alignment: SUCCESS (0.009s) [58.355205] [043/162] (932s left) gem_sync (basic-all) [58.511499] Starting subtest: basic-all [60.459560] Subtest basic-all: SUCCESS (2.042s) [60.673890] [044/162] (929s left) gem_sync (basic-each) [60.836797] Starting subtest: basic-each [62.814297] Subtest basic-each: SUCCESS (2.071s) [63.016175] [045/162] (927s left) gem_tiled_blits (basic) [63.158986] Starting subtest: basic [63.165284] Subtest basic: SUCCESS (0.008s) [63.332087] [046/162] (927s left) gem_tiled_fence_blits (basic) [63.476978] Starting subtest: basic [63.485758] Subtest basic: SUCCESS (0.012s) [63.668936] [047/162] (926s left) gem_tiled_pread_basic [63.852548] [048/162] (926s left) gem_wait (busy@all-engines) [63.911151] Starting subtest: busy [63.917340] Starting dynamic subtest: all-engines [64.422543] Dynamic subtest all-engines: SUCCESS (0.520s) [64.428740] Subtest busy: SUCCESS (0.520s) [64.662418] [049/162] (926s left) gem_wait (wait@all-engines) [64.719451] Starting subtest: wait [64.725545] Starting dynamic subtest: all-engines [65.747216] Dynamic subtest all-engines: SUCCESS (1.023s) [65.754369] Subtest wait: SUCCESS (1.023s) [65.964867] [050/162] (924s left) i915_getparams_basic (basic-eu-total) [66.045098] Starting subtest: basic-eu-total [66.060173] Subtest basic-eu-total: SUCCESS (0.000s) [66.122815] [051/162] (924s left) i915_getparams_basic (basic-subslice-total) [66.205559] Starting subtest: basic-subslice-total [66.227458] Subtest basic-subslice-total: SUCCESS (0.000s) [66.301413] [052/162] (924s left) i915_hangman (error-state-basic) [66.371082] Starting subtest: error-state-basic [66.458159] Subtest error-state-basic: SUCCESS (0.090s) [66.556159] [053/162] (924s left) i915_pciid [66.704593] [054/162] (924s left) intel_hwmon (hwmon-read) [66.777918] Subtest hwmon-read: SKIP (0.000s) [66.840349] [055/162] (924s left) intel_hwmon (hwmon-write) [66.930866] Subtest hwmon-write: SKIP (0.000s) [67.013154] [056/162] (924s left) kms_addfb_basic (addfb25-4-tiled) [67.216363] Starting subtest: addfb25-4-tiled [67.232958] Subtest addfb25-4-tiled: SUCCESS (0.000s) [67.412734] [057/162] (923s left) kms_addfb_basic (addfb25-bad-modifier) [67.539970] Starting subtest: addfb25-bad-modifier [67.546168] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [67.766473] [058/162] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [67.888638] Starting subtest: addfb25-framebuffer-vs-set-tiling [67.896412] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [68.002178] [059/162] (923s left) kms_addfb_basic (addfb25-modifier-no-flag) [68.123207] Starting subtest: addfb25-modifier-no-flag [68.130091] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [68.246318] [060/162] (923s left) kms_addfb_basic (addfb25-x-tiled-legacy) [68.361652] Starting subtest: addfb25-x-tiled-legacy [68.367782] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [68.471614] [061/162] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [68.584971] Starting subtest: addfb25-x-tiled-mismatch-legacy [68.594127] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [68.720723] [062/162] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [68.843173] Starting subtest: addfb25-yf-tiled-legacy [68.854282] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [68.978412] [063/162] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy) [69.097851] Starting subtest: addfb25-y-tiled-legacy [69.107112] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [69.246772] [064/162] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [69.365255] Starting subtest: addfb25-y-tiled-small-legacy [69.376956] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [69.498296] [065/162] (922s left) kms_addfb_basic (bad-pitch-0) [69.559323] Starting subtest: bad-pitch-0 [69.565523] Subtest bad-pitch-0: SUCCESS (0.000s) [69.755501] [066/162] (921s left) kms_addfb_basic (bad-pitch-1024) [69.816959] Starting subtest: bad-pitch-1024 [69.833433] Subtest bad-pitch-1024: SUCCESS (0.000s) [70.006521] [067/162] (921s left) kms_addfb_basic (bad-pitch-128) [70.077127] Starting subtest: bad-pitch-128 [70.083115] Subtest bad-pitch-128: SUCCESS (0.000s) [70.252083] [068/162] (921s left) kms_addfb_basic (bad-pitch-256) [70.338701] Starting subtest: bad-pitch-256 [70.344771] Subtest bad-pitch-256: SUCCESS (0.000s) [70.520745] [069/162] (921s left) kms_addfb_basic (bad-pitch-32) [70.583677] Starting subtest: bad-pitch-32 [70.600178] Subtest bad-pitch-32: SUCCESS (0.000s) [70.788981] [070/162] (921s left) kms_addfb_basic (bad-pitch-63) [70.876556] Starting subtest: bad-pitch-63 [70.882764] Subtest bad-pitch-63: SUCCESS (0.000s) [71.051810] [071/162] (921s left) kms_addfb_basic (bad-pitch-65536) [71.121842] Starting subtest: bad-pitch-65536 [71.138400] Subtest bad-pitch-65536: SUCCESS (0.000s) [71.289745] [072/162] (920s left) kms_addfb_basic (bad-pitch-999) [71.361217] Starting subtest: bad-pitch-999 [71.377660] Subtest bad-pitch-999: SUCCESS (0.000s) [71.553364] [073/162] (920s left) kms_addfb_basic (basic) [71.603789] Starting subtest: basic [71.610078] Subtest basic: SUCCESS (0.000s) [71.823786] [074/162] (920s left) kms_addfb_basic (basic-x-tiled-legacy) [71.895332] Starting subtest: basic-x-tiled-legacy [71.911727] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [72.090537] [075/162] (920s left) kms_addfb_basic (basic-y-tiled-legacy) [72.160827] Starting subtest: basic-y-tiled-legacy [72.171191] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [72.366186] [076/162] (920s left) kms_addfb_basic (bo-too-small) [72.492013] Starting subtest: bo-too-small [72.508508] Subtest bo-too-small: SUCCESS (0.000s) [72.641505] [077/162] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling) [72.780368] Starting subtest: bo-too-small-due-to-tiling [72.795814] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [72.944561] [078/162] (919s left) kms_addfb_basic (clobberred-modifier) [73.035213] Starting subtest: clobberred-modifier [73.041449] Subtest clobberred-modifier: SUCCESS (0.000s) [73.211825] [079/162] (919s left) kms_addfb_basic (framebuffer-vs-set-tiling) [73.276490] Starting subtest: framebuffer-vs-set-tiling [73.282703] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [73.484663] [080/162] (919s left) kms_addfb_basic (invalid-get-prop) [73.556674] Starting subtest: invalid-get-prop [73.573288] Subtest invalid-get-prop: SUCCESS (0.000s) [73.742730] [081/162] (918s left) kms_addfb_basic (invalid-get-prop-any) [73.819026] Starting subtest: invalid-get-prop-any [73.825469] Subtest invalid-get-prop-any: SUCCESS (0.000s) [74.003815] [082/162] (918s left) kms_addfb_basic (invalid-set-prop) [74.083601] Starting subtest: invalid-set-prop [74.089707] Subtest invalid-set-prop: SUCCESS (0.000s) [74.265905] [083/162] (918s left) kms_addfb_basic (invalid-set-prop-any) [74.339246] Starting subtest: invalid-set-prop-any [74.355780] Subtest invalid-set-prop-any: SUCCESS (0.000s) [74.512360] [084/162] (918s left) kms_addfb_basic (no-handle) [74.581903] Starting subtest: no-handle [74.594289] Subtest no-handle: SUCCESS (0.000s) [74.764580] [085/162] (918s left) kms_addfb_basic (size-max) [74.899147] Starting subtest: size-max [74.907903] Subtest size-max: SUCCESS (0.000s) [75.040234] [086/162] (917s left) kms_addfb_basic (small-bo) [75.181928] Starting subtest: small-bo [75.197400] Subtest small-bo: SUCCESS (0.000s) [75.326941] [087/162] (917s left) kms_addfb_basic (tile-pitch-mismatch) [75.400074] Starting subtest: tile-pitch-mismatch [75.408796] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [75.586643] [088/162] (917s left) kms_addfb_basic (too-high) [75.717101] Starting subtest: too-high [75.728697] Subtest too-high: SUCCESS (0.001s) [75.856566] [089/162] (917s left) kms_addfb_basic (too-wide) [75.989454] Starting subtest: too-wide [75.995746] Subtest too-wide: SUCCESS (0.000s) [76.117147] [090/162] (917s left) kms_addfb_basic (unused-handle) [76.176523] Starting subtest: unused-handle [76.183911] Subtest unused-handle: SUCCESS (0.000s) [76.385158] [091/162] (916s left) kms_addfb_basic (unused-modifier) [76.442569] Starting subtest: unused-modifier [76.450590] Subtest unused-modifier: SUCCESS (0.000s) [76.639549] [092/162] (916s left) kms_addfb_basic (unused-offsets) [76.695016] Starting subtest: unused-offsets [76.701272] Subtest unused-offsets: SUCCESS (0.000s) [76.864683] [093/162] (916s left) kms_addfb_basic (unused-pitches) [76.930341] Starting subtest: unused-pitches [76.936583] Subtest unused-pitches: SUCCESS (0.000s) [77.138362] [094/162] (916s left) kms_busy (basic) [77.281742] Starting subtest: basic [77.287950] Starting dynamic subtest: flip [77.990656] Dynamic subtest flip: SUCCESS (0.715s) [78.006541] Starting dynamic subtest: modeset [78.844105] Dynamic subtest modeset: SUCCESS (0.852s) [78.857330] Subtest basic: SUCCESS (1.568s) [79.032486] [095/162] (914s left) kms_prop_blob (basic) [79.120538] Starting subtest: basic [79.127365] Subtest basic: SUCCESS (0.000s) [79.212433] [096/162] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [79.353559] Starting subtest: basic-busy-flip-before-cursor-atomic [79.376599] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [79.455541] [097/162] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [79.598106] Starting subtest: basic-busy-flip-before-cursor-legacy [79.624468] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [79.705911] [098/162] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [79.817754] Starting subtest: basic-flip-after-cursor-atomic [80.847331] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.036s) [81.101307] [099/162] (912s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [81.229060] Starting subtest: basic-flip-after-cursor-legacy [82.259957] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.030s) [82.484852] [100/162] (911s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [82.624214] Starting subtest: basic-flip-after-cursor-varying-size [83.661518] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.046s) [83.889617] [101/162] (910s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [84.003184] Starting subtest: basic-flip-before-cursor-atomic [85.041575] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.044s) [85.290237] [102/162] (908s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [85.422554] Starting subtest: basic-flip-before-cursor-legacy [86.453965] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.037s) [86.677395] [103/162] (907s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [86.802051] Starting subtest: basic-flip-before-cursor-varying-size [87.846551] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.040s) [88.072523] [104/162] (906s left) kms_dsc (dsc-basic) [88.199730] Starting subtest: dsc-basic [88.263792] Subtest dsc-basic: SKIP (0.001s) [88.321932] [105/162] (905s left) kms_flip (basic-flip-vs-dpms) [88.440513] Starting subtest: basic-flip-vs-dpms [88.446680] Starting dynamic subtest: A-DP1 [89.332798] Dynamic subtest A-DP1: SUCCESS (0.897s) [89.349332] Starting dynamic subtest: B-DP1 [89.985037] Dynamic subtest B-DP1: SUCCESS (0.657s) [90.001483] Starting dynamic subtest: C-DP1 [90.665992] Dynamic subtest C-DP1: SUCCESS (0.672s) [90.683512] Starting dynamic subtest: D-DP1 [91.344857] Dynamic subtest D-DP1: SUCCESS (0.673s) [91.362650] Starting dynamic subtest: A-HDMI-A2 [92.041742] Dynamic subtest A-HDMI-A2: SUCCESS (0.692s) [92.053428] Starting dynamic subtest: B-HDMI-A2 [92.784537] Dynamic subtest B-HDMI-A2: SUCCESS (0.744s) [92.800845] Starting dynamic subtest: C-HDMI-A2 [93.527633] Dynamic subtest C-HDMI-A2: SUCCESS (0.750s) [93.540432] Starting dynamic subtest: D-HDMI-A2 [94.292947] Dynamic subtest D-HDMI-A2: SUCCESS (0.751s) [94.299539] Subtest basic-flip-vs-dpms: SUCCESS (5.850s) [94.560832] [106/162] (899s left) kms_flip (basic-flip-vs-modeset) [94.715169] Starting subtest: basic-flip-vs-modeset [94.725670] Starting dynamic subtest: A-DP1 [95.627825] Dynamic subtest A-DP1: SUCCESS (0.929s) [95.645660] Starting dynamic subtest: B-DP1 [96.308422] Dynamic subtest B-DP1: SUCCESS (0.683s) [96.320112] Starting dynamic subtest: C-DP1 [97.007278] Dynamic subtest C-DP1: SUCCESS (0.689s) [97.023780] Starting dynamic subtest: D-DP1 [97.701283] Dynamic subtest D-DP1: SUCCESS (0.693s) [97.717897] Starting dynamic subtest: A-HDMI-A2 [98.412651] Dynamic subtest A-HDMI-A2: SUCCESS (0.709s) [98.432179] Starting dynamic subtest: B-HDMI-A2 [99.188326] Dynamic subtest B-HDMI-A2: SUCCESS (0.766s) [99.204842] Starting dynamic subtest: C-HDMI-A2 [99.821753] Dynamic subtest C-HDMI-A2: SUCCESS (0.642s) [99.833056] Starting dynamic subtest: D-HDMI-A2 [100.466399] Dynamic subtest D-HDMI-A2: SUCCESS (0.642s) [100.481846] Subtest basic-flip-vs-modeset: SUCCESS (5.770s) [100.687864] [107/162] (893s left) kms_flip (basic-flip-vs-wf_vblank) [100.838465] Starting subtest: basic-flip-vs-wf_vblank [100.847252] Starting dynamic subtest: A-DP1 [101.947262] Dynamic subtest A-DP1: SUCCESS (1.130s) [101.966880] Starting dynamic subtest: B-DP1 [102.997219] Dynamic subtest B-DP1: SUCCESS (1.029s) [103.016768] Starting dynamic subtest: C-DP1 [103.999691] Dynamic subtest C-DP1: SUCCESS (1.012s) [104.012373] Starting dynamic subtest: D-DP1 [105.017130] Dynamic subtest D-DP1: SUCCESS (1.014s) [105.031661] Starting dynamic subtest: A-HDMI-A2 [106.057753] Dynamic subtest A-HDMI-A2: SUCCESS (1.040s) [106.069184] Starting dynamic subtest: B-HDMI-A2 [107.063685] Dynamic subtest B-HDMI-A2: SUCCESS (1.000s) [107.077006] Starting dynamic subtest: C-HDMI-A2 [108.068056] Dynamic subtest C-HDMI-A2: SUCCESS (0.997s) [108.087379] Starting dynamic subtest: D-HDMI-A2 [109.083636] Dynamic subtest D-HDMI-A2: SUCCESS (0.999s) [109.097147] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.254s) [109.387837] [108/162] (885s left) kms_flip (basic-plain-flip) [109.512271] Starting subtest: basic-plain-flip [109.524517] Starting dynamic subtest: A-DP1 [110.351291] Dynamic subtest A-DP1: SUCCESS (0.846s) [110.371705] Starting dynamic subtest: B-DP1 [111.089133] Dynamic subtest B-DP1: SUCCESS (0.727s) [111.103651] Starting dynamic subtest: C-DP1 [111.822487] Dynamic subtest C-DP1: SUCCESS (0.730s) [111.833845] Starting dynamic subtest: D-DP1 [112.569092] Dynamic subtest D-DP1: SUCCESS (0.746s) [112.598475] Starting dynamic subtest: A-HDMI-A2 [113.326393] Dynamic subtest A-HDMI-A2: SUCCESS (0.753s) [113.344013] Starting dynamic subtest: B-HDMI-A2 [114.066008] Dynamic subtest B-HDMI-A2: SUCCESS (0.734s) [114.083668] Starting dynamic subtest: C-HDMI-A2 [114.805537] Dynamic subtest C-HDMI-A2: SUCCESS (0.734s) [114.823400] Starting dynamic subtest: D-HDMI-A2 [115.557958] Dynamic subtest D-HDMI-A2: SUCCESS (0.753s) [115.564202] Subtest basic-plain-flip: SUCCESS (6.052s) [115.824593] [109/162] (878s left) kms_force_connector_basic (force-connector-state) [115.964556] Starting subtest: force-connector-state [116.397277] Subtest force-connector-state: SUCCESS (0.439s) [116.853291] [110/162] (877s left) kms_force_connector_basic (force-edid) [116.993757] Starting subtest: force-edid [117.033493] Subtest force-edid: SUCCESS (0.030s) [117.322637] [111/162] (877s left) kms_force_connector_basic (force-load-detect) [117.456082] Starting subtest: force-load-detect [117.478957] Subtest force-load-detect: SKIP (0.000s) [117.677743] [112/162] (877s left) kms_force_connector_basic (prune-stale-modes) [117.820733] Starting subtest: prune-stale-modes [117.846737] Subtest prune-stale-modes: SUCCESS (0.031s) [118.166080] [113/162] (876s left) kms_frontbuffer_tracking (basic) [118.331120] Starting subtest: basic [122.168141] Subtest basic: SUCCESS (3.873s) [122.399476] [114/162] (872s left) kms_hdmi_inject (inject-audio) [122.637441] Starting subtest: inject-audio [122.748661] Subtest inject-audio: SUCCESS (0.123s) [123.091424] [115/162] (871s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [123.229052] Starting subtest: compare-crc-sanitycheck-xr24 [123.241268] Starting dynamic subtest: pipe-A-DP-1 [123.844517] Dynamic subtest pipe-A-DP-1: SUCCESS (0.618s) [123.866565] Starting dynamic subtest: pipe-B-HDMI-A-2 [124.215704] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.364s) [124.237585] Starting dynamic subtest: pipe-C-DP-1 [124.596479] Dynamic subtest pipe-C-DP-1: SUCCESS (0.383s) [124.614394] Starting dynamic subtest: pipe-D-DP-1 [124.990700] Dynamic subtest pipe-D-DP-1: SUCCESS (0.389s) [125.007244] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.764s) [125.235494] [116/162] (869s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [125.373174] Starting subtest: compare-crc-sanitycheck-nv12 [125.383720] Starting dynamic subtest: pipe-A-DP-1 [126.115893] Dynamic subtest pipe-A-DP-1: SUCCESS (0.742s) [126.137768] Starting dynamic subtest: pipe-B-HDMI-A-2 [126.619045] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.508s) [126.630673] Starting dynamic subtest: pipe-C-DP-1 [127.132371] Dynamic subtest pipe-C-DP-1: SUCCESS (0.513s) [127.149045] Starting dynamic subtest: pipe-D-DP-1 [127.624975] Dynamic subtest pipe-D-DP-1: SUCCESS (0.496s) [127.641447] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.269s) [127.866310] [117/162] (867s left) kms_pipe_crc_basic (hang-read-crc) [128.002278] Starting subtest: hang-read-crc [128.008483] Starting dynamic subtest: pipe-A-DP-1 [129.347491] Dynamic subtest pipe-A-DP-1: SUCCESS (1.347s) [129.365113] Starting dynamic subtest: pipe-B-HDMI-A-2 [130.418226] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.065s) [130.440420] Starting dynamic subtest: pipe-C-DP-1 [131.525733] Dynamic subtest pipe-C-DP-1: SUCCESS (1.120s) [131.537593] Starting dynamic subtest: pipe-D-DP-1 [132.625817] Dynamic subtest pipe-D-DP-1: SUCCESS (1.091s) [132.631981] Subtest hang-read-crc: SUCCESS (4.633s) [132.812698] [118/162] (862s left) kms_pipe_crc_basic (nonblocking-crc) [132.947319] Starting subtest: nonblocking-crc [132.963956] Starting dynamic subtest: pipe-A-DP-1 [133.764793] Dynamic subtest pipe-A-DP-1: SUCCESS (0.817s) [133.781388] Starting dynamic subtest: pipe-B-HDMI-A-2 [134.326381] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.560s) [134.345739] Starting dynamic subtest: pipe-C-DP-1 [134.898434] Dynamic subtest pipe-C-DP-1: SUCCESS (0.574s) [134.915134] Starting dynamic subtest: pipe-D-DP-1 [135.471470] Dynamic subtest pipe-D-DP-1: SUCCESS (0.578s) [135.477566] Subtest nonblocking-crc: SUCCESS (2.540s) [135.650089] [119/162] (859s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [135.765880] Starting subtest: nonblocking-crc-frame-sequence [135.772019] Starting dynamic subtest: pipe-A-DP-1 [136.591904] Dynamic subtest pipe-A-DP-1: SUCCESS (0.824s) [136.603918] Starting dynamic subtest: pipe-B-HDMI-A-2 [137.153921] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.561s) [137.165808] Starting dynamic subtest: pipe-C-DP-1 [137.729603] Dynamic subtest pipe-C-DP-1: SUCCESS (0.576s) [137.741471] Starting dynamic subtest: pipe-D-DP-1 [138.314885] Dynamic subtest pipe-D-DP-1: SUCCESS (0.582s) [138.321086] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.555s) [138.493457] [120/162] (856s left) kms_pipe_crc_basic (read-crc) [138.602660] Starting subtest: read-crc [138.608804] Starting dynamic subtest: pipe-A-DP-1 [139.377419] Dynamic subtest pipe-A-DP-1: SUCCESS (0.765s) [139.393977] Starting dynamic subtest: pipe-B-HDMI-A-2 [139.869999] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.492s) [139.887592] Starting dynamic subtest: pipe-C-DP-1 [140.385041] Dynamic subtest pipe-C-DP-1: SUCCESS (0.509s) [140.402669] Starting dynamic subtest: pipe-D-DP-1 [140.891089] Dynamic subtest pipe-D-DP-1: SUCCESS (0.515s) [140.897206] Subtest read-crc: SUCCESS (2.293s) [141.069624] [121/162] (854s left) kms_pipe_crc_basic (read-crc-frame-sequence) [141.178811] Starting subtest: read-crc-frame-sequence [141.184941] Starting dynamic subtest: pipe-A-DP-1 [141.940449] Dynamic subtest pipe-A-DP-1: SUCCESS (0.764s) [141.952568] Starting dynamic subtest: pipe-B-HDMI-A-2 [142.434067] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.491s) [142.445696] Starting dynamic subtest: pipe-C-DP-1 [142.944272] Dynamic subtest pipe-C-DP-1: SUCCESS (0.507s) [142.955729] Starting dynamic subtest: pipe-D-DP-1 [143.459203] Dynamic subtest pipe-D-DP-1: SUCCESS (0.511s) [143.465331] Subtest read-crc-frame-sequence: SUCCESS (2.283s) [143.639133] [122/162] (851s left) kms_pm_backlight (basic-brightness) [143.757336] Subtest basic-brightness: SKIP (0.000s) [143.816287] [123/162] (851s left) kms_pm_rpm (basic-pci-d3-state) [145.284086] Starting subtest: basic-pci-d3-state [145.701854] Subtest basic-pci-d3-state: SUCCESS (0.414s) [145.973062] [124/162] (849s left) kms_pm_rpm (basic-rte) [146.037965] Starting subtest: basic-rte [147.840153] Subtest basic-rte: SUCCESS (1.806s) [148.496718] [125/162] (847s left) kms_psr (psr-primary-page-flip) [148.630667] Subtest psr-primary-page-flip: SKIP (0.000s) [148.700862] [126/162] (846s left) kms_psr (psr-cursor-plane-move) [148.851162] Subtest psr-cursor-plane-move: SKIP (0.000s) [148.954726] [127/162] (846s left) kms_psr (psr-sprite-plane-onoff) [149.112737] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [149.190332] [128/162] (846s left) kms_psr (psr-primary-mmap-gtt) [149.333711] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [149.419840] [129/162] (846s left) kms_setmode (basic-clone-single-crtc) [149.493896] Starting subtest: basic-clone-single-crtc [149.681168] Subtest basic-clone-single-crtc: SKIP (0.186s) [149.880993] [130/162] (846s left) i915_pm_rps (basic-api) [149.959519] Starting subtest: basic-api [149.968291] Subtest basic-api: SUCCESS (0.001s) [150.072021] [131/162] (845s left) prime_self_import (basic-llseek-bad) [150.138956] Starting subtest: basic-llseek-bad [150.162065] Subtest basic-llseek-bad: SUCCESS (0.002s) [150.303919] [132/162] (845s left) prime_self_import (basic-llseek-size) [150.368970] Starting subtest: basic-llseek-size [150.392100] Subtest basic-llseek-size: SUCCESS (0.004s) [150.518793] [133/162] (845s left) prime_self_import (basic-with_fd_dup) [150.589251] Starting subtest: basic-with_fd_dup [150.612436] Subtest basic-with_fd_dup: SUCCESS (0.004s) [150.749100] [134/162] (845s left) prime_self_import (basic-with_one_bo) [150.800824] Starting subtest: basic-with_one_bo [150.817899] Subtest basic-with_one_bo: SUCCESS (0.003s) [150.932738] [135/162] (845s left) prime_self_import (basic-with_one_bo_two_files) [150.983322] Starting subtest: basic-with_one_bo_two_files [151.006433] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [151.147839] [136/162] (845s left) prime_self_import (basic-with_two_bos) [151.215124] Starting subtest: basic-with_two_bos [151.238252] Subtest basic-with_two_bos: SUCCESS (0.005s) [151.354492] [137/162] (845s left) prime_vgem (basic-fence-flip) [151.464926] Starting subtest: basic-fence-flip [151.900316] Subtest basic-fence-flip: SUCCESS (0.442s) [152.063156] [138/162] (844s left) prime_vgem (basic-fence-mmap) [152.178138] Starting subtest: basic-fence-mmap [152.200176] Subtest basic-fence-mmap: SUCCESS (0.022s) [152.365218] [139/162] (844s left) prime_vgem (basic-fence-read) [152.463631] Starting subtest: basic-fence-read [152.486740] Subtest basic-fence-read: SKIP (0.006s) [152.636249] [140/162] (844s left) prime_vgem (basic-gtt) [152.734839] Starting subtest: basic-gtt [152.751347] Subtest basic-gtt: SUCCESS (0.009s) [152.899846] [141/162] (843s left) prime_vgem (basic-read) [153.006341] Starting subtest: basic-read [153.023134] Subtest basic-read: SKIP (0.010s) [153.171418] [142/162] (843s left) prime_vgem (basic-write) [153.280025] Starting subtest: basic-write [153.302131] Subtest basic-write: SKIP (0.006s) [153.418303] [143/162] (843s left) vgem_basic (setversion) [153.506343] Starting subtest: setversion [153.528449] Subtest setversion: SUCCESS (0.000s) [153.615233] [144/162] (843s left) vgem_basic (create) [153.705750] Starting subtest: create [153.712537] Subtest create: SUCCESS (0.000s) [153.798246] [145/162] (843s left) vgem_basic (debugfs) [153.882526] Starting subtest: debugfs [153.892398] Subtest debugfs: SUCCESS (0.001s) [153.974043] [146/162] (843s left) vgem_basic (dmabuf-export) [154.056738] Starting subtest: dmabuf-export [154.088396] Subtest dmabuf-export: SUCCESS (0.048s) [154.238395] [147/162] (842s left) vgem_basic (dmabuf-fence) [154.326687] Starting subtest: dmabuf-fence [154.333340] Subtest dmabuf-fence: SUCCESS (0.001s) [154.418307] [148/162] (842s left) vgem_basic (dmabuf-fence-before) [154.491963] Starting subtest: dmabuf-fence-before [154.508547] Subtest dmabuf-fence-before: SUCCESS (0.000s) [154.578958] [149/162] (842s left) vgem_basic (dmabuf-mmap) [154.636522] Starting subtest: dmabuf-mmap [154.642724] Subtest dmabuf-mmap: SUCCESS (0.009s) [154.713998] [150/162] (842s left) vgem_basic (mmap) [154.769945] Starting subtest: mmap [154.783130] Subtest mmap: SUCCESS (0.013s) [154.873540] [151/162] (842s left) vgem_basic (second-client) [154.936755] Starting subtest: second-client [154.978034] Subtest second-client: SUCCESS (0.033s) [155.057864] [152/162] (842s left) vgem_basic (sysfs) [155.119743] Starting subtest: sysfs [155.126240] Subtest sysfs: SUCCESS (0.001s) [155.204855] [153/162] (842s left) core_hotunplug (unbind-rebind) [155.302230] Starting subtest: unbind-rebind [158.657884] Subtest unbind-rebind: SUCCESS (3.347s) [158.729291] [154/162] (838s left) vgem_basic (unload) [158.794524] Starting subtest: unload [187.832321] Subtest unload: SUCCESS (29.034s) [187.967290] [155/162] (809s left) i915_module_load (reload) [188.043205] Starting subtest: reload [190.048066] Subtest reload: SUCCESS (2.026s) [190.124968] [156/162] (807s left) gem_lmem_swapping (basic) [190.230048] Subtest basic: SKIP (0.000s) [190.303600] [157/162] (807s left) gem_lmem_swapping (parallel-random-engines) [190.407053] Subtest parallel-random-engines: SKIP (0.000s) [190.479529] [158/162] (807s left) gem_lmem_swapping (random-engines) [190.571106] Subtest random-engines: SKIP (0.000s) [190.658627] [159/162] (807s left) gem_lmem_swapping (verify-random) [190.756459] Subtest verify-random: SKIP (0.000s) [190.824388] [160/162] (807s left) i915_pm_rpm (module-reload) [192.450784] Starting subtest: module-reload [199.448237] Subtest module-reload: SUCCESS (6.987s) [199.516390] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [199.517024] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [199.531222] [161/162] (798s left) i915_selftest (live)