[43.588884] Initializing watchdogs [43.589189] /dev/watchdog0 [43.602462] [001/165] (960s left) i915_module_load (load) [43.700543] Starting subtest: load [45.978029] Subtest load: SUCCESS (2.277s) [46.007752] [002/165] (958s left) core_auth (basic-auth) [46.131663] Starting subtest: basic-auth [46.135611] Subtest basic-auth: SUCCESS (0.001s) [46.202300] [003/165] (957s left) debugfs_test (read_all_entries) [46.327691] Starting subtest: read_all_entries [46.463990] Subtest read_all_entries: SUCCESS (0.134s) [46.760462] [004/165] (957s left) debugfs_test (basic-hwmon) [46.830645] Starting subtest: basic-hwmon [46.836871] Subtest basic-hwmon: SKIP (0.000s) [47.111569] [005/165] (957s left) fbdev (eof) [47.194457] Starting subtest: eof [47.197510] Subtest eof: SUCCESS (0.001s) [47.246223] [006/165] (956s left) fbdev (info) [47.315101] Starting subtest: info [47.318148] Subtest info: SUCCESS (0.000s) [47.378205] [007/165] (956s left) fbdev (nullptr) [47.453849] Starting subtest: nullptr [47.457036] Subtest nullptr: SUCCESS (0.000s) [47.509775] [008/165] (956s left) fbdev (read) [47.594511] Starting subtest: read [47.898584] Subtest read: SUCCESS (0.257s) [48.419248] [009/165] (956s left) fbdev (write) [48.777873] Starting subtest: write [48.908640] Subtest write: SUCCESS (0.160s) [49.176473] [010/165] (955s left) gem_basic (bad-close) [49.262122] Starting subtest: bad-close [49.268307] Subtest bad-close: SUCCESS (0.000s) [49.340908] [011/165] (955s left) gem_basic (create-close) [49.445492] Starting subtest: create-close [49.451792] Subtest create-close: SUCCESS (0.000s) [49.524284] [012/165] (955s left) gem_basic (create-fd-close) [49.618273] Starting subtest: create-fd-close [49.625092] Subtest create-fd-close: SUCCESS (0.000s) [49.702802] [013/165] (955s left) gem_busy (busy@all-engines) [49.791978] Starting subtest: busy [49.795482] Starting dynamic subtest: all-engines [49.859151] Dynamic subtest all-engines: SUCCESS (0.067s) [49.862774] Subtest busy: SUCCESS (0.067s) [50.268415] [014/165] (954s left) gem_close_race (basic-process) [50.368957] Starting subtest: basic-process [50.428869] Subtest basic-process: SUCCESS (0.060s) [50.647620] [015/165] (954s left) gem_close_race (basic-threads) [50.751303] Starting subtest: basic-threads [51.907567] Subtest basic-threads: SUCCESS (1.155s) [52.117782] [016/165] (952s left) gem_ctx_create (basic) [52.226602] Starting subtest: basic [52.230489] Subtest basic: SUCCESS (0.000s) [52.435942] [017/165] (952s left) gem_ctx_create (basic-files) [52.532603] Starting subtest: basic-files [54.552256] Subtest basic-files: SUCCESS (2.020s) [54.792454] [018/165] (950s left) gem_ctx_exec (basic) [54.890181] Starting subtest: basic [54.893497] Subtest basic: SUCCESS (0.003s) [55.003904] [019/165] (950s left) gem_exec_basic (basic) [55.101777] Starting subtest: basic [55.104802] Starting dynamic subtest: rcs0-smem [55.108176] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [55.116733] Starting dynamic subtest: bcs0-smem [55.120177] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [55.128139] Starting dynamic subtest: vcs0-smem [55.131694] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [55.139960] Starting dynamic subtest: vcs1-smem [55.143632] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [55.151819] Starting dynamic subtest: vecs0-smem [55.155160] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [55.158835] Subtest basic: SUCCESS (0.006s) [55.320565] [020/165] (949s left) gem_exec_create (basic) [55.399302] Starting subtest: basic [55.402509] Starting dynamic subtest: smem [57.451578] Dynamic subtest smem: SUCCESS (2.052s) [57.455088] Subtest basic: SUCCESS (2.052s) [57.661329] [021/165] (947s left) gem_exec_fence (basic-busy) [57.876325] Starting subtest: basic-busy [57.882182] Starting dynamic subtest: rcs0 [57.910866] Dynamic subtest rcs0: SUCCESS (0.035s) [57.923157] Starting dynamic subtest: bcs0 [57.951656] Dynamic subtest bcs0: SUCCESS (0.041s) [57.964921] Starting dynamic subtest: vcs0 [57.984876] Dynamic subtest vcs0: SUCCESS (0.031s) [58.000085] Starting dynamic subtest: vcs1 [58.019650] Dynamic subtest vcs1: SUCCESS (0.037s) [58.028376] Starting dynamic subtest: vecs0 [58.047204] Dynamic subtest vecs0: SUCCESS (0.028s) [58.050616] Subtest basic-busy: SUCCESS (0.173s) [58.708331] [022/165] (946s left) gem_exec_fence (basic-wait) [58.936275] Starting subtest: basic-wait [58.940384] Starting dynamic subtest: rcs0 [58.963319] Dynamic subtest rcs0: SUCCESS (0.026s) [58.979735] Starting dynamic subtest: bcs0 [59.002306] Dynamic subtest bcs0: SUCCESS (0.040s) [59.020304] Starting dynamic subtest: vcs0 [59.029125] Dynamic subtest vcs0: SUCCESS (0.027s) [59.041384] Starting dynamic subtest: vcs1 [59.064269] Dynamic subtest vcs1: SUCCESS (0.035s) [59.073483] Starting dynamic subtest: vecs0 [59.088436] Dynamic subtest vecs0: SUCCESS (0.024s) [59.092099] Subtest basic-wait: SUCCESS (0.154s) [59.709661] [023/165] (945s left) gem_exec_fence (basic-await) [59.947985] Starting subtest: basic-await [59.951978] Starting dynamic subtest: rcs0 [60.058948] Dynamic subtest rcs0: SUCCESS (0.111s) [60.070076] Starting dynamic subtest: bcs0 [60.167030] Dynamic subtest bcs0: SUCCESS (0.106s) [60.178182] Starting dynamic subtest: vcs0 [60.277602] Dynamic subtest vcs0: SUCCESS (0.112s) [60.289306] Starting dynamic subtest: vcs1 [60.387804] Dynamic subtest vcs1: SUCCESS (0.110s) [60.401323] Starting dynamic subtest: vecs0 [60.492288] Dynamic subtest vecs0: SUCCESS (0.104s) [60.495920] Subtest basic-await: SUCCESS (0.545s) [61.123119] [024/165] (944s left) gem_exec_fence (nb-await) [61.401266] Starting subtest: nb-await [61.466107] Starting dynamic subtest: rcs0 [61.530489] Dynamic subtest rcs0: SUCCESS (0.066s) [61.594893] Starting dynamic subtest: bcs0 [61.659702] Dynamic subtest bcs0: SUCCESS (0.072s) [61.725234] Starting dynamic subtest: vcs0 [61.791702] Dynamic subtest vcs0: SUCCESS (0.071s) [61.859907] Starting dynamic subtest: vcs1 [61.926132] Dynamic subtest vcs1: SUCCESS (0.072s) [61.993220] Starting dynamic subtest: vecs0 [62.059242] Dynamic subtest vecs0: SUCCESS (0.070s) [62.125828] Subtest nb-await: SUCCESS (0.353s) [62.559639] [025/165] (943s left) gem_exec_gttfill (basic) [62.922658] Starting subtest: basic [67.321138] Subtest basic: SUCCESS (4.474s) [67.499512] [026/165] (938s left) gem_exec_parallel (engines) [67.662632] Starting subtest: engines [67.665960] Starting dynamic subtest: basic [69.668104] Dynamic subtest basic: SUCCESS (2.005s) [69.684586] Starting dynamic subtest: contexts [73.210990] Dynamic subtest contexts: SUCCESS (3.543s) [73.219902] Starting dynamic subtest: fds [78.910042] Dynamic subtest fds: SUCCESS (5.699s) [78.920082] Starting dynamic subtest: userptr [80.955855] Dynamic subtest userptr: SUCCESS (2.045s) [80.959265] Subtest engines: SUCCESS (13.293s) [81.189209] [027/165] (924s left) gem_exec_store (basic) [81.271309] Starting subtest: basic [81.321299] Subtest basic: SUCCESS (0.053s) [81.526276] [028/165] (924s left) gem_flink_basic (bad-flink) [81.602558] Starting subtest: bad-flink [81.606114] Subtest bad-flink: SUCCESS (0.000s) [81.664143] [029/165] (924s left) gem_flink_basic (bad-open) [81.733982] Starting subtest: bad-open [81.737317] Subtest bad-open: SUCCESS (0.000s) [81.801496] [030/165] (923s left) gem_flink_basic (basic) [81.882038] Starting subtest: basic [81.885290] Subtest basic: SUCCESS (0.000s) [81.977564] [031/165] (923s left) gem_flink_basic (double-flink) [82.066840] Starting subtest: double-flink [82.070227] Subtest double-flink: SUCCESS (0.000s) [82.176377] [032/165] (923s left) gem_flink_basic (flink-lifetime) [82.261175] Starting subtest: flink-lifetime [82.264299] Subtest flink-lifetime: SUCCESS (0.001s) [82.363151] [033/165] (923s left) gem_huc_copy (huc-copy) [82.435161] Starting subtest: huc-copy [82.441599] Subtest huc-copy: SKIP (0.000s) [82.551507] [034/165] (923s left) gem_linear_blits (basic) [82.760598] Starting subtest: basic [82.769030] Subtest basic: SUCCESS (0.007s) [82.932879] [035/165] (923s left) gem_mmap (basic) [83.130367] Starting subtest: basic [83.147259] Subtest basic: SUCCESS (0.000s) [83.235519] [036/165] (922s left) gem_mmap_gtt (basic) [83.316512] Starting subtest: basic [83.320108] Subtest basic: SUCCESS (0.001s) [83.393135] [037/165] (922s left) gem_render_linear_blits (basic) [83.470396] Starting subtest: basic [83.498634] Subtest basic: SUCCESS (0.031s) [83.546685] [038/165] (922s left) gem_render_tiled_blits (basic) [83.626932] Starting subtest: basic [83.666129] Subtest basic: SUCCESS (0.039s) [83.705256] [039/165] (922s left) gem_ringfill (basic-all) [84.014239] Starting subtest: basic-all [85.182948] Subtest basic-all: SUCCESS (1.180s) [85.284800] [040/165] (920s left) gem_softpin (allocator-basic) [85.378281] Starting subtest: allocator-basic [85.492651] Subtest allocator-basic: SUCCESS (0.115s) [85.601214] [041/165] (920s left) gem_softpin (allocator-basic-reserve) [85.692606] Starting subtest: allocator-basic-reserve [85.813637] Subtest allocator-basic-reserve: SUCCESS (0.122s) [85.931738] [042/165] (920s left) gem_softpin (safe-alignment) [86.024120] Starting subtest: safe-alignment [86.040218] Subtest safe-alignment: SUCCESS (0.015s) [86.154183] [043/165] (920s left) gem_sync (basic-all) [86.275081] Starting subtest: basic-all [88.561765] Subtest basic-all: SUCCESS (2.306s) [88.767685] [044/165] (917s left) gem_sync (basic-each) [88.859745] Starting subtest: basic-each [91.065418] Subtest basic-each: SUCCESS (2.222s) [91.271871] [045/165] (915s left) gem_tiled_blits (basic) [91.495015] Starting subtest: basic [91.517698] Subtest basic: SUCCESS (0.022s) [91.734227] [046/165] (914s left) gem_tiled_fence_blits (basic) [92.036463] Starting subtest: basic [92.045923] Subtest basic: SUCCESS (0.011s) [92.204329] [047/165] (914s left) gem_tiled_pread_basic [92.599665] [048/165] (913s left) gem_wait (busy@all-engines) [92.698990] Starting subtest: busy [92.702113] Starting dynamic subtest: all-engines [93.229246] Dynamic subtest all-engines: SUCCESS (0.529s) [93.232594] Subtest busy: SUCCESS (0.530s) [93.475503] [049/165] (912s left) gem_wait (wait@all-engines) [93.558774] Starting subtest: wait [93.562302] Starting dynamic subtest: all-engines [94.598947] Dynamic subtest all-engines: SUCCESS (1.039s) [94.603031] Subtest wait: SUCCESS (1.040s) [94.867273] [050/165] (911s left) i915_getparams_basic (basic-eu-total) [94.941548] Starting subtest: basic-eu-total [94.948351] Subtest basic-eu-total: SUCCESS (0.000s) [95.026784] [051/165] (911s left) i915_getparams_basic (basic-subslice-total) [95.108565] Starting subtest: basic-subslice-total [95.115312] Subtest basic-subslice-total: SUCCESS (0.000s) [95.191649] [052/165] (911s left) i915_hangman (error-state-basic) [95.275710] Starting subtest: error-state-basic [95.286263] Subtest error-state-basic: SUCCESS (0.010s) [95.356214] [053/165] (911s left) i915_pciid [95.509410] [054/165] (911s left) kms_addfb_basic (addfb25-4-tiled) [95.816955] Starting subtest: addfb25-4-tiled [95.819937] Subtest addfb25-4-tiled: SUCCESS (0.000s) [95.911378] [055/165] (910s left) kms_addfb_basic (addfb25-bad-modifier) [95.991455] Starting subtest: addfb25-bad-modifier [95.994636] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [96.295119] [056/165] (910s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [96.377915] Starting subtest: addfb25-framebuffer-vs-set-tiling [96.381537] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [96.666750] [057/165] (910s left) kms_addfb_basic (addfb25-modifier-no-flag) [96.751191] Starting subtest: addfb25-modifier-no-flag [96.754212] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [97.041312] [058/165] (909s left) kms_addfb_basic (addfb25-x-tiled-legacy) [97.114712] Starting subtest: addfb25-x-tiled-legacy [97.118092] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [97.398151] [059/165] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [97.476098] Starting subtest: addfb25-x-tiled-mismatch-legacy [97.479334] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [97.769134] [060/165] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [98.063111] Starting subtest: addfb25-yf-tiled-legacy [98.066093] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [98.148986] [061/165] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy) [98.441880] Starting subtest: addfb25-y-tiled-legacy [98.458180] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [98.536705] [062/165] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [98.828660] Starting subtest: addfb25-y-tiled-small-legacy [98.831467] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [98.925877] [063/165] (907s left) kms_addfb_basic (bad-pitch-0) [99.031297] Starting subtest: bad-pitch-0 [99.034576] Subtest bad-pitch-0: SUCCESS (0.000s) [99.330429] [064/165] (907s left) kms_addfb_basic (bad-pitch-1024) [99.424891] Starting subtest: bad-pitch-1024 [99.428142] Subtest bad-pitch-1024: SUCCESS (0.000s) [99.718428] [065/165] (907s left) kms_addfb_basic (bad-pitch-128) [99.813303] Starting subtest: bad-pitch-128 [99.816356] Subtest bad-pitch-128: SUCCESS (0.000s) [100.116890] [066/165] (906s left) kms_addfb_basic (bad-pitch-256) [100.203546] Starting subtest: bad-pitch-256 [100.206754] Subtest bad-pitch-256: SUCCESS (0.000s) [100.511575] [067/165] (906s left) kms_addfb_basic (bad-pitch-32) [100.619511] Starting subtest: bad-pitch-32 [100.623130] Subtest bad-pitch-32: SUCCESS (0.000s) [100.915071] [068/165] (906s left) kms_addfb_basic (bad-pitch-63) [100.990427] Starting subtest: bad-pitch-63 [100.993734] Subtest bad-pitch-63: SUCCESS (0.000s) [101.294385] [069/165] (905s left) kms_addfb_basic (bad-pitch-65536) [101.371238] Starting subtest: bad-pitch-65536 [101.374514] Subtest bad-pitch-65536: SUCCESS (0.000s) [101.663266] [070/165] (905s left) kms_addfb_basic (bad-pitch-999) [101.733399] Starting subtest: bad-pitch-999 [101.736515] Subtest bad-pitch-999: SUCCESS (0.000s) [102.030462] [071/165] (905s left) kms_addfb_basic (basic) [102.142919] Starting subtest: basic [102.146452] Subtest basic: SUCCESS (0.000s) [102.450285] [072/165] (904s left) kms_addfb_basic (basic-x-tiled-legacy) [102.541278] Starting subtest: basic-x-tiled-legacy [102.544591] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [102.846460] [073/165] (904s left) kms_addfb_basic (basic-y-tiled-legacy) [102.950861] Starting subtest: basic-y-tiled-legacy [102.953907] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [103.240309] [074/165] (903s left) kms_addfb_basic (bo-too-small) [103.518580] Starting subtest: bo-too-small [103.521420] Subtest bo-too-small: SUCCESS (0.000s) [103.610884] [075/165] (903s left) kms_addfb_basic (bo-too-small-due-to-tiling) [103.910661] Starting subtest: bo-too-small-due-to-tiling [103.913266] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [103.995966] [076/165] (903s left) kms_addfb_basic (clobberred-modifier) [104.095721] Starting subtest: clobberred-modifier [104.098780] Subtest clobberred-modifier: SUCCESS (0.000s) [104.380493] [077/165] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling) [104.449825] Starting subtest: framebuffer-vs-set-tiling [104.453222] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [104.753672] [078/165] (902s left) kms_addfb_basic (invalid-get-prop) [104.866027] Starting subtest: invalid-get-prop [104.869224] Subtest invalid-get-prop: SUCCESS (0.000s) [105.184734] [079/165] (902s left) kms_addfb_basic (invalid-get-prop-any) [105.273653] Starting subtest: invalid-get-prop-any [105.277332] Subtest invalid-get-prop-any: SUCCESS (0.000s) [105.561480] [080/165] (901s left) kms_addfb_basic (invalid-set-prop) [105.643208] Starting subtest: invalid-set-prop [105.646189] Subtest invalid-set-prop: SUCCESS (0.000s) [105.942413] [081/165] (901s left) kms_addfb_basic (invalid-set-prop-any) [106.046634] Starting subtest: invalid-set-prop-any [106.049631] Subtest invalid-set-prop-any: SUCCESS (0.000s) [106.370722] [082/165] (901s left) kms_addfb_basic (no-handle) [106.472031] Starting subtest: no-handle [106.475127] Subtest no-handle: SUCCESS (0.000s) [106.768120] [083/165] (900s left) kms_addfb_basic (size-max) [107.079638] Starting subtest: size-max [107.082588] Subtest size-max: SUCCESS (0.000s) [107.168137] [084/165] (900s left) kms_addfb_basic (small-bo) [107.467869] Starting subtest: small-bo [107.470640] Subtest small-bo: SUCCESS (0.000s) [107.546355] [085/165] (899s left) kms_addfb_basic (tile-pitch-mismatch) [107.619448] Starting subtest: tile-pitch-mismatch [107.622955] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [107.921259] [086/165] (899s left) kms_addfb_basic (too-high) [108.238085] Starting subtest: too-high [108.241210] Subtest too-high: SUCCESS (0.002s) [108.335125] [087/165] (899s left) kms_addfb_basic (too-wide) [108.645315] Starting subtest: too-wide [108.648830] Subtest too-wide: SUCCESS (0.000s) [108.732136] [088/165] (898s left) kms_addfb_basic (unused-handle) [108.806420] Starting subtest: unused-handle [108.809488] Subtest unused-handle: SUCCESS (0.000s) [109.097324] [089/165] (898s left) kms_addfb_basic (unused-modifier) [109.167566] Starting subtest: unused-modifier [109.170828] Subtest unused-modifier: SUCCESS (0.000s) [109.482575] [090/165] (898s left) kms_addfb_basic (unused-offsets) [109.554614] Starting subtest: unused-offsets [109.557792] Subtest unused-offsets: SUCCESS (0.000s) [109.841992] [091/165] (897s left) kms_addfb_basic (unused-pitches) [109.915499] Starting subtest: unused-pitches [109.918978] Subtest unused-pitches: SUCCESS (0.000s) [110.232557] [092/165] (897s left) kms_busy (basic) [110.523785] Starting subtest: basic [110.526806] Starting dynamic subtest: flip [111.404207] Dynamic subtest flip: SUCCESS (0.794s) [111.469219] Starting dynamic subtest: modeset [112.605394] Dynamic subtest modeset: SUCCESS (1.212s) [112.608582] Subtest basic: SUCCESS (2.010s) [112.942092] [093/165] (894s left) kms_prop_blob (basic) [113.039698] Starting subtest: basic [113.043348] Subtest basic: SUCCESS (0.000s) [113.133849] [094/165] (894s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [113.428934] Starting subtest: basic-busy-flip-before-cursor-atomic [113.434991] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [113.499994] [095/165] (894s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [113.782261] Starting subtest: basic-busy-flip-before-cursor-legacy [113.787792] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [113.851088] [096/165] (894s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [114.136592] Starting subtest: basic-flip-after-cursor-atomic [115.264821] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.039s) [115.814361] [097/165] (892s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [116.143985] Starting subtest: basic-flip-after-cursor-legacy [117.309535] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.063s) [117.814279] [098/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [118.104620] Starting subtest: basic-flip-after-cursor-varying-size [119.160637] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.054s) [119.564532] [099/165] (888s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [119.868917] Starting subtest: basic-flip-before-cursor-atomic [121.005301] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.062s) [121.528080] [100/165] (886s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [121.856603] Starting subtest: basic-flip-before-cursor-legacy [122.881221] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.036s) [123.316463] [101/165] (885s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [123.622308] Starting subtest: basic-flip-before-cursor-varying-size [124.705339] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.085s) [125.130243] [102/165] (883s left) kms_dsc (dsc-basic) [125.436663] Subtest dsc-basic: SKIP (0.000s) [125.478828] [103/165] (883s left) kms_flip (basic-flip-vs-dpms) [125.741173] Starting subtest: basic-flip-vs-dpms [125.744041] Starting dynamic subtest: A-DP1 [126.877528] Dynamic subtest A-DP1: SUCCESS (1.131s) [126.894889] Starting dynamic subtest: B-DP1 [127.916124] Dynamic subtest B-DP1: SUCCESS (1.030s) [127.933348] Starting dynamic subtest: C-DP1 [128.895483] Dynamic subtest C-DP1: SUCCESS (0.980s) [128.915626] Starting dynamic subtest: A-DP2 [129.675183] Dynamic subtest A-DP2: SUCCESS (0.777s) [129.687695] Starting dynamic subtest: B-DP2 [130.576449] Dynamic subtest B-DP2: SUCCESS (0.896s) [130.592377] Starting dynamic subtest: C-DP2 [131.328177] Dynamic subtest C-DP2: SUCCESS (0.749s) [131.330923] Subtest basic-flip-vs-dpms: SUCCESS (5.587s) [131.763752] [104/165] (876s left) kms_flip (basic-flip-vs-modeset) [132.041847] Starting subtest: basic-flip-vs-modeset [132.044420] Starting dynamic subtest: A-DP1 [133.184138] Dynamic subtest A-DP1: SUCCESS (1.138s) [133.200098] Starting dynamic subtest: B-DP1 [134.173948] Dynamic subtest B-DP1: SUCCESS (0.984s) [134.187399] Starting dynamic subtest: C-DP1 [135.133782] Dynamic subtest C-DP1: SUCCESS (0.959s) [135.151383] Starting dynamic subtest: A-DP2 [135.966246] Dynamic subtest A-DP2: SUCCESS (0.830s) [135.976320] Starting dynamic subtest: B-DP2 [136.663131] Dynamic subtest B-DP2: SUCCESS (0.696s) [136.674830] Starting dynamic subtest: C-DP2 [137.371255] Dynamic subtest C-DP2: SUCCESS (0.704s) [137.374438] Subtest basic-flip-vs-modeset: SUCCESS (5.334s) [137.795750] [105/165] (870s left) kms_flip (basic-flip-vs-wf_vblank) [138.067266] Starting subtest: basic-flip-vs-wf_vblank [138.070208] Starting dynamic subtest: A-DP1 [139.549643] Dynamic subtest A-DP1: SUCCESS (1.382s) [139.615547] Starting dynamic subtest: B-DP1 [140.603968] Dynamic subtest B-DP1: SUCCESS (1.139s) [140.617782] Starting dynamic subtest: C-DP1 [141.735822] Dynamic subtest C-DP1: SUCCESS (1.134s) [141.747185] Starting dynamic subtest: A-DP2 [142.783809] Dynamic subtest A-DP2: SUCCESS (1.045s) [142.813960] Starting dynamic subtest: B-DP2 [143.847836] Dynamic subtest B-DP2: SUCCESS (1.056s) [143.881078] Starting dynamic subtest: C-DP2 [144.932442] Dynamic subtest C-DP2: SUCCESS (1.075s) [144.935854] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.866s) [145.456300] [106/165] (863s left) kms_flip (basic-plain-flip) [145.728855] Starting subtest: basic-plain-flip [145.731967] Starting dynamic subtest: A-DP1 [146.697147] Dynamic subtest A-DP1: SUCCESS (0.958s) [146.723804] Starting dynamic subtest: B-DP1 [147.605501] Dynamic subtest B-DP1: SUCCESS (0.903s) [147.636432] Starting dynamic subtest: C-DP1 [148.477648] Dynamic subtest C-DP1: SUCCESS (0.860s) [148.502489] Starting dynamic subtest: A-DP2 [149.296937] Dynamic subtest A-DP2: SUCCESS (0.812s) [149.325697] Starting dynamic subtest: B-DP2 [150.086671] Dynamic subtest B-DP2: SUCCESS (0.790s) [150.119581] Starting dynamic subtest: C-DP2 [150.935105] Dynamic subtest C-DP2: SUCCESS (0.839s) [150.948615] Subtest basic-plain-flip: SUCCESS (5.213s) [151.464352] [107/165] (857s left) kms_force_connector_basic (force-connector-state) [151.598879] Starting subtest: force-connector-state [152.244755] Subtest force-connector-state: SUCCESS (0.646s) [153.203395] [108/165] (855s left) kms_force_connector_basic (force-edid) [153.343291] Starting subtest: force-edid [153.451143] Subtest force-edid: SUCCESS (0.106s) [153.986538] [109/165] (854s left) kms_force_connector_basic (force-load-detect) [154.158839] Starting subtest: force-load-detect [154.164460] Subtest force-load-detect: SKIP (0.000s) [154.484629] [110/165] (854s left) kms_force_connector_basic (prune-stale-modes) [154.646312] Starting subtest: prune-stale-modes [154.757848] Subtest prune-stale-modes: SUCCESS (0.111s) [155.284666] [111/165] (853s left) kms_frontbuffer_tracking (basic) [155.632270] Starting subtest: basic [158.385971] Subtest basic: SUCCESS (2.760s) [158.649844] [112/165] (850s left) kms_hdmi_inject (inject-audio) [158.855499] Starting subtest: inject-audio [159.047756] Subtest inject-audio: SUCCESS (0.191s) [159.695598] [113/165] (849s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [159.987038] Starting subtest: compare-crc-sanitycheck-xr24 [159.990080] Starting dynamic subtest: pipe-A-DP-1 [160.576156] Dynamic subtest pipe-A-DP-1: SUCCESS (0.583s) [160.590519] Starting dynamic subtest: pipe-B-DP-2 [161.052234] Dynamic subtest pipe-B-DP-2: SUCCESS (0.475s) [161.062876] Starting dynamic subtest: pipe-C-DP-1 [161.644026] Dynamic subtest pipe-C-DP-1: SUCCESS (0.558s) [161.647282] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.630s) [162.017397] [114/165] (847s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [162.315171] Starting subtest: compare-crc-sanitycheck-nv12 [162.319830] Starting dynamic subtest: pipe-A-DP-1 [162.969710] Dynamic subtest pipe-A-DP-1: SUCCESS (0.652s) [162.981449] Starting dynamic subtest: pipe-B-DP-2 [163.491046] Dynamic subtest pipe-B-DP-2: SUCCESS (0.517s) [163.504256] Starting dynamic subtest: pipe-C-DP-1 [163.510708] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [163.513906] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.182s) [163.883847] [115/165] (845s left) kms_pipe_crc_basic (hang-read-crc) [164.187888] Starting subtest: hang-read-crc [164.190847] Starting dynamic subtest: pipe-A-DP-1 [165.652037] Dynamic subtest pipe-A-DP-1: SUCCESS (1.367s) [165.722301] Starting dynamic subtest: pipe-B-DP-2 [166.722182] Dynamic subtest pipe-B-DP-2: SUCCESS (1.158s) [166.735527] Starting dynamic subtest: pipe-C-DP-1 [168.052053] Dynamic subtest pipe-C-DP-1: SUCCESS (1.325s) [168.055409] Subtest hang-read-crc: SUCCESS (3.864s) [168.442257] [116/165] (840s left) kms_pipe_crc_basic (nonblocking-crc) [168.753717] Starting subtest: nonblocking-crc [168.756588] Starting dynamic subtest: pipe-A-DP-1 [169.494902] Dynamic subtest pipe-A-DP-1: SUCCESS (0.736s) [169.509337] Starting dynamic subtest: pipe-B-DP-2 [170.158088] Dynamic subtest pipe-B-DP-2: SUCCESS (0.665s) [170.168214] Starting dynamic subtest: pipe-C-DP-1 [170.903549] Dynamic subtest pipe-C-DP-1: SUCCESS (0.737s) [170.907282] Subtest nonblocking-crc: SUCCESS (2.148s) [171.331162] [117/165] (837s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [171.634884] Starting subtest: nonblocking-crc-frame-sequence [171.637689] Starting dynamic subtest: pipe-A-DP-1 [172.373493] Dynamic subtest pipe-A-DP-1: SUCCESS (0.739s) [172.388401] Starting dynamic subtest: pipe-B-DP-2 [173.021093] Dynamic subtest pipe-B-DP-2: SUCCESS (0.642s) [173.031664] Starting dynamic subtest: pipe-C-DP-1 [173.732224] Dynamic subtest pipe-C-DP-1: SUCCESS (0.709s) [173.735554] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.099s) [174.122423] [118/165] (835s left) kms_pipe_crc_basic (read-crc) [174.424055] Starting subtest: read-crc [174.426873] Starting dynamic subtest: pipe-A-DP-1 [175.118119] Dynamic subtest pipe-A-DP-1: SUCCESS (0.689s) [175.134557] Starting dynamic subtest: pipe-B-DP-2 [175.714673] Dynamic subtest pipe-B-DP-2: SUCCESS (0.597s) [175.727587] Starting dynamic subtest: pipe-C-DP-1 [176.365508] Dynamic subtest pipe-C-DP-1: SUCCESS (0.643s) [176.369403] Subtest read-crc: SUCCESS (1.942s) [176.762216] [119/165] (832s left) kms_pipe_crc_basic (read-crc-frame-sequence) [177.060072] Starting subtest: read-crc-frame-sequence [177.062832] Starting dynamic subtest: pipe-A-DP-1 [177.763404] Dynamic subtest pipe-A-DP-1: SUCCESS (0.699s) [177.776777] Starting dynamic subtest: pipe-B-DP-2 [178.358981] Dynamic subtest pipe-B-DP-2: SUCCESS (0.594s) [178.370524] Starting dynamic subtest: pipe-C-DP-1 [179.007790] Dynamic subtest pipe-C-DP-1: SUCCESS (0.641s) [179.011419] Subtest read-crc-frame-sequence: SUCCESS (1.946s) [179.403057] [120/165] (829s left) kms_pm_backlight (basic-brightness) [179.723956] Subtest basic-brightness: SKIP (0.000s) [179.745282] [121/165] (829s left) kms_psr (primary_page_flip) [179.823300] Subtest primary_page_flip: SKIP (0.000s) [179.846107] [122/165] (829s left) kms_psr (cursor_plane_move) [179.915755] Subtest cursor_plane_move: SKIP (0.000s) [179.946162] [123/165] (829s left) kms_psr (sprite_plane_onoff) [180.029763] Subtest sprite_plane_onoff: SKIP (0.000s) [180.075635] [124/165] (829s left) kms_psr (primary_mmap_gtt) [180.159126] Subtest primary_mmap_gtt: SKIP (0.000s) [180.190520] [125/165] (829s left) kms_setmode (basic-clone-single-crtc) [180.272915] Starting subtest: basic-clone-single-crtc [180.490111] Subtest basic-clone-single-crtc: SKIP (0.211s) [180.898997] [126/165] (828s left) i915_pm_rpm (basic-pci-d3-state) [182.779552] Starting subtest: basic-pci-d3-state [183.660696] Subtest basic-pci-d3-state: SUCCESS (0.875s) [184.079492] [127/165] (825s left) i915_pm_rpm (basic-rte) [184.192868] Starting subtest: basic-rte [186.922158] Subtest basic-rte: SUCCESS (2.725s) [188.116229] [128/165] (821s left) i915_pm_rps (basic-api) [188.211338] Starting subtest: basic-api [188.214795] Subtest basic-api: SUCCESS (0.004s) [188.272519] [129/165] (821s left) prime_self_import (basic-llseek-bad) [188.338862] Starting subtest: basic-llseek-bad [188.345155] Subtest basic-llseek-bad: SUCCESS (0.003s) [188.424197] [130/165] (821s left) prime_self_import (basic-llseek-size) [188.492452] Starting subtest: basic-llseek-size [188.498979] Subtest basic-llseek-size: SUCCESS (0.002s) [188.594421] [131/165] (821s left) prime_self_import (basic-with_fd_dup) [188.676773] Starting subtest: basic-with_fd_dup [188.684169] Subtest basic-with_fd_dup: SUCCESS (0.004s) [188.794048] [132/165] (820s left) prime_self_import (basic-with_one_bo) [188.863058] Starting subtest: basic-with_one_bo [188.870355] Subtest basic-with_one_bo: SUCCESS (0.003s) [188.964620] [133/165] (820s left) prime_self_import (basic-with_one_bo_two_files) [189.041203] Starting subtest: basic-with_one_bo_two_files [189.048153] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [189.142412] [134/165] (820s left) prime_self_import (basic-with_two_bos) [189.212756] Starting subtest: basic-with_two_bos [189.220382] Subtest basic-with_two_bos: SUCCESS (0.007s) [189.318803] [135/165] (820s left) prime_vgem (basic-fence-flip) [189.413800] Starting subtest: basic-fence-flip [190.160581] Subtest basic-fence-flip: SUCCESS (0.652s) [190.468602] [136/165] (819s left) prime_vgem (basic-fence-mmap) [190.947255] Starting subtest: basic-fence-mmap [191.016065] Subtest basic-fence-mmap: SUCCESS (0.035s) [191.351698] [137/165] (818s left) prime_vgem (basic-fence-read) [191.462836] Starting subtest: basic-fence-read [191.510888] Subtest basic-fence-read: SUCCESS (0.048s) [191.604859] [138/165] (818s left) prime_vgem (basic-gtt) [191.699994] Starting subtest: basic-gtt [191.723692] Subtest basic-gtt: SUCCESS (0.024s) [191.829117] [139/165] (818s left) prime_vgem (basic-read) [191.926998] Starting subtest: basic-read [191.946594] Subtest basic-read: SUCCESS (0.021s) [192.065266] [140/165] (818s left) prime_vgem (basic-write) [192.161627] Starting subtest: basic-write [192.185188] Subtest basic-write: SUCCESS (0.026s) [192.276088] [141/165] (818s left) vgem_basic (setversion) [192.387503] Starting subtest: setversion [192.393418] Subtest setversion: SUCCESS (0.000s) [192.442701] [142/165] (818s left) vgem_basic (create) [192.525508] Starting subtest: create [192.529086] Subtest create: SUCCESS (0.000s) [192.585878] [143/165] (817s left) vgem_basic (debugfs) [192.671430] Starting subtest: debugfs [192.675069] Subtest debugfs: SUCCESS (0.000s) [192.744468] [144/165] (817s left) vgem_basic (dmabuf-export) [192.837671] Starting subtest: dmabuf-export [192.852926] Subtest dmabuf-export: SUCCESS (0.018s) [192.977162] [145/165] (817s left) vgem_basic (dmabuf-fence) [193.071638] Starting subtest: dmabuf-fence [193.075362] Subtest dmabuf-fence: SUCCESS (0.001s) [193.137107] [146/165] (817s left) vgem_basic (dmabuf-fence-before) [193.218727] Starting subtest: dmabuf-fence-before [193.222052] Subtest dmabuf-fence-before: SUCCESS (0.000s) [193.274438] [147/165] (817s left) vgem_basic (dmabuf-mmap) [193.354241] Starting subtest: dmabuf-mmap [193.366883] Subtest dmabuf-mmap: SUCCESS (0.013s) [193.424424] [148/165] (817s left) vgem_basic (mmap) [193.521661] Starting subtest: mmap [193.529674] Subtest mmap: SUCCESS (0.011s) [193.586354] [149/165] (817s left) vgem_basic (second-client) [193.658262] Starting subtest: second-client [193.692137] Subtest second-client: SUCCESS (0.033s) [193.770725] [150/165] (817s left) vgem_basic (sysfs) [193.871092] Starting subtest: sysfs [193.874797] Subtest sysfs: SUCCESS (0.001s) [193.938326] [151/165] (816s left) core_hotunplug (unbind-rebind) [194.052953] Starting subtest: unbind-rebind [197.688604] Subtest unbind-rebind: SUCCESS (3.634s) [197.710883] [152/165] (813s left) vgem_basic (unload) [197.785572] Starting subtest: unload [226.828500] Subtest unload: SUCCESS (29.039s) [226.949786] [153/165] (783s left) i915_module_load (reload) [227.019380] Starting subtest: reload [229.973663] Subtest reload: SUCCESS (2.957s) [229.999783] [154/165] (780s left) gem_lmem_swapping (basic) [230.126893] Subtest basic: SKIP (0.000s) [230.170892] [155/165] (780s left) gem_lmem_swapping (parallel-random-engines) [230.253408] Subtest parallel-random-engines: SKIP (0.000s) [230.316245] [156/165] (780s left) gem_lmem_swapping (random-engines) [230.432224] Subtest random-engines: SKIP (0.000s) [230.453173] [157/165] (780s left) gem_lmem_swapping (verify-random) [230.525473] Subtest verify-random: SKIP (0.000s) [230.566844] [158/165] (780s left) i915_pm_rpm (module-reload) [232.868228] Starting subtest: module-reload [244.411575] Subtest module-reload: SUCCESS (11.552s) [244.445719] [159/165] (766s left) i915_selftest (live) [244.542598] Starting subtest: live [244.545838] Starting dynamic subtest: sanitycheck [245.237955] Dynamic subtest sanitycheck: SUCCESS (0.695s) [245.247249] Starting dynamic subtest: uncore [245.951287] Dynamic subtest uncore: SUCCESS (0.709s) [245.961298] Starting dynamic subtest: workarounds [246.858929] Dynamic subtest workarounds: SUCCESS (0.908s) [246.869701] Starting dynamic subtest: gt_engines [248.107211] Dynamic subtest gt_engines: SUCCESS (1.244s) [248.116430] Starting dynamic subtest: gt_timelines [260.248346] Dynamic subtest gt_timelines: SUCCESS (12.141s) [260.259159] Starting dynamic subtest: gt_contexts [261.099191] Dynamic subtest gt_contexts: SUCCESS (0.847s) [261.107868] Starting dynamic subtest: gt_lrc [264.912964] Dynamic subtest gt_lrc: SUCCESS (3.814s) [264.922080] Starting dynamic subtest: gt_mocs [265.753069] Dynamic subtest gt_mocs: SUCCESS (0.838s) [265.763864] Starting dynamic subtest: gt_pm [272.429024] Dynamic subtest gt_pm: SUCCESS (6.674s) [272.437715] Starting dynamic subtest: gt_heartbeat [273.225023] Dynamic subtest gt_heartbeat: SUCCESS (0.794s) [273.234088] Starting dynamic subtest: gt_tlb [275.011538] Dynamic subtest gt_tlb: SUCCESS (1.743s) [275.078722] Starting dynamic subtest: requests [283.112048] Dynamic subtest requests: SUCCESS (8.140s) [283.121358] Starting dynamic subtest: migrate [286.568101] Dynamic subtest migrate: SUCCESS (3.454s) [286.576856] Starting dynamic subtest: active [287.309175] Dynamic subtest active: SUCCESS (0.740s) [287.318681] Starting dynamic subtest: objects [289.048240] Dynamic subtest objects: SUCCESS (1.735s) [289.056523] Starting dynamic subtest: mman [293.564991] Dynamic subtest mman: SUCCESS (4.518s) [293.575889] Starting dynamic subtest: dmabuf [294.328074] Dynamic subtest dmabuf: SUCCESS (0.761s) [294.337391] Starting dynamic subtest: vma [295.069487] Dynamic subtest vma: SUCCESS (0.739s) [295.079974] Starting dynamic subtest: coherency [296.715291] Dynamic subtest coherency: SUCCESS (1.641s) [296.726182] Starting dynamic subtest: gtt [304.621262] Dynamic subtest gtt: SUCCESS (7.905s) [304.630573] Starting dynamic subtest: gem [305.503229] Dynamic subtest gem: SUCCESS (0.882s) [305.513376] Starting dynamic subtest: evict [307.955860] Dynamic subtest evict: SUCCESS (2.451s) [307.964220] Starting dynamic subtest: hugepages [315.128110] Dynamic subtest hugepages: SUCCESS (7.171s) [315.137105] Starting dynamic subtest: gem_contexts [331.654491] Dynamic subtest gem_contexts: SUCCESS (16.524s) [331.664765] Starting dynamic subtest: client [332.410110] Dynamic subtest client: SUCCESS (0.754s) [332.421380] Starting dynamic subtest: gem_migrate [333.077218] Dynamic subtest gem_migrate: SUCCESS (0.663s) [333.086670] Starting dynamic subtest: reset [334.605239] Dynamic subtest reset: SUCCESS (1.526s) [334.616169] Starting dynamic subtest: memory_region [335.295189] Dynamic subtest memory_region: SUCCESS (0.688s) [335.304128] Starting dynamic subtest: hangcheck [364.562315] Dynamic subtest hangcheck: SUCCESS (29.267s) [364.573337] Starting dynamic subtest: execlists [377.663381] Dynamic subtest execlists: SUCCESS (13.099s) [377.672550] Starting dynamic subtest: ring_submission [378.399100] Dynamic subtest ring_submission: SUCCESS (0.734s) [378.408032] Starting dynamic subtest: perf [379.201143] Dynamic subtest perf: SUCCESS (0.801s) [379.211124] Starting dynamic subtest: slpc [379.893236] Dynamic subtest slpc: SUCCESS (0.687s) [379.903447] Starting dynamic subtest: guc [380.583039] Dynamic subtest guc: SUCCESS (0.691s) [380.594032] Starting dynamic subtest: guc_multi_lrc [381.305118] Dynamic subtest guc_multi_lrc: SUCCESS (0.720s) [381.314720] Starting dynamic subtest: guc_hang [382.008175] Dynamic subtest guc_hang: SUCCESS (0.701s) [382.018300] Starting dynamic subtest: late_gt_pm [382.757223] Dynamic subtest late_gt_pm: SUCCESS (0.747s) [382.760755] Subtest live: SUCCESS (138.216s) [382.786468] [160/165] (628s left) dmabuf (all-tests) [382.869605] Starting subtest: all-tests [382.876657] Starting dynamic subtest: sanitycheck [382.944287] Dynamic subtest sanitycheck: SUCCESS (0.073s) [382.969383] Starting dynamic subtest: dma_fence [383.137566] Dynamic subtest dma_fence: SUCCESS (0.190s) [383.149192] Starting dynamic subtest: dma_fence_chain [398.269236] Dynamic subtest dma_fence_chain: SUCCESS (15.129s) [398.287472] Starting dynamic subtest: dma_fence_unwrap [398.351126] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s) [398.370605] Starting dynamic subtest: dma_resv [398.426049] Dynamic subtest dma_resv: SUCCESS (0.072s) [398.430164] Subtest all-tests: SUCCESS (15.558s) [398.467961] [161/165] (612s left) i915_suspend (basic-s2idle-without-i915) [398.559722] Starting subtest: basic-s2idle-without-i915 [418.009952] Subtest basic-s2idle-without-i915: SUCCESS (3.675s) [421.663162] [162/165] (608s left) i915_suspend (basic-s3-without-i915) [421.740951] Starting subtest: basic-s3-without-i915 [440.756800] Subtest basic-s3-without-i915: SUCCESS (3.230s) [444.402297] [163/165] (604s left) gem_exec_suspend (basic-s0) [444.502711] Starting subtest: basic-S0 [444.505773] Starting dynamic subtest: smem [463.149035] Dynamic subtest smem: SUCCESS (2.846s) [463.152537] Subtest basic-S0: SUCCESS (2.848s) [465.782811] [164/165] (601s left) gem_exec_suspend (basic-s3) [465.888063] Starting subtest: basic-S3 [465.891545] Starting dynamic subtest: smem [485.798638] Dynamic subtest smem: SUCCESS (3.522s) [485.802073] Subtest basic-S3: SUCCESS (3.524s) [488.978606] [165/165] (597s left) kms_pipe_crc_basic (suspend-read-crc) [489.286643] Starting subtest: suspend-read-crc [489.289831] Starting dynamic subtest: pipe-A-DP-1 [508.719051] Dynamic subtest pipe-A-DP-1: SUCCESS (2.906s) [508.732854] Starting dynamic subtest: pipe-B-DP-2 [527.702917] Dynamic subtest pipe-B-DP-2: SUCCESS (2.775s) [527.715008] Starting dynamic subtest: pipe-C-DP-1 [546.720900] Dynamic subtest pipe-C-DP-1: SUCCESS (2.786s) [546.724243] Subtest suspend-read-crc: SUCCESS (8.475s) [550.078620] Closing watchdogs Done.