[62.512497] Initializing watchdogs [62.512542] /dev/watchdog0 [62.517176] [001/165] (960s left) i915_module_load (load) [62.549205] Starting subtest: load [73.035580] Subtest load: SUCCESS (10.486s) [73.046696] [002/165] (949s left) core_auth (basic-auth) [73.086985] Starting subtest: basic-auth [73.087818] Subtest basic-auth: SUCCESS (0.000s) [73.159747] [003/165] (949s left) debugfs_test (read_all_entries) [73.199165] Starting subtest: read_all_entries [73.375024] Subtest read_all_entries: SUCCESS (0.176s) [75.357321] [004/165] (947s left) debugfs_test (basic-hwmon) [75.387169] Starting subtest: basic-hwmon [75.388592] Subtest basic-hwmon: SKIP (0.000s) [77.369236] [005/165] (945s left) fbdev (eof) [77.416386] Starting subtest: eof [77.417374] Subtest eof: SUCCESS (0.000s) [77.468556] [006/165] (945s left) fbdev (info) [77.495565] Starting subtest: info [77.496622] Subtest info: SUCCESS (0.000s) [77.549604] [007/165] (945s left) fbdev (nullptr) [77.582927] Starting subtest: nullptr [77.584024] Subtest nullptr: SUCCESS (0.000s) [77.631328] [008/165] (945s left) fbdev (read) [77.665773] Starting subtest: read [80.257107] Subtest read: SUCCESS (2.582s) [80.313140] [009/165] (942s left) fbdev (write) [80.347213] Starting subtest: write [82.108121] Subtest write: SUCCESS (1.752s) [82.166074] [010/165] (940s left) gem_basic (bad-close) [82.192055] Starting subtest: bad-close [82.193270] Subtest bad-close: SUCCESS (0.000s) [82.246990] [011/165] (940s left) gem_basic (create-close) [82.271962] Starting subtest: create-close [82.273668] Subtest create-close: SUCCESS (0.000s) [82.375033] [012/165] (940s left) gem_basic (create-fd-close) [82.399960] Starting subtest: create-fd-close [82.401184] Subtest create-fd-close: SUCCESS (0.000s) [82.484306] [013/165] (940s left) gem_busy (busy@all-engines) [82.519734] Starting subtest: busy [82.520500] Starting dynamic subtest: all-engines [82.542031] Dynamic subtest all-engines: SUCCESS (0.022s) [82.542922] Subtest busy: SUCCESS (0.022s) [82.873311] [014/165] (940s left) gem_close_race (basic-process) [82.913048] Starting subtest: basic-process [82.957572] Subtest basic-process: SUCCESS (0.043s) [83.144037] [015/165] (940s left) gem_close_race (basic-threads) [83.189044] Starting subtest: basic-threads [84.405259] Subtest basic-threads: SUCCESS (1.224s) [84.587059] [016/165] (938s left) gem_ctx_create (basic) [84.619701] Starting subtest: basic [84.620491] Subtest basic: SUCCESS (0.000s) [84.805320] [017/165] (938s left) gem_ctx_create (basic-files) [84.835406] Starting subtest: basic-files [86.856911] Subtest basic-files: SUCCESS (2.021s) [87.047965] [018/165] (936s left) gem_ctx_exec (basic) [87.078228] Starting subtest: basic [87.080041] Subtest basic: SUCCESS (0.002s) [87.162980] [019/165] (936s left) gem_exec_basic (basic) [87.198084] Starting subtest: basic [87.198926] Starting dynamic subtest: rcs0-smem [87.199739] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [87.204823] Starting dynamic subtest: bcs0-smem [87.205757] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [87.209279] Starting dynamic subtest: vcs0-smem [87.210166] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [87.214267] Starting dynamic subtest: vcs1-smem [87.215681] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [87.219851] Starting dynamic subtest: vecs0-smem [87.220798] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [87.221745] Subtest basic: SUCCESS (0.002s) [87.387414] [020/165] (935s left) gem_exec_create (basic) [87.420016] Starting subtest: basic [87.420869] Starting dynamic subtest: smem [89.508699] Dynamic subtest smem: SUCCESS (2.088s) [89.510447] Subtest basic: SUCCESS (2.088s) [89.694297] [021/165] (933s left) gem_exec_fence (basic-busy) [89.865184] Starting subtest: basic-busy [89.866186] Starting dynamic subtest: rcs0 [89.919148] Dynamic subtest rcs0: SUCCESS (0.063s) [89.923498] Starting dynamic subtest: bcs0 [89.967100] Dynamic subtest bcs0: SUCCESS (0.047s) [89.978785] Starting dynamic subtest: vcs0 [90.014486] Dynamic subtest vcs0: SUCCESS (0.047s) [90.026191] Starting dynamic subtest: vcs1 [90.063438] Dynamic subtest vcs1: SUCCESS (0.048s) [90.075696] Starting dynamic subtest: vecs0 [90.110442] Dynamic subtest vecs0: SUCCESS (0.048s) [90.111651] Subtest basic-busy: SUCCESS (0.255s) [90.622300] [022/165] (932s left) gem_exec_fence (basic-wait) [90.780390] Starting subtest: basic-wait [90.781267] Starting dynamic subtest: rcs0 [90.821903] Dynamic subtest rcs0: SUCCESS (0.049s) [90.829308] Starting dynamic subtest: bcs0 [90.868928] Dynamic subtest bcs0: SUCCESS (0.047s) [90.881652] Starting dynamic subtest: vcs0 [90.917521] Dynamic subtest vcs0: SUCCESS (0.048s) [90.930440] Starting dynamic subtest: vcs1 [90.965659] Dynamic subtest vcs1: SUCCESS (0.048s) [90.977642] Starting dynamic subtest: vecs0 [91.014087] Dynamic subtest vecs0: SUCCESS (0.048s) [91.015745] Subtest basic-wait: SUCCESS (0.241s) [91.489416] [023/165] (931s left) gem_exec_fence (basic-await) [91.649344] Starting subtest: basic-await [91.650252] Starting dynamic subtest: rcs0 [91.712428] Dynamic subtest rcs0: SUCCESS (0.072s) [91.718856] Starting dynamic subtest: bcs0 [91.783427] Dynamic subtest bcs0: SUCCESS (0.070s) [91.790768] Starting dynamic subtest: vcs0 [91.856829] Dynamic subtest vcs0: SUCCESS (0.073s) [91.863568] Starting dynamic subtest: vcs1 [91.933878] Dynamic subtest vcs1: SUCCESS (0.077s) [91.941978] Starting dynamic subtest: vecs0 [92.006633] Dynamic subtest vecs0: SUCCESS (0.072s) [92.008650] Subtest basic-await: SUCCESS (0.365s) [92.490207] [024/165] (930s left) gem_exec_fence (nb-await) [92.647561] Starting subtest: nb-await [92.648293] Starting dynamic subtest: rcs0 [92.698433] Dynamic subtest rcs0: SUCCESS (0.058s) [92.705549] Starting dynamic subtest: bcs0 [92.756944] Dynamic subtest bcs0: SUCCESS (0.059s) [92.767710] Starting dynamic subtest: vcs0 [92.817096] Dynamic subtest vcs0: SUCCESS (0.060s) [92.824135] Starting dynamic subtest: vcs1 [92.876121] Dynamic subtest vcs1: SUCCESS (0.058s) [92.884166] Starting dynamic subtest: vecs0 [92.937059] Dynamic subtest vecs0: SUCCESS (0.061s) [92.939095] Subtest nb-await: SUCCESS (0.297s) [93.427247] [025/165] (929s left) gem_exec_gttfill (basic) [93.466446] Starting subtest: basic [95.601415] Subtest basic: SUCCESS (2.135s) [95.778494] [026/165] (927s left) gem_exec_parallel (engines) [95.855139] Starting subtest: engines [95.856183] Starting dynamic subtest: basic [97.168604] Dynamic subtest basic: SUCCESS (1.313s) [97.175270] Starting dynamic subtest: contexts [98.826335] Dynamic subtest contexts: SUCCESS (1.649s) [98.834334] Starting dynamic subtest: fds [100.675256] Dynamic subtest fds: SUCCESS (1.849s) [100.681558] Starting dynamic subtest: userptr [101.941422] Dynamic subtest userptr: SUCCESS (1.275s) [101.942418] Subtest engines: SUCCESS (6.086s) [102.131198] [027/165] (921s left) gem_exec_store (basic) [102.162643] Starting subtest: basic [102.244811] Subtest basic: SUCCESS (0.081s) [102.429459] [028/165] (920s left) gem_flink_basic (bad-flink) [102.456750] Starting subtest: bad-flink [102.457515] Subtest bad-flink: SUCCESS (0.000s) [102.530395] [029/165] (920s left) gem_flink_basic (bad-open) [102.557840] Starting subtest: bad-open [102.558702] Subtest bad-open: SUCCESS (0.000s) [102.629146] [030/165] (920s left) gem_flink_basic (basic) [102.657179] Starting subtest: basic [102.657985] Subtest basic: SUCCESS (0.000s) [102.746518] [031/165] (920s left) gem_flink_basic (double-flink) [102.773083] Starting subtest: double-flink [102.773789] Subtest double-flink: SUCCESS (0.000s) [102.856344] [032/165] (920s left) gem_flink_basic (flink-lifetime) [102.886353] Starting subtest: flink-lifetime [102.887144] Subtest flink-lifetime: SUCCESS (0.001s) [102.970717] [033/165] (920s left) gem_huc_copy (huc-copy) [102.998853] Starting subtest: huc-copy [103.000598] Subtest huc-copy: SUCCESS (0.002s) [103.106666] [034/165] (920s left) gem_linear_blits (basic) [103.179751] Starting subtest: basic [103.184878] Subtest basic: SUCCESS (0.005s) [103.309333] [035/165] (920s left) gem_mmap (basic) [103.368786] Starting subtest: basic [103.372051] Subtest basic: SUCCESS (0.000s) [103.455964] [036/165] (919s left) gem_mmap_gtt (basic) [103.482128] Starting subtest: basic [103.482832] Subtest basic: SUCCESS (0.000s) [103.559770] [037/165] (919s left) gem_render_linear_blits (basic) [103.587445] Starting subtest: basic [103.607265] Subtest basic: SUCCESS (0.020s) [103.679702] [038/165] (919s left) gem_render_tiled_blits (basic) [103.709919] Starting subtest: basic [103.732901] Subtest basic: SUCCESS (0.023s) [103.807586] [039/165] (919s left) gem_ringfill (basic-all) [104.129926] Starting subtest: basic-all [105.264611] Subtest basic-all: SUCCESS (1.127s) [105.377509] [040/165] (918s left) gem_softpin (allocator-basic) [105.409875] Starting subtest: allocator-basic [105.455734] Subtest allocator-basic: SUCCESS (0.046s) [105.562397] [041/165] (917s left) gem_softpin (allocator-basic-reserve) [105.592068] Starting subtest: allocator-basic-reserve [105.637762] Subtest allocator-basic-reserve: SUCCESS (0.045s) [105.744168] [042/165] (917s left) gem_softpin (safe-alignment) [105.773862] Starting subtest: safe-alignment [105.780226] Subtest safe-alignment: SUCCESS (0.007s) [105.888374] [043/165] (917s left) gem_sync (basic-all) [105.923978] Starting subtest: basic-all [108.453706] Subtest basic-all: SUCCESS (2.528s) [108.640730] [044/165] (914s left) gem_sync (basic-each) [108.674985] Starting subtest: basic-each [110.858868] Subtest basic-each: SUCCESS (2.184s) [111.047825] [045/165] (912s left) gem_tiled_blits (basic) [111.116827] Starting subtest: basic [111.125662] Subtest basic: SUCCESS (0.009s) [111.247132] [046/165] (912s left) gem_tiled_fence_blits (basic) [111.366623] Starting subtest: basic [111.385560] Subtest basic: SUCCESS (0.019s) [111.495963] [047/165] (912s left) gem_tiled_pread_basic [111.589755] [048/165] (911s left) gem_wait (busy@all-engines) [111.626193] Starting subtest: busy [111.627108] Starting dynamic subtest: all-engines [112.174740] Dynamic subtest all-engines: SUCCESS (0.547s) [112.176592] Subtest busy: SUCCESS (0.548s) [112.382221] [049/165] (911s left) gem_wait (wait@all-engines) [112.415853] Starting subtest: wait [112.416704] Starting dynamic subtest: all-engines [113.465702] Dynamic subtest all-engines: SUCCESS (1.048s) [113.467844] Subtest wait: SUCCESS (1.049s) [113.672307] [050/165] (909s left) i915_getparams_basic (basic-eu-total) [113.706117] Starting subtest: basic-eu-total [113.707682] Subtest basic-eu-total: SUCCESS (0.000s) [113.768680] [051/165] (909s left) i915_getparams_basic (basic-subslice-total) [113.796171] Starting subtest: basic-subslice-total [113.797827] Subtest basic-subslice-total: SUCCESS (0.000s) [113.867348] [052/165] (909s left) i915_hangman (error-state-basic) [113.906670] Starting subtest: error-state-basic [113.995015] Subtest error-state-basic: SUCCESS (0.088s) [114.072846] [053/165] (909s left) i915_pciid [114.172254] [054/165] (909s left) kms_addfb_basic (addfb25-4-tiled) [116.108615] Starting subtest: addfb25-4-tiled [116.109497] Subtest addfb25-4-tiled: SUCCESS (0.000s) [116.195952] [055/165] (907s left) kms_addfb_basic (addfb25-bad-modifier) [116.226145] Starting subtest: addfb25-bad-modifier [116.226954] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [118.231394] [056/165] (905s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [118.258298] Starting subtest: addfb25-framebuffer-vs-set-tiling [118.259153] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [120.260085] [057/165] (903s left) kms_addfb_basic (addfb25-modifier-no-flag) [120.292651] Starting subtest: addfb25-modifier-no-flag [120.293609] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [122.289586] [058/165] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy) [122.319952] Starting subtest: addfb25-x-tiled-legacy [122.320906] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [124.311865] [059/165] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [124.343073] Starting subtest: addfb25-x-tiled-mismatch-legacy [124.343873] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [126.342195] [060/165] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [128.280220] Starting subtest: addfb25-yf-tiled-legacy [128.281199] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [128.366665] [061/165] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [130.300978] Starting subtest: addfb25-y-tiled-legacy [130.301689] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [130.390883] [062/165] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [132.326042] Starting subtest: addfb25-y-tiled-small-legacy [132.326899] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [132.418945] [063/165] (891s left) kms_addfb_basic (bad-pitch-0) [132.448034] Starting subtest: bad-pitch-0 [132.449057] Subtest bad-pitch-0: SUCCESS (0.000s) [134.456211] [064/165] (889s left) kms_addfb_basic (bad-pitch-1024) [134.483619] Starting subtest: bad-pitch-1024 [134.484445] Subtest bad-pitch-1024: SUCCESS (0.000s) [136.474340] [065/165] (887s left) kms_addfb_basic (bad-pitch-128) [136.500702] Starting subtest: bad-pitch-128 [136.501582] Subtest bad-pitch-128: SUCCESS (0.000s) [138.493808] [066/165] (885s left) kms_addfb_basic (bad-pitch-256) [138.521716] Starting subtest: bad-pitch-256 [138.522577] Subtest bad-pitch-256: SUCCESS (0.000s) [140.514608] [067/165] (883s left) kms_addfb_basic (bad-pitch-32) [140.548286] Starting subtest: bad-pitch-32 [140.549225] Subtest bad-pitch-32: SUCCESS (0.000s) [142.550371] [068/165] (881s left) kms_addfb_basic (bad-pitch-63) [142.581266] Starting subtest: bad-pitch-63 [142.582156] Subtest bad-pitch-63: SUCCESS (0.000s) [144.582977] [069/165] (879s left) kms_addfb_basic (bad-pitch-65536) [144.610112] Starting subtest: bad-pitch-65536 [144.610985] Subtest bad-pitch-65536: SUCCESS (0.000s) [146.609053] [070/165] (877s left) kms_addfb_basic (bad-pitch-999) [146.642261] Starting subtest: bad-pitch-999 [146.643129] Subtest bad-pitch-999: SUCCESS (0.000s) [148.645182] [071/165] (875s left) kms_addfb_basic (basic) [148.674921] Starting subtest: basic [148.675779] Subtest basic: SUCCESS (0.000s) [150.669228] [072/165] (873s left) kms_addfb_basic (basic-x-tiled-legacy) [150.694566] Starting subtest: basic-x-tiled-legacy [150.695328] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [152.697255] [073/165] (871s left) kms_addfb_basic (basic-y-tiled-legacy) [152.729334] Starting subtest: basic-y-tiled-legacy [152.730297] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [154.733584] [074/165] (869s left) kms_addfb_basic (bo-too-small) [156.668169] Starting subtest: bo-too-small [156.669059] Subtest bo-too-small: SUCCESS (0.000s) [156.762450] [075/165] (867s left) kms_addfb_basic (bo-too-small-due-to-tiling) [158.696202] Starting subtest: bo-too-small-due-to-tiling [158.697057] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [158.783129] [076/165] (865s left) kms_addfb_basic (clobberred-modifier) [158.811912] Starting subtest: clobberred-modifier [158.812581] Subtest clobberred-modifier: SUCCESS (0.000s) [160.818328] [077/165] (863s left) kms_addfb_basic (framebuffer-vs-set-tiling) [160.845009] Starting subtest: framebuffer-vs-set-tiling [160.845698] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [162.850309] [078/165] (861s left) kms_addfb_basic (invalid-get-prop) [162.877203] Starting subtest: invalid-get-prop [162.878194] Subtest invalid-get-prop: SUCCESS (0.000s) [164.879795] [079/165] (858s left) kms_addfb_basic (invalid-get-prop-any) [164.915821] Starting subtest: invalid-get-prop-any [164.916634] Subtest invalid-get-prop-any: SUCCESS (0.000s) [166.919768] [080/165] (856s left) kms_addfb_basic (invalid-set-prop) [166.952079] Starting subtest: invalid-set-prop [166.952898] Subtest invalid-set-prop: SUCCESS (0.000s) [168.957747] [081/165] (854s left) kms_addfb_basic (invalid-set-prop-any) [168.983604] Starting subtest: invalid-set-prop-any [168.984587] Subtest invalid-set-prop-any: SUCCESS (0.000s) [170.996508] [082/165] (852s left) kms_addfb_basic (no-handle) [171.027766] Starting subtest: no-handle [171.028443] Subtest no-handle: SUCCESS (0.000s) [173.029930] [083/165] (850s left) kms_addfb_basic (size-max) [174.968249] Starting subtest: size-max [174.968943] Subtest size-max: SUCCESS (0.000s) [175.068862] [084/165] (848s left) kms_addfb_basic (small-bo) [177.004028] Starting subtest: small-bo [177.004870] Subtest small-bo: SUCCESS (0.000s) [177.092056] [085/165] (846s left) kms_addfb_basic (tile-pitch-mismatch) [177.120018] Starting subtest: tile-pitch-mismatch [177.120864] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [179.118478] [086/165] (844s left) kms_addfb_basic (too-high) [181.055230] Starting subtest: too-high [181.056055] Subtest too-high: SUCCESS (0.000s) [181.145345] [087/165] (842s left) kms_addfb_basic (too-wide) [183.081456] Starting subtest: too-wide [183.082413] Subtest too-wide: SUCCESS (0.000s) [183.167846] [088/165] (840s left) kms_addfb_basic (unused-handle) [183.196273] Starting subtest: unused-handle [183.197119] Subtest unused-handle: SUCCESS (0.000s) [185.203053] [089/165] (838s left) kms_addfb_basic (unused-modifier) [185.233027] Starting subtest: unused-modifier [185.233942] Subtest unused-modifier: SUCCESS (0.000s) [187.235408] [090/165] (836s left) kms_addfb_basic (unused-offsets) [187.268150] Starting subtest: unused-offsets [187.269110] Subtest unused-offsets: SUCCESS (0.000s) [189.268103] [091/165] (834s left) kms_addfb_basic (unused-pitches) [189.297270] Starting subtest: unused-pitches [189.298227] Subtest unused-pitches: SUCCESS (0.000s) [191.291978] [092/165] (832s left) kms_busy (basic) [193.230635] Starting subtest: basic [193.231694] Starting dynamic subtest: flip [195.270955] Dynamic subtest flip: SUCCESS (2.041s) [195.276649] Starting dynamic subtest: modeset [199.228502] Dynamic subtest modeset: SUCCESS (3.956s) [199.229370] Subtest basic: SUCCESS (5.998s) [200.261304] [093/165] (823s left) kms_prop_blob (basic) [200.295747] Starting subtest: basic [200.296525] Subtest basic: SUCCESS (0.000s) [200.360982] [094/165] (823s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [202.328598] Starting subtest: basic-busy-flip-before-cursor-atomic [202.330310] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [202.449970] [095/165] (821s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [204.411454] Starting subtest: basic-busy-flip-before-cursor-legacy [204.413108] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [204.531317] [096/165] (819s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [206.490551] Starting subtest: basic-flip-after-cursor-atomic [208.845942] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.355s) [209.929903] [097/165] (814s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [211.885788] Starting subtest: basic-flip-after-cursor-legacy [214.225098] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.339s) [215.295815] [098/165] (808s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [217.259535] Starting subtest: basic-flip-after-cursor-varying-size [219.594184] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.336s) [220.664044] [099/165] (803s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [222.622188] Starting subtest: basic-flip-before-cursor-atomic [224.973388] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.351s) [226.055329] [100/165] (798s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [228.020335] Starting subtest: basic-flip-before-cursor-legacy [230.353915] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.334s) [231.432178] [101/165] (792s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [233.393051] Starting subtest: basic-flip-before-cursor-varying-size [235.724748] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.332s) [236.800353] [102/165] (787s left) kms_dsc (dsc-basic) [238.737742] Starting subtest: dsc-basic [238.739198] Subtest dsc-basic: SKIP (0.000s) [238.812482] [103/165] (785s left) kms_flip (basic-flip-vs-dpms) [239.813512] Starting subtest: basic-flip-vs-dpms [239.815147] Starting dynamic subtest: A-eDP1 [242.559324] Dynamic subtest A-eDP1: SUCCESS (2.743s) [242.565616] Starting dynamic subtest: B-eDP1 [244.927973] Dynamic subtest B-eDP1: SUCCESS (2.369s) [244.933182] Starting dynamic subtest: C-eDP1 [247.292078] Dynamic subtest C-eDP1: SUCCESS (2.364s) [247.297086] Starting dynamic subtest: D-eDP1 [249.660314] Dynamic subtest D-eDP1: SUCCESS (2.364s) [249.665197] Starting dynamic subtest: A-DP3 [250.493307] Dynamic subtest A-DP3: SUCCESS (0.834s) [250.499064] Starting dynamic subtest: B-DP3 [251.273233] Dynamic subtest B-DP3: SUCCESS (0.781s) [251.279547] Starting dynamic subtest: C-DP3 [252.049562] Dynamic subtest C-DP3: SUCCESS (0.775s) [252.054870] Starting dynamic subtest: D-DP3 [252.824165] Dynamic subtest D-DP3: SUCCESS (0.774s) [252.824921] Subtest basic-flip-vs-dpms: SUCCESS (13.012s) [253.326558] [104/165] (770s left) kms_flip (basic-flip-vs-modeset) [254.328991] Starting subtest: basic-flip-vs-modeset [254.330770] Starting dynamic subtest: A-eDP1 [257.085761] Dynamic subtest A-eDP1: SUCCESS (2.755s) [257.090797] Starting dynamic subtest: B-eDP1 [259.453199] Dynamic subtest B-eDP1: SUCCESS (2.367s) [259.459089] Starting dynamic subtest: C-eDP1 [261.819881] Dynamic subtest C-eDP1: SUCCESS (2.366s) [261.825460] Starting dynamic subtest: D-eDP1 [264.193395] Dynamic subtest D-eDP1: SUCCESS (2.374s) [264.199989] Starting dynamic subtest: A-DP3 [265.018788] Dynamic subtest A-DP3: SUCCESS (0.823s) [265.024129] Starting dynamic subtest: B-DP3 [265.803303] Dynamic subtest B-DP3: SUCCESS (0.784s) [265.808815] Starting dynamic subtest: C-DP3 [266.587424] Dynamic subtest C-DP3: SUCCESS (0.784s) [266.592353] Starting dynamic subtest: D-DP3 [267.375269] Dynamic subtest D-DP3: SUCCESS (0.788s) [267.376061] Subtest basic-flip-vs-modeset: SUCCESS (13.048s) [267.852179] [105/165] (756s left) kms_flip (basic-flip-vs-wf_vblank) [268.857285] Starting subtest: basic-flip-vs-wf_vblank [268.858220] Starting dynamic subtest: A-eDP1 [270.899824] Dynamic subtest A-eDP1: SUCCESS (2.040s) [270.912562] Starting dynamic subtest: B-eDP1 [273.141632] Dynamic subtest B-eDP1: SUCCESS (2.238s) [273.155251] Starting dynamic subtest: C-eDP1 [275.199395] Dynamic subtest C-eDP1: SUCCESS (2.052s) [275.208208] Starting dynamic subtest: D-eDP1 [277.248526] Dynamic subtest D-eDP1: SUCCESS (2.048s) [277.257739] Starting dynamic subtest: A-DP3 [278.590816] Dynamic subtest A-DP3: SUCCESS (1.336s) [278.602863] Starting dynamic subtest: B-DP3 [279.669144] Dynamic subtest B-DP3: SUCCESS (1.075s) [279.678257] Starting dynamic subtest: C-DP3 [280.752462] Dynamic subtest C-DP3: SUCCESS (1.076s) [280.759332] Starting dynamic subtest: D-DP3 [281.821175] Dynamic subtest D-DP3: SUCCESS (1.068s) [281.822574] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.966s) [282.353427] [106/165] (741s left) kms_flip (basic-plain-flip) [283.355059] Starting subtest: basic-plain-flip [283.357317] Starting dynamic subtest: A-eDP1 [285.113729] Dynamic subtest A-eDP1: SUCCESS (1.755s) [285.127244] Starting dynamic subtest: B-eDP1 [286.904183] Dynamic subtest B-eDP1: SUCCESS (1.788s) [286.917438] Starting dynamic subtest: C-eDP1 [288.678218] Dynamic subtest C-eDP1: SUCCESS (1.769s) [288.688565] Starting dynamic subtest: D-eDP1 [290.407231] Dynamic subtest D-eDP1: SUCCESS (1.725s) [290.415851] Starting dynamic subtest: A-DP3 [291.477420] Dynamic subtest A-DP3: SUCCESS (1.066s) [291.490047] Starting dynamic subtest: B-DP3 [292.280779] Dynamic subtest B-DP3: SUCCESS (0.799s) [292.288049] Starting dynamic subtest: C-DP3 [293.078110] Dynamic subtest C-DP3: SUCCESS (0.797s) [293.083416] Starting dynamic subtest: D-DP3 [293.868902] Dynamic subtest D-DP3: SUCCESS (0.788s) [293.870807] Subtest basic-plain-flip: SUCCESS (10.514s) [294.392148] [107/165] (729s left) kms_force_connector_basic (force-connector-state) [294.426493] Starting subtest: force-connector-state [297.078451] Subtest force-connector-state: SUCCESS (2.652s) [300.000271] [108/165] (724s left) kms_force_connector_basic (force-edid) [300.028281] Starting subtest: force-edid [300.059345] Subtest force-edid: SUCCESS (0.031s) [302.112542] [109/165] (722s left) kms_force_connector_basic (force-load-detect) [302.141807] Starting subtest: force-load-detect [302.143114] Subtest force-load-detect: SKIP (0.000s) [303.202736] [110/165] (721s left) kms_force_connector_basic (prune-stale-modes) [303.232489] Starting subtest: prune-stale-modes [303.261882] Subtest prune-stale-modes: SUCCESS (0.029s) [305.316502] [111/165] (718s left) kms_frontbuffer_tracking (basic) [307.259135] Starting subtest: basic [312.122901] Subtest basic: SUCCESS (4.865s) [313.471369] [112/165] (710s left) kms_hdmi_inject (inject-audio) [314.057875] Starting subtest: inject-audio [314.154926] Subtest inject-audio: SUCCESS (0.097s) [315.843434] [113/165] (708s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [317.781678] Starting subtest: compare-crc-sanitycheck-xr24 [317.782459] Starting dynamic subtest: pipe-A-eDP-1 [319.743761] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s) [319.749068] Starting dynamic subtest: pipe-B-DP-3 [320.199117] Dynamic subtest pipe-B-DP-3: SUCCESS (0.459s) [320.205337] Starting dynamic subtest: pipe-C-DP-3 [320.659298] Dynamic subtest pipe-C-DP-3: SUCCESS (0.459s) [320.665418] Starting dynamic subtest: pipe-D-DP-3 [321.128421] Dynamic subtest pipe-D-DP-3: SUCCESS (0.467s) [321.129279] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.347s) [321.638241] [114/165] (702s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [323.588566] Starting subtest: compare-crc-sanitycheck-nv12 [323.589210] Starting dynamic subtest: pipe-A-eDP-1 [325.645933] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.057s) [325.651975] Starting dynamic subtest: pipe-B-DP-3 [326.258076] Dynamic subtest pipe-B-DP-3: SUCCESS (0.610s) [326.263318] Starting dynamic subtest: pipe-C-DP-3 [326.859406] Dynamic subtest pipe-C-DP-3: SUCCESS (0.600s) [326.864253] Starting dynamic subtest: pipe-D-DP-3 [327.457087] Dynamic subtest pipe-D-DP-3: SUCCESS (0.597s) [327.457818] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.869s) [327.944349] [115/165] (696s left) kms_pipe_crc_basic (hang-read-crc) [329.879831] Starting subtest: hang-read-crc [329.880668] Starting dynamic subtest: pipe-A-eDP-1 [333.409953] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.529s) [333.414982] Starting dynamic subtest: pipe-B-DP-3 [334.641504] Dynamic subtest pipe-B-DP-3: SUCCESS (1.231s) [334.647543] Starting dynamic subtest: pipe-C-DP-3 [335.843602] Dynamic subtest pipe-C-DP-3: SUCCESS (1.200s) [335.849638] Starting dynamic subtest: pipe-D-DP-3 [337.078483] Dynamic subtest pipe-D-DP-3: SUCCESS (1.234s) [337.079420] Subtest hang-read-crc: SUCCESS (7.199s) [337.543644] [116/165] (686s left) kms_pipe_crc_basic (nonblocking-crc) [339.481600] Starting subtest: nonblocking-crc [339.482774] Starting dynamic subtest: pipe-A-eDP-1 [341.614962] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.133s) [341.620572] Starting dynamic subtest: pipe-B-DP-3 [342.233602] Dynamic subtest pipe-B-DP-3: SUCCESS (0.618s) [342.238897] Starting dynamic subtest: pipe-C-DP-3 [342.871229] Dynamic subtest pipe-C-DP-3: SUCCESS (0.637s) [342.876310] Starting dynamic subtest: pipe-D-DP-3 [343.513163] Dynamic subtest pipe-D-DP-3: SUCCESS (0.641s) [343.514065] Subtest nonblocking-crc: SUCCESS (4.033s) [343.980899] [117/165] (680s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [345.922020] Starting subtest: nonblocking-crc-frame-sequence [345.922798] Starting dynamic subtest: pipe-A-eDP-1 [347.982803] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.059s) [347.988068] Starting dynamic subtest: pipe-B-DP-3 [348.621898] Dynamic subtest pipe-B-DP-3: SUCCESS (0.637s) [348.627960] Starting dynamic subtest: pipe-C-DP-3 [349.242522] Dynamic subtest pipe-C-DP-3: SUCCESS (0.621s) [349.247589] Starting dynamic subtest: pipe-D-DP-3 [349.883911] Dynamic subtest pipe-D-DP-3: SUCCESS (0.640s) [349.884779] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.962s) [350.338275] [118/165] (673s left) kms_pipe_crc_basic (read-crc) [352.279075] Starting subtest: read-crc [352.279875] Starting dynamic subtest: pipe-A-eDP-1 [354.336620] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.057s) [354.342207] Starting dynamic subtest: pipe-B-DP-3 [354.927264] Dynamic subtest pipe-B-DP-3: SUCCESS (0.589s) [354.932486] Starting dynamic subtest: pipe-C-DP-3 [355.500753] Dynamic subtest pipe-C-DP-3: SUCCESS (0.572s) [355.505886] Starting dynamic subtest: pipe-D-DP-3 [356.060693] Dynamic subtest pipe-D-DP-3: SUCCESS (0.558s) [356.061456] Subtest read-crc: SUCCESS (3.781s) [356.526120] [119/165] (667s left) kms_pipe_crc_basic (read-crc-frame-sequence) [358.465286] Starting subtest: read-crc-frame-sequence [358.465992] Starting dynamic subtest: pipe-A-eDP-1 [360.455898] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.990s) [360.460881] Starting dynamic subtest: pipe-B-DP-3 [361.016377] Dynamic subtest pipe-B-DP-3: SUCCESS (0.556s) [361.021447] Starting dynamic subtest: pipe-C-DP-3 [361.567228] Dynamic subtest pipe-C-DP-3: SUCCESS (0.552s) [361.572315] Starting dynamic subtest: pipe-D-DP-3 [362.142392] Dynamic subtest pipe-D-DP-3: SUCCESS (0.574s) [362.143149] Subtest read-crc-frame-sequence: SUCCESS (3.678s) [362.610602] [120/165] (661s left) kms_pm_backlight (basic-brightness) [364.550061] Starting subtest: basic-brightness [365.780854] Starting dynamic subtest: eDP-1 [366.069964] Dynamic subtest eDP-1: SUCCESS (0.290s) [366.070841] Subtest basic-brightness: SUCCESS (1.520s) [367.092110] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1817 [max: 8192] direct dependencies: 18370 [max: 32768] indirect dependencies: 141216 all direct dependencies: 385100 dependency chains: 27657 [max: 131072] dependency chain hlocks used: 121086 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 288 in-softirq chains: 636 in-process chains: 26733 stack-trace entries: 173506 [max: 1048576] number of stack traces: 8729 number of stack hash chains: 6800 combined max dependencies: 626574966 hardirq-safe locks: 104 hardirq-unsafe locks: 1085 softirq-safe locks: 217 softirq-unsafe locks: 993 irq-safe locks: 234 irq-unsafe locks: 1085 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 328 softirq-read-safe locks: 7 softirq-read-unsafe locks: 323 irq-read-safe locks: 7 irq-read-unsafe locks: 328 uncategorized locks: 287 unused locks: 1 max locking depth: 16 max bfs queue depth: 411 max lock class index: 1816 chain lookup misses: 28096 chain lookup hits: 456265900 cyclic checks: 28210 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4946 find-mask backwards checks: 2731 hardirq on events: 232673418 hardirq off events: 232673402 redundant hardirq ons: 42 redundant hardirq offs: 25 softirq on events: 1731957 softirq off events: 1731957 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 109 large chain blocks: 1 [367.093400] Closing watchdogs Done.