[35.747379] Initializing watchdogs [35.747517] /dev/watchdog0 [35.757273] [001/165] (960s left) i915_module_load (load) [35.980510] Starting subtest: load [37.066044] Subtest load: SUCCESS (1.085s) [37.078641] [002/165] (959s left) core_auth (basic-auth) [37.150727] Starting subtest: basic-auth [37.151715] Subtest basic-auth: SUCCESS (0.001s) [37.230904] [003/165] (959s left) debugfs_test (read_all_entries) [37.304031] Starting subtest: read_all_entries [37.464704] Subtest read_all_entries: SUCCESS (0.161s) [37.595606] [004/165] (958s left) debugfs_test (basic-hwmon) [37.676412] Starting subtest: basic-hwmon [37.678445] Subtest basic-hwmon: SKIP (0.000s) [37.789023] [005/165] (958s left) fbdev (eof) [37.867955] Starting subtest: eof [37.870359] Subtest eof: SUCCESS (0.002s) [37.954163] [006/165] (958s left) fbdev (info) [38.025320] Starting subtest: info [38.026547] Subtest info: SUCCESS (0.000s) [38.091392] [007/165] (958s left) fbdev (nullptr) [38.172881] Starting subtest: nullptr [38.174036] Subtest nullptr: SUCCESS (0.000s) [38.219841] [008/165] (958s left) fbdev (read) [38.281343] Starting subtest: read [38.532860] Subtest read: SUCCESS (0.250s) [38.575591] [009/165] (957s left) fbdev (write) [38.623427] Starting subtest: write [38.753958] Subtest write: SUCCESS (0.129s) [38.801261] [010/165] (957s left) gem_basic (bad-close) [38.845724] Starting subtest: bad-close [38.847987] Subtest bad-close: SUCCESS (0.000s) [38.914278] [011/165] (957s left) gem_basic (create-close) [38.986374] Starting subtest: create-close [38.988391] Subtest create-close: SUCCESS (0.000s) [39.103951] [012/165] (957s left) gem_basic (create-fd-close) [39.170714] Starting subtest: create-fd-close [39.172770] Subtest create-fd-close: SUCCESS (0.000s) [39.287048] [013/165] (957s left) gem_busy (busy@all-engines) [39.366469] Starting subtest: busy [39.367497] Starting dynamic subtest: all-engines [39.390906] Dynamic subtest all-engines: SUCCESS (0.024s) [39.391883] Subtest busy: SUCCESS (0.024s) [39.820369] [014/165] (956s left) gem_close_race (basic-process) [39.910566] Starting subtest: basic-process [39.966306] Subtest basic-process: SUCCESS (0.056s) [40.172606] [015/165] (956s left) gem_close_race (basic-threads) [40.259650] Starting subtest: basic-threads [41.465712] Subtest basic-threads: SUCCESS (1.206s) [41.684753] [016/165] (955s left) gem_ctx_create (basic) [41.769656] Starting subtest: basic [41.770859] Subtest basic: SUCCESS (0.000s) [41.977091] [017/165] (954s left) gem_ctx_create (basic-files) [42.032348] Starting subtest: basic-files [44.043993] Subtest basic-files: SUCCESS (2.012s) [44.302213] [018/165] (952s left) gem_ctx_exec (basic) [44.375856] Starting subtest: basic [44.378042] Subtest basic: SUCCESS (0.002s) [44.510754] [019/165] (952s left) gem_exec_basic (basic) [44.583566] Starting subtest: basic [44.584601] Starting dynamic subtest: rcs0-smem [44.585618] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [44.591391] Starting dynamic subtest: bcs0-smem [44.592689] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [44.597889] Starting dynamic subtest: vcs0-smem [44.599149] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [44.604362] Starting dynamic subtest: vecs0-smem [44.605628] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [44.606812] Subtest basic: SUCCESS (0.002s) [44.837297] [020/165] (952s left) gem_exec_create (basic) [44.912798] Starting subtest: basic [44.914102] Starting dynamic subtest: smem [46.953258] Dynamic subtest smem: SUCCESS (2.040s) [46.954646] Subtest basic: SUCCESS (2.040s) [47.172491] [021/165] (949s left) gem_exec_fence (basic-busy) [47.393651] Starting subtest: basic-busy [47.395973] Starting dynamic subtest: rcs0 [47.423297] Dynamic subtest rcs0: SUCCESS (0.033s) [47.446250] Starting dynamic subtest: bcs0 [47.465611] Dynamic subtest bcs0: SUCCESS (0.044s) [47.477406] Starting dynamic subtest: vcs0 [47.503601] Dynamic subtest vcs0: SUCCESS (0.038s) [47.515411] Starting dynamic subtest: vecs0 [47.529658] Dynamic subtest vecs0: SUCCESS (0.026s) [47.530994] Subtest basic-busy: SUCCESS (0.142s) [48.133541] [022/165] (948s left) gem_exec_fence (basic-wait) [48.324465] Starting subtest: basic-wait [48.326844] Starting dynamic subtest: rcs0 [48.364469] Dynamic subtest rcs0: SUCCESS (0.041s) [48.388638] Starting dynamic subtest: bcs0 [48.406608] Dynamic subtest bcs0: SUCCESS (0.042s) [48.429415] Starting dynamic subtest: vcs0 [48.449666] Dynamic subtest vcs0: SUCCESS (0.043s) [48.461920] Starting dynamic subtest: vecs0 [48.480613] Dynamic subtest vecs0: SUCCESS (0.031s) [48.482144] Subtest basic-wait: SUCCESS (0.159s) [49.074391] [023/165] (947s left) gem_exec_fence (basic-await) [49.265732] Starting subtest: basic-await [49.267939] Starting dynamic subtest: rcs0 [49.355490] Dynamic subtest rcs0: SUCCESS (0.090s) [49.363849] Starting dynamic subtest: bcs0 [49.436432] Dynamic subtest bcs0: SUCCESS (0.080s) [49.451203] Starting dynamic subtest: vcs0 [49.530241] Dynamic subtest vcs0: SUCCESS (0.094s) [49.541057] Starting dynamic subtest: vecs0 [49.617557] Dynamic subtest vecs0: SUCCESS (0.087s) [49.618935] Subtest basic-await: SUCCESS (0.353s) [50.208912] [024/165] (946s left) gem_exec_fence (nb-await) [50.399693] Starting subtest: nb-await [50.401884] Starting dynamic subtest: rcs0 [50.473791] Dynamic subtest rcs0: SUCCESS (0.073s) [50.499125] Starting dynamic subtest: bcs0 [50.546171] Dynamic subtest bcs0: SUCCESS (0.073s) [50.571419] Starting dynamic subtest: vcs0 [50.618260] Dynamic subtest vcs0: SUCCESS (0.072s) [50.643414] Starting dynamic subtest: vecs0 [50.690471] Dynamic subtest vecs0: SUCCESS (0.072s) [50.692729] Subtest nb-await: SUCCESS (0.292s) [51.244303] [025/165] (945s left) gem_exec_gttfill (basic) [51.301976] Starting subtest: basic [54.491591] Subtest basic: SUCCESS (3.188s) [54.691519] [026/165] (942s left) gem_exec_parallel (engines) [54.838225] Starting subtest: engines [54.839207] Starting dynamic subtest: basic [56.371843] Dynamic subtest basic: SUCCESS (1.534s) [56.378207] Starting dynamic subtest: contexts [59.009385] Dynamic subtest contexts: SUCCESS (2.636s) [59.017710] Starting dynamic subtest: fds [62.392461] Dynamic subtest fds: SUCCESS (3.384s) [62.399085] Starting dynamic subtest: userptr [64.197630] Dynamic subtest userptr: SUCCESS (1.805s) [64.198730] Subtest engines: SUCCESS (9.360s) [64.412749] [027/165] (932s left) gem_exec_store (basic) [64.499879] Starting subtest: basic [64.564362] Subtest basic: SUCCESS (0.064s) [64.773303] [028/165] (932s left) gem_flink_basic (bad-flink) [64.837420] Starting subtest: bad-flink [64.838535] Subtest bad-flink: SUCCESS (0.000s) [64.915618] [029/165] (932s left) gem_flink_basic (bad-open) [64.988281] Starting subtest: bad-open [64.990611] Subtest bad-open: SUCCESS (0.000s) [65.053078] [030/165] (932s left) gem_flink_basic (basic) [65.123982] Starting subtest: basic [65.125340] Subtest basic: SUCCESS (0.000s) [65.242121] [031/165] (931s left) gem_flink_basic (double-flink) [65.306513] Starting subtest: double-flink [65.307595] Subtest double-flink: SUCCESS (0.000s) [65.424726] [032/165] (931s left) gem_flink_basic (flink-lifetime) [65.474783] Starting subtest: flink-lifetime [65.475888] Subtest flink-lifetime: SUCCESS (0.001s) [65.583907] [033/165] (931s left) gem_huc_copy (huc-copy) [65.656221] Starting subtest: huc-copy [65.658323] Subtest huc-copy: SUCCESS (0.002s) [65.790617] [034/165] (931s left) gem_linear_blits (basic) [65.913853] Starting subtest: basic [65.918784] Subtest basic: SUCCESS (0.005s) [66.082578] [035/165] (931s left) gem_mmap (basic) [66.269136] Starting subtest: basic [66.274836] Subtest basic: SUCCESS (0.000s) [66.371717] [036/165] (931s left) gem_mmap_gtt (basic) [66.411363] Starting subtest: basic [66.412425] Subtest basic: SUCCESS (0.000s) [66.469211] [037/165] (930s left) gem_render_linear_blits (basic) [66.535424] Starting subtest: basic [66.555369] Subtest basic: SUCCESS (0.020s) [66.596211] [038/165] (930s left) gem_render_tiled_blits (basic) [66.638769] Starting subtest: basic [66.660768] Subtest basic: SUCCESS (0.022s) [66.709255] [039/165] (930s left) gem_ringfill (basic-all) [66.942959] Starting subtest: basic-all [68.100706] Subtest basic-all: SUCCESS (1.158s) [68.219129] [040/165] (929s left) gem_softpin (allocator-basic) [68.270456] Starting subtest: allocator-basic [68.342389] Subtest allocator-basic: SUCCESS (0.071s) [68.484179] [041/165] (929s left) gem_softpin (allocator-basic-reserve) [68.530216] Starting subtest: allocator-basic-reserve [68.616860] Subtest allocator-basic-reserve: SUCCESS (0.083s) [68.757301] [042/165] (928s left) gem_softpin (safe-alignment) [68.819951] Starting subtest: safe-alignment [68.828106] Subtest safe-alignment: SUCCESS (0.008s) [68.960108] [043/165] (928s left) gem_sync (basic-all) [69.031120] Starting subtest: basic-all [71.086300] Subtest basic-all: SUCCESS (2.058s) [71.275815] [044/165] (926s left) gem_sync (basic-each) [71.324550] Starting subtest: basic-each [73.437230] Subtest basic-each: SUCCESS (2.115s) [73.667107] [045/165] (924s left) gem_tiled_blits (basic) [73.803584] Starting subtest: basic [73.817437] Subtest basic: SUCCESS (0.013s) [73.981752] [046/165] (923s left) gem_tiled_fence_blits (basic) [74.175575] Starting subtest: basic [74.183940] Subtest basic: SUCCESS (0.007s) [74.334498] [047/165] (923s left) gem_tiled_pread_basic [74.663525] [048/165] (923s left) gem_wait (busy@all-engines) [74.716154] Starting subtest: busy [74.717253] Starting dynamic subtest: all-engines [75.245062] Dynamic subtest all-engines: SUCCESS (0.529s) [75.246145] Subtest busy: SUCCESS (0.529s) [75.447580] [049/165] (922s left) gem_wait (wait@all-engines) [75.497226] Starting subtest: wait [75.498317] Starting dynamic subtest: all-engines [76.535475] Dynamic subtest all-engines: SUCCESS (1.037s) [76.537893] Subtest wait: SUCCESS (1.037s) [76.765927] [050/165] (921s left) i915_getparams_basic (basic-eu-total) [76.826686] Starting subtest: basic-eu-total [76.828821] Subtest basic-eu-total: SUCCESS (0.000s) [76.877920] [051/165] (921s left) i915_getparams_basic (basic-subslice-total) [76.918734] Starting subtest: basic-subslice-total [76.920869] Subtest basic-subslice-total: SUCCESS (0.000s) [76.998263] [052/165] (920s left) i915_hangman (error-state-basic) [77.072306] Starting subtest: error-state-basic [77.133751] Subtest error-state-basic: SUCCESS (0.062s) [77.194854] [053/165] (920s left) i915_pciid [77.302250] [054/165] (920s left) kms_addfb_basic (addfb25-4-tiled) [77.439249] Starting subtest: addfb25-4-tiled [77.440338] Subtest addfb25-4-tiled: SUCCESS (0.000s) [77.522101] [055/165] (920s left) kms_addfb_basic (addfb25-bad-modifier) [77.594194] Starting subtest: addfb25-bad-modifier [77.595295] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [77.760987] [056/165] (920s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [77.811130] Starting subtest: addfb25-framebuffer-vs-set-tiling [77.812223] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [77.936605] [057/165] (920s left) kms_addfb_basic (addfb25-modifier-no-flag) [78.017576] Starting subtest: addfb25-modifier-no-flag [78.018652] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [78.159854] [058/165] (919s left) kms_addfb_basic (addfb25-x-tiled-legacy) [78.232364] Starting subtest: addfb25-x-tiled-legacy [78.233445] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [78.383340] [059/165] (919s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [78.449749] Starting subtest: addfb25-x-tiled-mismatch-legacy [78.450833] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [78.571712] [060/165] (919s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [78.687262] Starting subtest: addfb25-yf-tiled-legacy [78.688336] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [78.816503] [061/165] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy) [78.923145] Starting subtest: addfb25-y-tiled-legacy [78.924161] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [79.042504] [062/165] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [79.156177] Starting subtest: addfb25-y-tiled-small-legacy [79.157277] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [79.238094] [063/165] (919s left) kms_addfb_basic (bad-pitch-0) [79.301771] Starting subtest: bad-pitch-0 [79.302869] Subtest bad-pitch-0: SUCCESS (0.000s) [79.444772] [064/165] (918s left) kms_addfb_basic (bad-pitch-1024) [79.519439] Starting subtest: bad-pitch-1024 [79.520529] Subtest bad-pitch-1024: SUCCESS (0.000s) [79.680458] [065/165] (918s left) kms_addfb_basic (bad-pitch-128) [79.749922] Starting subtest: bad-pitch-128 [79.750996] Subtest bad-pitch-128: SUCCESS (0.000s) [79.871771] [066/165] (918s left) kms_addfb_basic (bad-pitch-256) [79.937219] Starting subtest: bad-pitch-256 [79.938274] Subtest bad-pitch-256: SUCCESS (0.000s) [80.085252] [067/165] (918s left) kms_addfb_basic (bad-pitch-32) [80.155636] Starting subtest: bad-pitch-32 [80.156802] Subtest bad-pitch-32: SUCCESS (0.000s) [80.292819] [068/165] (918s left) kms_addfb_basic (bad-pitch-63) [80.364935] Starting subtest: bad-pitch-63 [80.365996] Subtest bad-pitch-63: SUCCESS (0.000s) [80.493164] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536) [80.560955] Starting subtest: bad-pitch-65536 [80.561997] Subtest bad-pitch-65536: SUCCESS (0.000s) [80.681739] [070/165] (917s left) kms_addfb_basic (bad-pitch-999) [80.733540] Starting subtest: bad-pitch-999 [80.734594] Subtest bad-pitch-999: SUCCESS (0.000s) [80.885972] [071/165] (917s left) kms_addfb_basic (basic) [80.956627] Starting subtest: basic [80.957699] Subtest basic: SUCCESS (0.000s) [81.095760] [072/165] (917s left) kms_addfb_basic (basic-x-tiled-legacy) [81.170910] Starting subtest: basic-x-tiled-legacy [81.171886] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [81.319033] [073/165] (917s left) kms_addfb_basic (basic-y-tiled-legacy) [81.391850] Starting subtest: basic-y-tiled-legacy [81.392926] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [81.539365] [074/165] (917s left) kms_addfb_basic (bo-too-small) [81.672200] Starting subtest: bo-too-small [81.673305] Subtest bo-too-small: SUCCESS (0.000s) [81.750761] [075/165] (916s left) kms_addfb_basic (bo-too-small-due-to-tiling) [81.840053] Starting subtest: bo-too-small-due-to-tiling [81.841027] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [81.930464] [076/165] (916s left) kms_addfb_basic (clobberred-modifier) [82.005251] Starting subtest: clobberred-modifier [82.006253] Subtest clobberred-modifier: SUCCESS (0.000s) [82.152845] [077/165] (916s left) kms_addfb_basic (framebuffer-vs-set-tiling) [82.222253] Starting subtest: framebuffer-vs-set-tiling [82.223262] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [82.370066] [078/165] (916s left) kms_addfb_basic (invalid-get-prop) [82.444721] Starting subtest: invalid-get-prop [82.445891] Subtest invalid-get-prop: SUCCESS (0.000s) [82.571020] [079/165] (916s left) kms_addfb_basic (invalid-get-prop-any) [82.631432] Starting subtest: invalid-get-prop-any [82.632475] Subtest invalid-get-prop-any: SUCCESS (0.000s) [82.757241] [080/165] (916s left) kms_addfb_basic (invalid-set-prop) [82.822235] Starting subtest: invalid-set-prop [82.823251] Subtest invalid-set-prop: SUCCESS (0.000s) [82.961506] [081/165] (915s left) kms_addfb_basic (invalid-set-prop-any) [83.033815] Starting subtest: invalid-set-prop-any [83.034829] Subtest invalid-set-prop-any: SUCCESS (0.000s) [83.205033] [082/165] (915s left) kms_addfb_basic (no-handle) [83.268102] Starting subtest: no-handle [83.269229] Subtest no-handle: SUCCESS (0.000s) [83.422226] [083/165] (915s left) kms_addfb_basic (size-max) [83.540345] Starting subtest: size-max [83.541421] Subtest size-max: SUCCESS (0.000s) [83.637084] [084/165] (915s left) kms_addfb_basic (small-bo) [83.764309] Starting subtest: small-bo [83.765468] Subtest small-bo: SUCCESS (0.000s) [83.842361] [085/165] (915s left) kms_addfb_basic (tile-pitch-mismatch) [83.914380] Starting subtest: tile-pitch-mismatch [83.915525] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [84.042182] [086/165] (914s left) kms_addfb_basic (too-high) [84.153210] Starting subtest: too-high [84.154280] Subtest too-high: SUCCESS (0.001s) [84.291151] [087/165] (914s left) kms_addfb_basic (too-wide) [84.396261] Starting subtest: too-wide [84.397298] Subtest too-wide: SUCCESS (0.000s) [84.478759] [088/165] (914s left) kms_addfb_basic (unused-handle) [84.553480] Starting subtest: unused-handle [84.554559] Subtest unused-handle: SUCCESS (0.000s) [84.718133] [089/165] (914s left) kms_addfb_basic (unused-modifier) [84.784431] Starting subtest: unused-modifier [84.785432] Subtest unused-modifier: SUCCESS (0.000s) [84.911168] [090/165] (914s left) kms_addfb_basic (unused-offsets) [84.980160] Starting subtest: unused-offsets [84.981229] Subtest unused-offsets: SUCCESS (0.000s) [85.118343] [091/165] (914s left) kms_addfb_basic (unused-pitches) [85.192516] Starting subtest: unused-pitches [85.193512] Subtest unused-pitches: SUCCESS (0.000s) [85.339947] [092/165] (913s left) kms_busy (basic) [85.461174] Starting subtest: basic [85.462465] Starting dynamic subtest: flip [86.225296] Dynamic subtest flip: SUCCESS (0.763s) [86.232593] Starting dynamic subtest: modeset [86.624249] Dynamic subtest modeset: SUCCESS (0.398s) [86.625347] Subtest basic: SUCCESS (1.162s) [86.734775] [093/165] (912s left) kms_prop_blob (basic) [86.774747] Starting subtest: basic [86.775802] Subtest basic: SUCCESS (0.000s) [86.848484] [094/165] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [86.966417] Starting subtest: basic-busy-flip-before-cursor-atomic [86.968469] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [87.032098] [095/165] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [87.135356] Starting subtest: basic-busy-flip-before-cursor-legacy [87.137508] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [87.199112] [096/165] (912s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [87.318330] Starting subtest: basic-flip-after-cursor-atomic [88.251275] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.933s) [88.382211] [097/165] (910s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [88.472437] Starting subtest: basic-flip-after-cursor-legacy [89.399268] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.927s) [89.522442] [098/165] (909s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [89.610427] Starting subtest: basic-flip-after-cursor-varying-size [90.538211] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.928s) [90.664478] [099/165] (908s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [90.753432] Starting subtest: basic-flip-before-cursor-atomic [91.681198] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.928s) [91.797070] [100/165] (907s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [91.884394] Starting subtest: basic-flip-before-cursor-legacy [92.814231] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.929s) [92.933400] [101/165] (906s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [93.020447] Starting subtest: basic-flip-before-cursor-varying-size [93.951061] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.931s) [94.082651] [102/165] (905s left) kms_dsc (dsc-basic) [94.170620] Subtest dsc-basic: SKIP (0.000s) [94.194420] [103/165] (905s left) kms_flip (basic-flip-vs-dpms) [94.267413] Starting subtest: basic-flip-vs-dpms [94.268486] Starting dynamic subtest: A-HDMI-A2 [94.944448] Dynamic subtest A-HDMI-A2: SUCCESS (0.676s) [94.951726] Starting dynamic subtest: B-HDMI-A2 [95.561404] Dynamic subtest B-HDMI-A2: SUCCESS (0.616s) [95.568506] Starting dynamic subtest: C-HDMI-A2 [96.174696] Dynamic subtest C-HDMI-A2: SUCCESS (0.613s) [96.183532] Starting dynamic subtest: A-DP2 [96.831521] Dynamic subtest A-DP2: SUCCESS (0.656s) [96.838619] Starting dynamic subtest: B-DP2 [97.503466] Dynamic subtest B-DP2: SUCCESS (0.672s) [97.510507] Starting dynamic subtest: C-DP2 [98.115846] Dynamic subtest C-DP2: SUCCESS (0.612s) [98.116992] Subtest basic-flip-vs-dpms: SUCCESS (3.850s) [98.259184] [104/165] (901s left) kms_flip (basic-flip-vs-modeset) [98.359139] Starting subtest: basic-flip-vs-modeset [98.361885] Starting dynamic subtest: A-HDMI-A2 [99.060097] Dynamic subtest A-HDMI-A2: SUCCESS (0.699s) [99.068180] Starting dynamic subtest: B-HDMI-A2 [99.725941] Dynamic subtest B-HDMI-A2: SUCCESS (0.663s) [99.734344] Starting dynamic subtest: C-HDMI-A2 [100.380422] Dynamic subtest C-HDMI-A2: SUCCESS (0.656s) [100.388890] Starting dynamic subtest: A-DP2 [101.012465] Dynamic subtest A-DP2: SUCCESS (0.630s) [101.020898] Starting dynamic subtest: B-DP2 [101.622684] Dynamic subtest B-DP2: SUCCESS (0.610s) [101.629697] Starting dynamic subtest: C-DP2 [102.227400] Dynamic subtest C-DP2: SUCCESS (0.604s) [102.228401] Subtest basic-flip-vs-modeset: SUCCESS (3.869s) [102.351458] [105/165] (897s left) kms_flip (basic-flip-vs-wf_vblank) [102.433423] Starting subtest: basic-flip-vs-wf_vblank [102.435597] Starting dynamic subtest: A-HDMI-A2 [103.391180] Dynamic subtest A-HDMI-A2: SUCCESS (0.956s) [103.398920] Starting dynamic subtest: B-HDMI-A2 [104.297225] Dynamic subtest B-HDMI-A2: SUCCESS (0.905s) [104.305096] Starting dynamic subtest: C-HDMI-A2 [105.205136] Dynamic subtest C-HDMI-A2: SUCCESS (0.907s) [105.214795] Starting dynamic subtest: A-DP2 [106.120019] Dynamic subtest A-DP2: SUCCESS (0.913s) [106.128185] Starting dynamic subtest: B-DP2 [107.039148] Dynamic subtest B-DP2: SUCCESS (0.915s) [107.047224] Starting dynamic subtest: C-DP2 [107.956316] Dynamic subtest C-DP2: SUCCESS (0.918s) [107.958477] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.524s) [108.114189] [106/165] (891s left) kms_flip (basic-plain-flip) [108.189800] Starting subtest: basic-plain-flip [108.190895] Starting dynamic subtest: A-HDMI-A2 [108.852358] Dynamic subtest A-HDMI-A2: SUCCESS (0.662s) [108.861440] Starting dynamic subtest: B-HDMI-A2 [109.475404] Dynamic subtest B-HDMI-A2: SUCCESS (0.622s) [109.482890] Starting dynamic subtest: C-HDMI-A2 [110.098262] Dynamic subtest C-HDMI-A2: SUCCESS (0.622s) [110.107738] Starting dynamic subtest: A-DP2 [110.727397] Dynamic subtest A-DP2: SUCCESS (0.628s) [110.737304] Starting dynamic subtest: B-DP2 [111.356247] Dynamic subtest B-DP2: SUCCESS (0.628s) [111.364616] Starting dynamic subtest: C-DP2 [111.993087] Dynamic subtest C-DP2: SUCCESS (0.636s) [111.994201] Subtest basic-plain-flip: SUCCESS (3.805s) [112.118604] [107/165] (887s left) kms_force_connector_basic (force-connector-state) [112.214165] Starting subtest: force-connector-state [112.512843] Subtest force-connector-state: SUCCESS (0.300s) [112.889435] [108/165] (886s left) kms_force_connector_basic (force-edid) [112.999594] Starting subtest: force-edid [113.025795] Subtest force-edid: SUCCESS (0.026s) [113.275160] [109/165] (886s left) kms_force_connector_basic (force-load-detect) [113.393481] Starting subtest: force-load-detect [113.395707] Subtest force-load-detect: SKIP (0.000s) [113.598740] [110/165] (885s left) kms_force_connector_basic (prune-stale-modes) [113.726586] Starting subtest: prune-stale-modes [113.750359] Subtest prune-stale-modes: SUCCESS (0.024s) [113.979396] [111/165] (885s left) kms_frontbuffer_tracking (basic) [114.111985] Starting subtest: basic [116.646395] Subtest basic: SUCCESS (2.537s) [116.804646] [112/165] (882s left) kms_hdmi_inject (inject-audio) [116.907749] Starting subtest: inject-audio [117.020880] Subtest inject-audio: FAIL (0.084s) [117.272934] [113/165] (882s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [117.402846] Starting subtest: compare-crc-sanitycheck-xr24 [117.403975] Starting dynamic subtest: pipe-A-HDMI-A-2 [117.864317] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.461s) [117.873868] Starting dynamic subtest: pipe-B-DP-2 [118.184949] Dynamic subtest pipe-B-DP-2: SUCCESS (0.318s) [118.193944] Starting dynamic subtest: pipe-C-HDMI-A-2 [118.498532] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.313s) [118.499804] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.097s) [118.630703] [114/165] (881s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [118.725642] Starting subtest: compare-crc-sanitycheck-nv12 [118.726707] Starting dynamic subtest: pipe-A-HDMI-A-2 [118.728750] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [118.736007] Starting dynamic subtest: pipe-B-DP-2 [118.738378] Dynamic subtest pipe-B-DP-2: SKIP (0.000s) [118.745294] Starting dynamic subtest: pipe-C-HDMI-A-2 [118.747404] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [118.749449] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s) [118.790947] [115/165] (880s left) kms_pipe_crc_basic (hang-read-crc) [118.883887] Starting subtest: hang-read-crc [118.884965] Starting dynamic subtest: pipe-A-HDMI-A-2 [119.912809] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.028s) [119.922111] Starting dynamic subtest: pipe-B-DP-2 [120.794832] Dynamic subtest pipe-B-DP-2: SUCCESS (0.881s) [120.803234] Starting dynamic subtest: pipe-C-HDMI-A-2 [121.655770] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.860s) [121.656919] Subtest hang-read-crc: SUCCESS (2.773s) [121.763436] [116/165] (877s left) kms_pipe_crc_basic (nonblocking-crc) [121.848423] Starting subtest: nonblocking-crc [121.849425] Starting dynamic subtest: pipe-A-HDMI-A-2 [122.482785] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.632s) [122.492363] Starting dynamic subtest: pipe-B-DP-2 [122.951623] Dynamic subtest pipe-B-DP-2: SUCCESS (0.467s) [122.962803] Starting dynamic subtest: pipe-C-HDMI-A-2 [123.417156] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.464s) [123.418290] Subtest nonblocking-crc: SUCCESS (1.569s) [123.529712] [117/165] (876s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [123.616779] Starting subtest: nonblocking-crc-frame-sequence [123.617895] Starting dynamic subtest: pipe-A-HDMI-A-2 [124.229710] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.612s) [124.238326] Starting dynamic subtest: pipe-B-DP-2 [124.678866] Dynamic subtest pipe-B-DP-2: SUCCESS (0.448s) [124.687406] Starting dynamic subtest: pipe-C-HDMI-A-2 [125.123252] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.442s) [125.124352] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.507s) [125.224472] [118/165] (874s left) kms_pipe_crc_basic (read-crc) [125.314244] Starting subtest: read-crc [125.315273] Starting dynamic subtest: pipe-A-HDMI-A-2 [125.861475] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.548s) [125.871708] Starting dynamic subtest: pipe-B-DP-2 [126.243789] Dynamic subtest pipe-B-DP-2: SUCCESS (0.380s) [126.250977] Starting dynamic subtest: pipe-C-HDMI-A-2 [126.638391] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.393s) [126.639596] Subtest read-crc: SUCCESS (1.326s) [126.744731] [119/165] (872s left) kms_pipe_crc_basic (read-crc-frame-sequence) [126.831748] Starting subtest: read-crc-frame-sequence [126.832882] Starting dynamic subtest: pipe-A-HDMI-A-2 [127.411363] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.579s) [127.418888] Starting dynamic subtest: pipe-B-DP-2 [127.809186] Dynamic subtest pipe-B-DP-2: SUCCESS (0.397s) [127.820316] Starting dynamic subtest: pipe-C-HDMI-A-2 [128.222113] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.411s) [128.223240] Subtest read-crc-frame-sequence: SUCCESS (1.392s) [128.324753] [120/165] (871s left) kms_pm_backlight (basic-brightness) [128.419821] Subtest basic-brightness: SKIP (0.000s) [128.445786] [121/165] (871s left) kms_pm_rpm (basic-pci-d3-state) [129.955361] Starting subtest: basic-pci-d3-state [130.273475] Subtest basic-pci-d3-state: SUCCESS (0.319s) [130.584226] [122/165] (869s left) kms_pm_rpm (basic-rte) [130.641231] Starting subtest: basic-rte [132.615020] Subtest basic-rte: SUCCESS (1.973s) [133.167096] [123/165] (866s left) kms_psr (primary_page_flip) [133.209202] Subtest primary_page_flip: SKIP (0.000s) [133.238154] [124/165] (866s left) kms_psr (cursor_plane_move) [133.279301] Subtest cursor_plane_move: SKIP (0.000s) [133.304713] [125/165] (866s left) kms_psr (sprite_plane_onoff) [133.345627] Subtest sprite_plane_onoff: SKIP (0.000s) [133.370692] [126/165] (866s left) kms_psr (primary_mmap_gtt) [133.410663] Subtest primary_mmap_gtt: SKIP (0.000s) [133.438785] [127/165] (866s left) kms_setmode (basic-clone-single-crtc) [133.485717] Starting subtest: basic-clone-single-crtc [133.550689] Subtest basic-clone-single-crtc: SKIP (0.065s) [133.666699] [128/165] (866s left) i915_pm_rps (basic-api) [133.709933] Starting subtest: basic-api [133.712163] Subtest basic-api: SUCCESS (0.002s) [133.782352] [129/165] (866s left) prime_self_import (basic-llseek-bad) [133.828600] Starting subtest: basic-llseek-bad [133.830761] Subtest basic-llseek-bad: SUCCESS (0.001s) [133.968971] [130/165] (865s left) prime_self_import (basic-llseek-size) [134.022809] Starting subtest: basic-llseek-size [134.026037] Subtest basic-llseek-size: SUCCESS (0.002s) [134.133914] [131/165] (865s left) prime_self_import (basic-with_fd_dup) [134.183752] Starting subtest: basic-with_fd_dup [134.185898] Subtest basic-with_fd_dup: SUCCESS (0.002s) [134.312457] [132/165] (865s left) prime_self_import (basic-with_one_bo) [134.369902] Starting subtest: basic-with_one_bo [134.372014] Subtest basic-with_one_bo: SUCCESS (0.002s) [134.430281] [133/165] (865s left) prime_self_import (basic-with_one_bo_two_files) [134.478535] Starting subtest: basic-with_one_bo_two_files [134.480628] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [134.608651] [134/165] (865s left) prime_self_import (basic-with_two_bos) [134.660090] Starting subtest: basic-with_two_bos [134.666113] Subtest basic-with_two_bos: SUCCESS (0.007s) [134.794912] [135/165] (865s left) prime_vgem (basic-fence-flip) [134.877758] Starting subtest: basic-fence-flip [135.278541] Subtest basic-fence-flip: SUCCESS (0.401s) [135.390738] [136/165] (864s left) prime_vgem (basic-fence-mmap) [135.477553] Starting subtest: basic-fence-mmap [135.513620] Subtest basic-fence-mmap: SUCCESS (0.037s) [135.645672] [137/165] (864s left) prime_vgem (basic-fence-read) [135.724263] Starting subtest: basic-fence-read [135.756935] Subtest basic-fence-read: SUCCESS (0.032s) [135.884986] [138/165] (864s left) prime_vgem (basic-gtt) [135.949701] Starting subtest: basic-gtt [135.960165] Subtest basic-gtt: SUCCESS (0.010s) [136.085261] [139/165] (864s left) prime_vgem (basic-read) [136.176553] Starting subtest: basic-read [136.202726] Subtest basic-read: SUCCESS (0.026s) [136.324628] [140/165] (863s left) prime_vgem (basic-write) [136.405252] Starting subtest: basic-write [136.424736] Subtest basic-write: SUCCESS (0.019s) [136.519042] [141/165] (863s left) vgem_basic (setversion) [136.606551] Starting subtest: setversion [136.609088] Subtest setversion: SUCCESS (0.000s) [136.661964] [142/165] (863s left) vgem_basic (create) [136.725711] Starting subtest: create [136.728097] Subtest create: SUCCESS (0.001s) [136.781085] [143/165] (863s left) vgem_basic (debugfs) [136.847689] Starting subtest: debugfs [136.848904] Subtest debugfs: SUCCESS (0.000s) [136.900043] [144/165] (863s left) vgem_basic (dmabuf-export) [136.956788] Starting subtest: dmabuf-export [136.970000] Subtest dmabuf-export: SUCCESS (0.014s) [137.097750] [145/165] (863s left) vgem_basic (dmabuf-fence) [137.164583] Starting subtest: dmabuf-fence [137.165923] Subtest dmabuf-fence: SUCCESS (0.000s) [137.217214] [146/165] (863s left) vgem_basic (dmabuf-fence-before) [137.290457] Starting subtest: dmabuf-fence-before [137.291643] Subtest dmabuf-fence-before: SUCCESS (0.000s) [137.379957] [147/165] (863s left) vgem_basic (dmabuf-mmap) [137.448202] Starting subtest: dmabuf-mmap [137.457479] Subtest dmabuf-mmap: SUCCESS (0.010s) [137.507305] [148/165] (863s left) vgem_basic (mmap) [137.574186] Starting subtest: mmap [137.580122] Subtest mmap: SUCCESS (0.007s) [137.640172] [149/165] (862s left) vgem_basic (second-client) [137.731929] Starting subtest: second-client [137.765519] Subtest second-client: SUCCESS (0.033s) [137.854825] [150/165] (862s left) vgem_basic (sysfs) [137.924470] Starting subtest: sysfs [137.925997] Subtest sysfs: SUCCESS (0.000s) [137.976107] [151/165] (862s left) core_hotunplug (unbind-rebind) [138.074051] Starting subtest: unbind-rebind [141.019383] Subtest unbind-rebind: SUCCESS (2.946s) [141.035544] [152/165] (859s left) vgem_basic (unload) [141.076902] Starting subtest: unload [170.036983] Subtest unload: SUCCESS (28.956s) [170.132599] [153/165] (830s left) i915_module_load (reload) [170.200706] Starting subtest: reload [171.988663] Subtest reload: SUCCESS (1.788s) [172.004245] [154/165] (828s left) gem_lmem_swapping (basic) [172.053856] Subtest basic: SKIP (0.000s) [172.080510] [155/165] (828s left) gem_lmem_swapping (parallel-random-engines) [172.122800] Subtest parallel-random-engines: SKIP (0.000s) [172.147068] [156/165] (828s left) gem_lmem_swapping (random-engines) [172.195013] Subtest random-engines: SKIP (0.000s) [172.213799] [157/165] (828s left) gem_lmem_swapping (verify-random) [172.258560] Subtest verify-random: SKIP (0.000s) [172.289634] [158/165] (828s left) i915_pm_rpm (module-reload) [174.100096] Starting subtest: module-reload [179.664159] Subtest module-reload: SUCCESS (5.562s) [179.677978] [159/165] (821s left) i915_selftest (live) [179.730304] Starting subtest: live [179.731444] Starting dynamic subtest: sanitycheck [180.262134] Dynamic subtest sanitycheck: SUCCESS (0.529s) [180.268357] Starting dynamic subtest: uncore [180.797950] Dynamic subtest uncore: SUCCESS (0.536s) [180.805255] Starting dynamic subtest: workarounds [181.573727] Dynamic subtest workarounds: SUCCESS (0.775s) [181.581833] Starting dynamic subtest: gt_engines [182.577250] Dynamic subtest gt_engines: SUCCESS (1.002s) [182.583492] Starting dynamic subtest: gt_timelines [189.295936] Dynamic subtest gt_timelines: SUCCESS (6.718s) [189.302104] Starting dynamic subtest: gt_contexts [189.955174] Dynamic subtest gt_contexts: SUCCESS (0.658s) [189.964073] Starting dynamic subtest: gt_lrc [192.831757] Dynamic subtest gt_lrc: SUCCESS (2.876s) [192.837549] Starting dynamic subtest: gt_mocs [193.485049] Dynamic subtest gt_mocs: SUCCESS (0.652s) [193.491107] Starting dynamic subtest: gt_pm [215.631805] Dynamic subtest gt_pm: SUCCESS (22.146s) [215.637629] Starting dynamic subtest: gt_heartbeat [216.286926] Dynamic subtest gt_heartbeat: SUCCESS (0.654s) [216.292717] Starting dynamic subtest: gt_tlb [217.732108] Dynamic subtest gt_tlb: SUCCESS (1.443s) [217.737900] Starting dynamic subtest: requests [224.603262] Dynamic subtest requests: SUCCESS (6.871s) [224.609515] Starting dynamic subtest: migrate [227.996209] Dynamic subtest migrate: SUCCESS (3.392s) [228.003037] Starting dynamic subtest: active [228.557837] Dynamic subtest active: SUCCESS (0.561s) [228.563680] Starting dynamic subtest: objects [229.726900] Dynamic subtest objects: SUCCESS (1.168s) [229.734001] Starting dynamic subtest: mman [233.728805] Dynamic subtest mman: SUCCESS (4.001s) [233.734732] Starting dynamic subtest: dmabuf [234.364112] Dynamic subtest dmabuf: SUCCESS (0.634s) [234.370423] Starting dynamic subtest: vma [234.941864] Dynamic subtest vma: SUCCESS (0.577s) [234.947519] Starting dynamic subtest: coherency [236.845002] Dynamic subtest coherency: SUCCESS (1.902s) [236.850757] Starting dynamic subtest: gtt [244.810778] Dynamic subtest gtt: SUCCESS (7.965s) [244.818782] Starting dynamic subtest: gem [245.524756] Dynamic subtest gem: SUCCESS (0.713s) [245.530650] Starting dynamic subtest: evict [246.948070] Dynamic subtest evict: SUCCESS (1.422s) [246.954344] Starting dynamic subtest: hugepages [254.063947] Dynamic subtest hugepages: SUCCESS (7.115s) [254.070334] Starting dynamic subtest: gem_contexts [266.578843] Dynamic subtest gem_contexts: SUCCESS (12.513s) [266.584846] Starting dynamic subtest: client [267.174961] Dynamic subtest client: SUCCESS (0.596s) [267.181553] Starting dynamic subtest: gem_migrate [267.751060] Dynamic subtest gem_migrate: SUCCESS (0.575s) [267.758054] Starting dynamic subtest: reset [268.955901] Dynamic subtest reset: SUCCESS (1.204s) [268.962967] Starting dynamic subtest: memory_region [269.539428] Dynamic subtest memory_region: SUCCESS (0.582s) [269.547959] Starting dynamic subtest: hangcheck [313.232501] Dynamic subtest hangcheck: FAIL (43.623s) [313.237859] Starting dynamic subtest: execlists [321.713985] Dynamic subtest execlists: SUCCESS (8.547s) [321.719646] Starting dynamic subtest: ring_submission [322.236096] Dynamic subtest ring_submission: SUCCESS (0.520s) [322.242088] Starting dynamic subtest: perf [322.861142] Dynamic subtest perf: SUCCESS (0.625s) [322.867444] Starting dynamic subtest: slpc [323.441974] Dynamic subtest slpc: SUCCESS (0.580s) [323.450348] Starting dynamic subtest: guc [323.987753] Dynamic subtest guc: SUCCESS (0.545s) [323.993781] Starting dynamic subtest: guc_multi_lrc [324.547010] Dynamic subtest guc_multi_lrc: SUCCESS (0.558s) [324.553047] Starting dynamic subtest: guc_hang [325.092764] Dynamic subtest guc_hang: SUCCESS (0.545s) [325.099704] Starting dynamic subtest: late_gt_pm [325.683165] Dynamic subtest late_gt_pm: SUCCESS (0.588s) [325.684199] Subtest live: FAIL (145.951s) [325.712216] [160/165] (675s left) dmabuf (all-tests) [325.782512] Starting subtest: all-tests [325.783689] Starting dynamic subtest: sanitycheck [325.839535] Dynamic subtest sanitycheck: SUCCESS (0.059s) [325.868629] Starting dynamic subtest: dma_fence [326.025685] Dynamic subtest dma_fence: SUCCESS (0.182s) [326.036068] Starting dynamic subtest: dma_fence_chain [337.432607] Dynamic subtest dma_fence_chain: SUCCESS (11.405s) [337.444235] Starting dynamic subtest: dma_fence_unwrap [337.499551] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s) [337.527097] Starting dynamic subtest: dma_resv [337.581557] Dynamic subtest dma_resv: SUCCESS (0.078s) [337.582823] Subtest all-tests: SUCCESS (11.804s) [337.612949] [161/165] (663s left) i915_suspend (basic-s2idle-without-i915) [337.684133] Starting subtest: basic-s2idle-without-i915 [355.679504] Subtest basic-s2idle-without-i915: SUCCESS (2.122s) [363.833687] [162/165] (660s left) i915_suspend (basic-s3-without-i915) [363.882171] Starting subtest: basic-s3-without-i915 [382.908498] Subtest basic-s3-without-i915: SUCCESS (2.244s) [390.073902] [163/165] (658s left) gem_exec_suspend (basic-s0) [390.131492] Starting subtest: basic-S0 [390.132511] Starting dynamic subtest: smem [406.823320] Dynamic subtest smem: SUCCESS (1.705s) [406.824454] Subtest basic-S0: SUCCESS (1.706s) [414.988889] [164/165] (656s left) gem_exec_suspend (basic-s3) [415.040652] Starting subtest: basic-S3 [415.041686] Starting dynamic subtest: smem [434.008746] Dynamic subtest smem: SUCCESS (2.342s) [434.010221] Subtest basic-S3: SUCCESS (2.343s) [446.228664] [165/165] (654s left) kms_pipe_crc_basic (suspend-read-crc) [446.328038] Starting subtest: suspend-read-crc [446.329106] Starting dynamic subtest: pipe-A-HDMI-A-2 [465.983579] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.945s) [465.995836] Starting dynamic subtest: pipe-B-DP-2 [484.992541] Dynamic subtest pipe-B-DP-2: SUCCESS (1.744s) [485.004402] Starting dynamic subtest: pipe-C-HDMI-A-2 [504.001451] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.800s) [504.002576] Subtest suspend-read-crc: SUCCESS (5.497s) [509.089979] Closing watchdogs Done.