[38.869585] Initializing watchdogs [38.869637] /dev/watchdog0 [38.875038] [001/171] (960s left) i915_module_load (load) [38.917121] Starting subtest: load [52.485156] Subtest load: SUCCESS (13.568s) [52.497649] [002/171] (946s left) core_auth (basic-auth) [52.551714] Starting subtest: basic-auth [52.552735] Subtest basic-auth: SUCCESS (0.000s) [52.638994] [003/171] (946s left) debugfs_test (read_all_entries) [52.680051] Starting subtest: read_all_entries [52.980112] Subtest read_all_entries: SUCCESS (0.299s) [56.961433] [004/171] (942s left) debugfs_test (basic-hwmon) [56.998032] Starting subtest: basic-hwmon [56.999385] Subtest basic-hwmon: SKIP (0.000s) [60.950454] [005/171] (938s left) fbdev (eof) [61.002805] Starting subtest: eof [61.003879] Subtest eof: SUCCESS (0.000s) [61.086286] [006/171] (938s left) fbdev (info) [61.120303] Starting subtest: info [61.121254] Subtest info: SUCCESS (0.000s) [61.219494] [007/171] (938s left) fbdev (nullptr) [61.269390] Starting subtest: nullptr [61.270246] Subtest nullptr: SUCCESS (0.000s) [61.351319] [008/171] (938s left) fbdev (read) [61.403053] Starting subtest: read [69.707025] Subtest read: SUCCESS (8.269s) [69.769541] [009/171] (929s left) fbdev (write) [69.820015] Starting subtest: write [75.153638] Subtest write: SUCCESS (5.334s) [75.252493] [010/171] (924s left) gem_basic (bad-close) [75.287946] Starting subtest: bad-close [75.289606] Subtest bad-close: SUCCESS (0.000s) [75.375141] [011/171] (924s left) gem_basic (create-close) [75.412512] Starting subtest: create-close [75.414105] Subtest create-close: SUCCESS (0.000s) [75.522335] [012/171] (923s left) gem_basic (create-fd-close) [75.557376] Starting subtest: create-fd-close [75.559047] Subtest create-fd-close: SUCCESS (0.000s) [75.655965] [013/171] (923s left) gem_busy (busy@all-engines) [75.699130] Starting subtest: busy [75.700047] Starting dynamic subtest: all-engines [75.720090] Dynamic subtest all-engines: SUCCESS (0.021s) [75.720887] Subtest busy: SUCCESS (0.021s) [76.076887] [014/171] (923s left) gem_close_race (basic-process) [76.121103] Starting subtest: basic-process [76.154624] Subtest basic-process: SUCCESS (0.033s) [76.358531] [015/171] (923s left) gem_close_race (basic-threads) [76.401881] Starting subtest: basic-threads [77.601156] Subtest basic-threads: SUCCESS (1.199s) [77.805099] [016/171] (921s left) gem_ctx_create (basic) [77.847012] Starting subtest: basic [77.848064] Subtest basic: SUCCESS (0.000s) [78.050316] [017/171] (921s left) gem_ctx_create (basic-files) [78.093142] Starting subtest: basic-files [80.101541] Subtest basic-files: SUCCESS (2.009s) [80.397199] [018/171] (919s left) gem_ctx_exec (basic) [80.438357] Starting subtest: basic [80.440194] Subtest basic: SUCCESS (0.003s) [80.548459] [019/171] (919s left) gem_exec_basic (basic) [80.588640] Starting subtest: basic [80.589468] Starting dynamic subtest: rcs0-smem [80.590321] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [80.593948] Starting dynamic subtest: bcs0-smem [80.594857] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [80.598168] Starting dynamic subtest: vcs0-smem [80.598958] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [80.602296] Starting dynamic subtest: vcs1-smem [80.603241] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [80.606767] Starting dynamic subtest: vecs0-smem [80.607697] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [80.608568] Subtest basic: SUCCESS (0.002s) [80.792398] [020/171] (918s left) gem_exec_create (basic) [80.833052] Starting subtest: basic [80.833980] Starting dynamic subtest: smem [82.919630] Dynamic subtest smem: SUCCESS (2.086s) [82.920870] Subtest basic: SUCCESS (2.086s) [83.127417] [021/171] (916s left) gem_exec_fence (basic-busy) [83.298918] Starting subtest: basic-busy [83.300154] Starting dynamic subtest: rcs0 [83.362772] Dynamic subtest rcs0: SUCCESS (0.073s) [83.371353] Starting dynamic subtest: bcs0 [83.410545] Dynamic subtest bcs0: SUCCESS (0.047s) [83.422529] Starting dynamic subtest: vcs0 [83.462304] Dynamic subtest vcs0: SUCCESS (0.051s) [83.474731] Starting dynamic subtest: vcs1 [83.510304] Dynamic subtest vcs1: SUCCESS (0.048s) [83.522068] Starting dynamic subtest: vecs0 [83.559197] Dynamic subtest vecs0: SUCCESS (0.048s) [83.561336] Subtest basic-busy: SUCCESS (0.269s) [84.081147] [022/171] (915s left) gem_exec_fence (basic-wait) [84.250043] Starting subtest: basic-wait [84.251128] Starting dynamic subtest: rcs0 [84.311565] Dynamic subtest rcs0: SUCCESS (0.069s) [84.324517] Starting dynamic subtest: bcs0 [84.359746] Dynamic subtest bcs0: SUCCESS (0.048s) [84.371952] Starting dynamic subtest: vcs0 [84.409098] Dynamic subtest vcs0: SUCCESS (0.049s) [84.417512] Starting dynamic subtest: vcs1 [84.457697] Dynamic subtest vcs1: SUCCESS (0.048s) [84.470153] Starting dynamic subtest: vecs0 [84.505824] Dynamic subtest vecs0: SUCCESS (0.048s) [84.507717] Subtest basic-wait: SUCCESS (0.264s) [85.009090] [023/171] (914s left) gem_exec_fence (basic-await) [85.173206] Starting subtest: basic-await [85.173932] Starting dynamic subtest: rcs0 [85.235300] Dynamic subtest rcs0: SUCCESS (0.070s) [85.245639] Starting dynamic subtest: bcs0 [85.309388] Dynamic subtest bcs0: SUCCESS (0.074s) [85.316223] Starting dynamic subtest: vcs0 [85.381439] Dynamic subtest vcs0: SUCCESS (0.071s) [85.388085] Starting dynamic subtest: vcs1 [85.450203] Dynamic subtest vcs1: SUCCESS (0.070s) [85.455792] Starting dynamic subtest: vecs0 [85.519444] Dynamic subtest vecs0: SUCCESS (0.068s) [85.522130] Subtest basic-await: SUCCESS (0.354s) [86.031903] [024/171] (913s left) gem_exec_fence (nb-await) [86.202778] Starting subtest: nb-await [86.204158] Starting dynamic subtest: rcs0 [86.252522] Dynamic subtest rcs0: SUCCESS (0.057s) [86.265766] Starting dynamic subtest: bcs0 [86.315366] Dynamic subtest bcs0: SUCCESS (0.063s) [86.321867] Starting dynamic subtest: vcs0 [86.373783] Dynamic subtest vcs0: SUCCESS (0.057s) [86.386812] Starting dynamic subtest: vcs1 [86.437979] Dynamic subtest vcs1: SUCCESS (0.064s) [86.447590] Starting dynamic subtest: vecs0 [86.498713] Dynamic subtest vecs0: SUCCESS (0.060s) [86.501947] Subtest nb-await: SUCCESS (0.304s) [87.004720] [025/171] (912s left) gem_exec_gttfill (basic) [87.048598] Starting subtest: basic [89.378795] Subtest basic: SUCCESS (2.330s) [89.572669] [026/171] (910s left) gem_exec_parallel (engines) [89.650719] Starting subtest: engines [89.651501] Starting dynamic subtest: basic [91.094657] Dynamic subtest basic: SUCCESS (1.444s) [91.102978] Starting dynamic subtest: contexts [92.842622] Dynamic subtest contexts: SUCCESS (1.739s) [92.847069] Starting dynamic subtest: fds [94.708828] Dynamic subtest fds: SUCCESS (1.866s) [94.713120] Starting dynamic subtest: userptr [96.087581] Dynamic subtest userptr: SUCCESS (1.387s) [96.088777] Subtest engines: SUCCESS (6.437s) [96.292427] [027/171] (903s left) gem_exec_store (basic) [96.333390] Starting subtest: basic [96.407356] Subtest basic: SUCCESS (0.073s) [96.610497] [028/171] (903s left) gem_flink_basic (bad-flink) [96.653658] Starting subtest: bad-flink [96.654662] Subtest bad-flink: SUCCESS (0.000s) [96.740192] [029/171] (902s left) gem_flink_basic (bad-open) [96.775979] Starting subtest: bad-open [96.776801] Subtest bad-open: SUCCESS (0.000s) [96.857547] [030/171] (902s left) gem_flink_basic (basic) [96.894051] Starting subtest: basic [96.894723] Subtest basic: SUCCESS (0.000s) [96.993676] [031/171] (902s left) gem_flink_basic (double-flink) [97.032952] Starting subtest: double-flink [97.033952] Subtest double-flink: SUCCESS (0.000s) [97.123686] [032/171] (902s left) gem_flink_basic (flink-lifetime) [97.159804] Starting subtest: flink-lifetime [97.160720] Subtest flink-lifetime: SUCCESS (0.001s) [97.263443] [033/171] (902s left) gem_huc_copy (huc-copy) [97.306019] Starting subtest: huc-copy [97.307787] Subtest huc-copy: SUCCESS (0.002s) [97.424691] [034/171] (902s left) gem_linear_blits (basic) [97.519316] Starting subtest: basic [97.523621] Subtest basic: SUCCESS (0.004s) [97.661534] [035/171] (902s left) gem_mmap (basic) [97.737259] Starting subtest: basic [97.740812] Subtest basic: SUCCESS (0.000s) [97.845339] [036/171] (901s left) gem_mmap_gtt (basic) [97.882776] Starting subtest: basic [97.883828] Subtest basic: SUCCESS (0.000s) [97.946606] [037/171] (901s left) gem_render_linear_blits (basic) [97.985629] Starting subtest: basic [98.004191] Subtest basic: SUCCESS (0.019s) [98.079248] [038/171] (901s left) gem_render_tiled_blits (basic) [98.116628] Starting subtest: basic [98.142047] Subtest basic: SUCCESS (0.025s) [98.230684] [039/171] (901s left) gem_ringfill (basic-all) [98.567183] Starting subtest: basic-all [99.712672] Subtest basic-all: SUCCESS (1.140s) [99.826120] [040/171] (899s left) gem_softpin (allocator-basic) [99.866300] Starting subtest: allocator-basic [99.912385] Subtest allocator-basic: SUCCESS (0.046s) [100.042631] [041/171] (899s left) gem_softpin (allocator-basic-reserve) [100.080962] Starting subtest: allocator-basic-reserve [100.125301] Subtest allocator-basic-reserve: SUCCESS (0.044s) [100.247388] [042/171] (899s left) gem_softpin (safe-alignment) [100.284999] Starting subtest: safe-alignment [100.291880] Subtest safe-alignment: SUCCESS (0.007s) [100.407488] [043/171] (899s left) gem_sync (basic-all) [100.451424] Starting subtest: basic-all [102.807452] Subtest basic-all: SUCCESS (2.355s) [103.012690] [044/171] (896s left) gem_sync (basic-each) [103.056924] Starting subtest: basic-each [105.267397] Subtest basic-each: SUCCESS (2.209s) [105.468019] [045/171] (894s left) gem_tiled_blits (basic) [105.568895] Starting subtest: basic [105.578847] Subtest basic: SUCCESS (0.010s) [105.711433] [046/171] (894s left) gem_tiled_fence_blits (basic) [105.847743] Starting subtest: basic [105.923606] Subtest basic: SUCCESS (0.076s) [106.061390] [047/171] (893s left) gem_tiled_pread_basic [106.186386] [048/171] (893s left) gem_wait (busy@all-engines) [106.230965] Starting subtest: busy [106.231787] Starting dynamic subtest: all-engines [106.780763] Dynamic subtest all-engines: SUCCESS (0.549s) [106.782416] Subtest busy: SUCCESS (0.549s) [106.999273] [049/171] (892s left) gem_wait (wait@all-engines) [107.042706] Starting subtest: wait [107.043588] Starting dynamic subtest: all-engines [108.092680] Dynamic subtest all-engines: SUCCESS (1.049s) [108.094669] Subtest wait: SUCCESS (1.049s) [108.314475] [050/171] (891s left) i915_getparams_basic (basic-eu-total) [108.350099] Starting subtest: basic-eu-total [108.351362] Subtest basic-eu-total: SUCCESS (0.000s) [108.425214] [051/171] (891s left) i915_getparams_basic (basic-subslice-total) [108.460573] Starting subtest: basic-subslice-total [108.462201] Subtest basic-subslice-total: SUCCESS (0.000s) [108.542379] [052/171] (891s left) i915_hangman (error-state-basic) [108.583392] Starting subtest: error-state-basic [108.774534] Subtest error-state-basic: SUCCESS (0.191s) [108.867710] [053/171] (891s left) i915_pciid [108.993322] [054/171] (890s left) kms_addfb_basic (addfb25-bad-modifier) [109.031053] Starting subtest: addfb25-bad-modifier [109.032048] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [112.908414] [055/171] (887s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [112.944948] Starting subtest: addfb25-framebuffer-vs-set-tiling [112.945890] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [116.822113] [056/171] (883s left) kms_addfb_basic (addfb25-modifier-no-flag) [116.859212] Starting subtest: addfb25-modifier-no-flag [116.860048] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [120.727952] [057/171] (879s left) kms_addfb_basic (addfb25-x-tiled-legacy) [120.764146] Starting subtest: addfb25-x-tiled-legacy [120.764841] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [124.646321] [058/171] (875s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [124.682460] Starting subtest: addfb25-x-tiled-mismatch-legacy [124.683122] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [128.553203] [059/171] (871s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [132.352710] Starting subtest: addfb25-yf-tiled-legacy [132.353404] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [132.455617] [060/171] (867s left) kms_addfb_basic (addfb25-y-tiled-legacy) [136.261519] Starting subtest: addfb25-y-tiled-legacy [136.262541] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [136.378272] [061/171] (863s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [140.187962] Starting subtest: addfb25-y-tiled-small-legacy [140.188834] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [140.294111] [062/171] (859s left) kms_addfb_basic (bad-pitch-0) [140.329544] Starting subtest: bad-pitch-0 [140.330292] Subtest bad-pitch-0: SUCCESS (0.000s) [144.230865] [063/171] (855s left) kms_addfb_basic (bad-pitch-1024) [144.266523] Starting subtest: bad-pitch-1024 [144.267283] Subtest bad-pitch-1024: SUCCESS (0.000s) [148.154223] [064/171] (851s left) kms_addfb_basic (bad-pitch-128) [148.194387] Starting subtest: bad-pitch-128 [148.195169] Subtest bad-pitch-128: SUCCESS (0.000s) [152.094492] [065/171] (847s left) kms_addfb_basic (bad-pitch-256) [152.129798] Starting subtest: bad-pitch-256 [152.130578] Subtest bad-pitch-256: SUCCESS (0.000s) [156.031077] [066/171] (844s left) kms_addfb_basic (bad-pitch-32) [156.069778] Starting subtest: bad-pitch-32 [156.070800] Subtest bad-pitch-32: SUCCESS (0.000s) [159.939166] [067/171] (840s left) kms_addfb_basic (bad-pitch-63) [159.977250] Starting subtest: bad-pitch-63 [159.978036] Subtest bad-pitch-63: SUCCESS (0.000s) [163.855370] [068/171] (836s left) kms_addfb_basic (bad-pitch-65536) [163.892973] Starting subtest: bad-pitch-65536 [163.893632] Subtest bad-pitch-65536: SUCCESS (0.000s) [167.764869] [069/171] (832s left) kms_addfb_basic (bad-pitch-999) [167.802324] Starting subtest: bad-pitch-999 [167.803071] Subtest bad-pitch-999: SUCCESS (0.000s) [171.672358] [070/171] (828s left) kms_addfb_basic (basic) [171.710644] Starting subtest: basic [171.711563] Subtest basic: SUCCESS (0.000s) [175.594545] [071/171] (824s left) kms_addfb_basic (basic-x-tiled-legacy) [175.631189] Starting subtest: basic-x-tiled-legacy [175.632059] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [179.505850] [072/171] (820s left) kms_addfb_basic (basic-y-tiled-legacy) [179.542141] Starting subtest: basic-y-tiled-legacy [179.543481] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [183.413478] [073/171] (816s left) kms_addfb_basic (bo-too-small) [187.214801] Starting subtest: bo-too-small [187.215563] Subtest bo-too-small: SUCCESS (0.000s) [187.337604] [074/171] (812s left) kms_addfb_basic (bo-too-small-due-to-tiling) [191.140216] Starting subtest: bo-too-small-due-to-tiling [191.140978] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [191.260966] [075/171] (808s left) kms_addfb_basic (clobberred-modifier) [191.298241] Starting subtest: clobberred-modifier [191.298993] Subtest clobberred-modifier: SUCCESS (0.000s) [195.173274] [076/171] (805s left) kms_addfb_basic (framebuffer-vs-set-tiling) [195.210522] Starting subtest: framebuffer-vs-set-tiling [195.211219] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [199.083395] [077/171] (801s left) kms_addfb_basic (invalid-get-prop) [199.120223] Starting subtest: invalid-get-prop [199.120989] Subtest invalid-get-prop: SUCCESS (0.000s) [202.990422] [078/171] (797s left) kms_addfb_basic (invalid-get-prop-any) [203.027998] Starting subtest: invalid-get-prop-any [203.028850] Subtest invalid-get-prop-any: SUCCESS (0.000s) [206.904542] [079/171] (793s left) kms_addfb_basic (invalid-set-prop) [206.941691] Starting subtest: invalid-set-prop [206.942645] Subtest invalid-set-prop: SUCCESS (0.000s) [210.807542] [080/171] (789s left) kms_addfb_basic (invalid-set-prop-any) [210.844636] Starting subtest: invalid-set-prop-any [210.845571] Subtest invalid-set-prop-any: SUCCESS (0.000s) [214.718915] [081/171] (785s left) kms_addfb_basic (no-handle) [214.755335] Starting subtest: no-handle [214.756042] Subtest no-handle: SUCCESS (0.000s) [218.637929] [082/171] (781s left) kms_addfb_basic (size-max) [222.437711] Starting subtest: size-max [222.438570] Subtest size-max: SUCCESS (0.000s) [222.553855] [083/171] (777s left) kms_addfb_basic (small-bo) [226.357492] Starting subtest: small-bo [226.358275] Subtest small-bo: SUCCESS (0.000s) [226.464560] [084/171] (773s left) kms_addfb_basic (tile-pitch-mismatch) [226.500671] Starting subtest: tile-pitch-mismatch [226.501491] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [230.368889] [085/171] (769s left) kms_addfb_basic (too-high) [234.163091] Starting subtest: too-high [234.163910] Subtest too-high: SUCCESS (0.001s) [234.278079] [086/171] (766s left) kms_addfb_basic (too-wide) [238.082286] Starting subtest: too-wide [238.083062] Subtest too-wide: SUCCESS (0.000s) [238.184482] [087/171] (762s left) kms_addfb_basic (unused-handle) [238.222019] Starting subtest: unused-handle [238.223131] Subtest unused-handle: SUCCESS (0.000s) [242.104353] [088/171] (758s left) kms_addfb_basic (unused-modifier) [242.141207] Starting subtest: unused-modifier [242.142205] Subtest unused-modifier: SUCCESS (0.000s) [246.013576] [089/171] (754s left) kms_addfb_basic (unused-offsets) [246.050647] Starting subtest: unused-offsets [246.051514] Subtest unused-offsets: SUCCESS (0.000s) [249.920867] [090/171] (750s left) kms_addfb_basic (unused-pitches) [249.957814] Starting subtest: unused-pitches [249.958513] Subtest unused-pitches: SUCCESS (0.000s) [253.826314] [091/171] (746s left) kms_busy (basic) [257.632830] Starting subtest: basic [257.633796] Starting dynamic subtest: flip [259.715011] Dynamic subtest flip: SUCCESS (2.081s) [259.719820] Starting dynamic subtest: modeset [263.460994] Dynamic subtest modeset: SUCCESS (3.745s) [263.461960] Subtest basic: SUCCESS (5.827s) [264.504174] [092/171] (735s left) kms_chamelium_hpd (dp-hpd-fast) [268.680169] Subtest dp-hpd-fast: SKIP (0.000s) [269.610570] [093/171] (730s left) kms_chamelium_edid (dp-edid-read) [273.777851] Subtest dp-edid-read: SKIP (0.000s) [274.691593] [094/171] (725s left) kms_chamelium_frames (dp-crc-fast) [278.842595] Subtest dp-crc-fast: SKIP (0.000s) [279.771183] [095/171] (720s left) kms_chamelium_hpd (hdmi-hpd-fast) [283.922709] Subtest hdmi-hpd-fast: SKIP (0.000s) [284.858505] [096/171] (715s left) kms_chamelium_edid (hdmi-edid-read) [289.018833] Subtest hdmi-edid-read: SKIP (0.000s) [289.932394] [097/171] (710s left) kms_chamelium_frames (hdmi-crc-fast) [294.082897] Subtest hdmi-crc-fast: SKIP (0.000s) [295.011317] [098/171] (705s left) kms_chamelium_hpd (vga-hpd-fast) [299.159921] Subtest vga-hpd-fast: SKIP (0.000s) [300.089450] [099/171] (700s left) kms_chamelium_edid (vga-edid-read) [304.238599] Subtest vga-edid-read: SKIP (0.000s) [305.165075] [100/171] (695s left) kms_prop_blob (basic) [305.203763] Starting subtest: basic [305.204474] Subtest basic: SUCCESS (0.000s) [305.289547] [101/171] (695s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [309.116948] Starting subtest: basic-busy-flip-before-cursor-atomic [309.118822] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [309.249239] [102/171] (691s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [313.077987] Starting subtest: basic-busy-flip-before-cursor-legacy [313.079709] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [313.205458] [103/171] (687s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [317.035598] Starting subtest: basic-flip-after-cursor-atomic [319.412014] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.377s) [320.502442] [104/171] (680s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [324.327475] Starting subtest: basic-flip-after-cursor-legacy [326.652171] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.325s) [327.717990] [105/171] (672s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [331.549187] Starting subtest: basic-flip-after-cursor-varying-size [333.883230] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.335s) [334.964016] [106/171] (665s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [338.792822] Starting subtest: basic-flip-before-cursor-atomic [341.111774] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.319s) [342.130783] [107/171] (658s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [345.956299] Starting subtest: basic-flip-before-cursor-legacy [348.277444] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.322s) [349.363376] [108/171] (651s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [353.191270] Starting subtest: basic-flip-before-cursor-varying-size [355.507268] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.316s) [356.536827] [109/171] (644s left) kms_flip (basic-flip-vs-dpms) [358.488067] Starting subtest: basic-flip-vs-dpms [358.490513] Starting dynamic subtest: A-eDP1 [361.259536] Dynamic subtest A-eDP1: SUCCESS (2.769s) [361.264110] Starting dynamic subtest: B-eDP1 [363.620272] Dynamic subtest B-eDP1: SUCCESS (2.360s) [363.626130] Starting dynamic subtest: C-eDP1 [365.946228] Dynamic subtest C-eDP1: SUCCESS (2.324s) [365.951389] Starting dynamic subtest: D-eDP1 [368.298846] Dynamic subtest D-eDP1: SUCCESS (2.352s) [368.304015] Starting dynamic subtest: A-DP3 [369.086767] Dynamic subtest A-DP3: SUCCESS (0.786s) [369.092651] Starting dynamic subtest: B-DP3 [369.834206] Dynamic subtest B-DP3: SUCCESS (0.748s) [369.840044] Starting dynamic subtest: C-DP3 [370.588066] Dynamic subtest C-DP3: SUCCESS (0.753s) [370.594114] Starting dynamic subtest: D-DP3 [371.338453] Dynamic subtest D-DP3: SUCCESS (0.750s) [371.339290] Subtest basic-flip-vs-dpms: SUCCESS (12.851s) [371.842399] [110/171] (628s left) kms_flip (basic-flip-vs-modeset) [373.780055] Starting subtest: basic-flip-vs-modeset [373.782319] Starting dynamic subtest: A-eDP1 [376.485662] Dynamic subtest A-eDP1: SUCCESS (2.704s) [376.490450] Starting dynamic subtest: B-eDP1 [378.852427] Dynamic subtest B-eDP1: SUCCESS (2.365s) [378.859239] Starting dynamic subtest: C-eDP1 [381.226513] Dynamic subtest C-eDP1: SUCCESS (2.375s) [381.231359] Starting dynamic subtest: D-eDP1 [383.593287] Dynamic subtest D-eDP1: SUCCESS (2.365s) [383.599911] Starting dynamic subtest: A-DP3 [384.390438] Dynamic subtest A-DP3: SUCCESS (0.796s) [384.395989] Starting dynamic subtest: B-DP3 [385.138832] Dynamic subtest B-DP3: SUCCESS (0.747s) [385.143927] Starting dynamic subtest: C-DP3 [385.885399] Dynamic subtest C-DP3: SUCCESS (0.746s) [385.891645] Starting dynamic subtest: D-DP3 [386.614458] Dynamic subtest D-DP3: SUCCESS (0.729s) [386.615399] Subtest basic-flip-vs-modeset: SUCCESS (12.835s) [387.092545] [111/171] (613s left) kms_flip (basic-flip-vs-wf_vblank) [389.036535] Starting subtest: basic-flip-vs-wf_vblank [389.038842] Starting dynamic subtest: A-eDP1 [391.080981] Dynamic subtest A-eDP1: SUCCESS (2.042s) [391.087691] Starting dynamic subtest: B-eDP1 [393.147051] Dynamic subtest B-eDP1: SUCCESS (2.065s) [393.155127] Starting dynamic subtest: C-eDP1 [395.175173] Dynamic subtest C-eDP1: SUCCESS (2.027s) [395.180163] Starting dynamic subtest: D-eDP1 [397.220967] Dynamic subtest D-eDP1: SUCCESS (2.046s) [397.228183] Starting dynamic subtest: A-DP3 [398.556313] Dynamic subtest A-DP3: SUCCESS (1.332s) [398.565457] Starting dynamic subtest: B-DP3 [399.627356] Dynamic subtest B-DP3: SUCCESS (1.070s) [399.632183] Starting dynamic subtest: C-DP3 [400.695026] Dynamic subtest C-DP3: SUCCESS (1.066s) [400.700220] Starting dynamic subtest: D-DP3 [401.773623] Dynamic subtest D-DP3: SUCCESS (1.079s) [401.774617] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.738s) [402.311345] [112/171] (598s left) kms_flip (basic-plain-flip) [404.261439] Starting subtest: basic-plain-flip [404.264720] Starting dynamic subtest: A-eDP1 [406.021342] Dynamic subtest A-eDP1: SUCCESS (1.757s) [406.030811] Starting dynamic subtest: B-eDP1 [407.774746] Dynamic subtest B-eDP1: SUCCESS (1.751s) [407.784346] Starting dynamic subtest: C-eDP1 [409.546619] Dynamic subtest C-eDP1: SUCCESS (1.770s) [409.554330] Starting dynamic subtest: D-eDP1 [411.274555] Dynamic subtest D-eDP1: SUCCESS (1.727s) [411.281142] Starting dynamic subtest: A-DP3 [412.323364] Dynamic subtest A-DP3: SUCCESS (1.046s) [412.333576] Starting dynamic subtest: B-DP3 [413.107660] Dynamic subtest B-DP3: SUCCESS (0.784s) [413.113452] Starting dynamic subtest: C-DP3 [413.893313] Dynamic subtest C-DP3: SUCCESS (0.784s) [413.898463] Starting dynamic subtest: D-DP3 [414.680057] Dynamic subtest D-DP3: SUCCESS (0.786s) [414.681094] Subtest basic-plain-flip: SUCCESS (10.420s) [415.222862] [113/171] (585s left) kms_force_connector_basic (force-connector-state) [415.261803] Starting subtest: force-connector-state [419.785334] Subtest force-connector-state: SUCCESS (4.523s) [424.566761] [114/171] (576s left) kms_force_connector_basic (force-edid) [424.605132] Starting subtest: force-edid [424.639672] Subtest force-edid: SUCCESS (0.036s) [428.570281] [115/171] (572s left) kms_force_connector_basic (force-load-detect) [428.606967] Starting subtest: force-load-detect [428.608653] Subtest force-load-detect: SKIP (0.000s) [430.617289] [116/171] (570s left) kms_force_connector_basic (prune-stale-modes) [430.656844] Starting subtest: prune-stale-modes [430.689904] Subtest prune-stale-modes: SUCCESS (0.034s) [434.621172] [117/171] (566s left) kms_frontbuffer_tracking (basic) [438.433881] Starting subtest: basic [443.414365] Subtest basic: SUCCESS (4.981s) [444.786986] [118/171] (555s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [448.607757] Starting subtest: compare-crc-sanitycheck-xr24 [448.608848] Starting dynamic subtest: pipe-A-eDP-1 [450.532231] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s) [450.538253] Starting dynamic subtest: pipe-B-DP-3 [451.072959] Dynamic subtest pipe-B-DP-3: SUCCESS (0.539s) [451.081613] Starting dynamic subtest: pipe-C-DP-3 [451.696885] Dynamic subtest pipe-C-DP-3: SUCCESS (0.622s) [451.703206] Starting dynamic subtest: pipe-D-DP-3 [452.406617] Dynamic subtest pipe-D-DP-3: SUCCESS (0.708s) [452.407569] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.799s) [452.861535] [119/171] (547s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [456.668556] Starting subtest: compare-crc-sanitycheck-nv12 [456.669582] Starting dynamic subtest: pipe-A-eDP-1 [459.045015] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.375s) [459.052037] Starting dynamic subtest: pipe-B-DP-3 [460.023251] Dynamic subtest pipe-B-DP-3: SUCCESS (0.978s) [460.029681] Starting dynamic subtest: pipe-C-DP-3 [461.047158] Dynamic subtest pipe-C-DP-3: SUCCESS (1.021s) [461.052390] Starting dynamic subtest: pipe-D-DP-3 [462.165802] Dynamic subtest pipe-D-DP-3: SUCCESS (1.118s) [462.166469] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.498s) [462.624218] [120/171] (538s left) kms_pipe_crc_basic (hang-read-crc) [466.428184] Starting subtest: hang-read-crc [466.429223] Starting dynamic subtest: pipe-A-eDP-1 [469.893531] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s) [469.898458] Starting dynamic subtest: pipe-B-DP-3 [471.371283] Dynamic subtest pipe-B-DP-3: SUCCESS (1.477s) [471.376992] Starting dynamic subtest: pipe-C-DP-3 [473.011728] Dynamic subtest pipe-C-DP-3: SUCCESS (1.639s) [473.016791] Starting dynamic subtest: pipe-D-DP-3 [474.824444] Dynamic subtest pipe-D-DP-3: SUCCESS (1.812s) [474.825142] Subtest hang-read-crc: SUCCESS (8.397s) [475.270586] [121/171] (525s left) kms_pipe_crc_basic (nonblocking-crc) [479.076377] Starting subtest: nonblocking-crc [479.077107] Starting dynamic subtest: pipe-A-eDP-1 [481.121149] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.045s) [481.127297] Starting dynamic subtest: pipe-B-DP-3 [481.824334] Dynamic subtest pipe-B-DP-3: SUCCESS (0.699s) [481.830660] Starting dynamic subtest: pipe-C-DP-3 [482.620190] Dynamic subtest pipe-C-DP-3: SUCCESS (0.797s) [482.625671] Starting dynamic subtest: pipe-D-DP-3 [483.502505] Dynamic subtest pipe-D-DP-3: SUCCESS (0.881s) [483.503255] Subtest nonblocking-crc: SUCCESS (4.427s) [483.959724] [122/171] (516s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [487.763777] Starting subtest: nonblocking-crc-frame-sequence [487.764835] Starting dynamic subtest: pipe-A-eDP-1 [489.828113] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.064s) [489.833217] Starting dynamic subtest: pipe-B-DP-3 [490.530737] Dynamic subtest pipe-B-DP-3: SUCCESS (0.701s) [490.536029] Starting dynamic subtest: pipe-C-DP-3 [491.299050] Dynamic subtest pipe-C-DP-3: SUCCESS (0.768s) [491.304166] Starting dynamic subtest: pipe-D-DP-3 [492.155978] Dynamic subtest pipe-D-DP-3: SUCCESS (0.856s) [492.156870] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.393s) [492.608767] [123/171] (508s left) kms_pipe_crc_basic (read-crc) [496.417300] Starting subtest: read-crc [496.418192] Starting dynamic subtest: pipe-A-eDP-1 [498.421394] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.004s) [498.426510] Starting dynamic subtest: pipe-B-DP-3 [499.055175] Dynamic subtest pipe-B-DP-3: SUCCESS (0.633s) [499.062381] Starting dynamic subtest: pipe-C-DP-3 [499.775614] Dynamic subtest pipe-C-DP-3: SUCCESS (0.719s) [499.780714] Starting dynamic subtest: pipe-D-DP-3 [500.575925] Dynamic subtest pipe-D-DP-3: SUCCESS (0.800s) [500.576599] Subtest read-crc: SUCCESS (4.160s) [501.033436] [124/171] (499s left) kms_pipe_crc_basic (read-crc-frame-sequence) [504.843906] Starting subtest: read-crc-frame-sequence [504.844700] Starting dynamic subtest: pipe-A-eDP-1 [506.873863] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.029s) [506.877696] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1813 [max: 8192] direct dependencies: 18224 [max: 32768] indirect dependencies: 138135 all direct dependencies: 387292 dependency chains: 27427 [max: 131072] dependency chain hlocks used: 121130 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 293 in-softirq chains: 606 in-process chains: 26528 stack-trace entries: 167812 [max: 1048576] number of stack traces: 8647 number of stack hash chains: 6680 combined max dependencies: 439344986 hardirq-safe locks: 108 hardirq-unsafe locks: 1076 softirq-safe locks: 216 softirq-unsafe locks: 988 irq-safe locks: 235 irq-unsafe locks: 1076 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 331 softirq-read-safe locks: 7 softirq-read-unsafe locks: 326 irq-read-safe locks: 7 irq-read-unsafe locks: 331 uncategorized locks: 282 unused locks: 1 max locking depth: 16 max bfs queue depth: 404 max lock class index: 1812 chain lookup misses: 27878 chain lookup hits: 743462768 cyclic checks: 28040 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4973 find-mask backwards checks: 2723 hardirq on events: 371010627 hardirq off events: 371010612 redundant hardirq ons: 20 redundant hardirq offs: 30 softirq on events: 2534880 softirq off events: 2534880 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 121 large chain blocks: 1 [506.879156] Starting dynamic subtest: pipe-B-DP-3 [507.543859] Dynamic subtest pipe-B-DP-3: SUCCESS (0.670s) [507.544558] Starting dynamic subtest: pipe-C-DP-3 [508.272581] Dynamic subtest pipe-C-DP-3: SUCCESS (0.728s) [508.273167] Starting dynamic subtest: pipe-D-DP-3 [509.081593] Dynamic subtest pipe-D-DP-3: SUCCESS (0.808s) [509.082269] Subtest read-crc-frame-sequence: SUCCESS (4.238s) [509.534521] Closing watchdogs Done.