[97.587939] Initializing watchdogs [97.587980] /dev/watchdog0 [97.591805] [001/165] (960s left) i915_module_load (load) [97.626294] Starting subtest: load [108.103841] Subtest load: SUCCESS (10.477s) [108.119314] [002/165] (949s left) core_auth (basic-auth) [108.177774] Starting subtest: basic-auth [108.178869] Subtest basic-auth: SUCCESS (0.001s) [108.265337] [003/165] (949s left) debugfs_test (read_all_entries) [108.299127] Starting subtest: read_all_entries [108.473649] Subtest read_all_entries: SUCCESS (0.174s) [110.456823] [004/165] (947s left) debugfs_test (basic-hwmon) [110.485935] Starting subtest: basic-hwmon [110.487476] Subtest basic-hwmon: SKIP (0.000s) [112.466490] [005/165] (945s left) fbdev (eof) [112.514244] Starting subtest: eof [112.515108] Subtest eof: SUCCESS (0.000s) [112.564581] [006/165] (945s left) fbdev (info) [112.590420] Starting subtest: info [112.591346] Subtest info: SUCCESS (0.000s) [112.646280] [007/165] (945s left) fbdev (nullptr) [112.684521] Starting subtest: nullptr [112.685303] Subtest nullptr: SUCCESS (0.000s) [112.732040] [008/165] (945s left) fbdev (read) [112.780243] Starting subtest: read [115.396122] Subtest read: SUCCESS (2.607s) [115.454017] [009/165] (942s left) fbdev (write) [115.494457] Starting subtest: write [117.237690] Subtest write: SUCCESS (1.734s) [117.301285] [010/165] (940s left) gem_basic (bad-close) [117.329482] Starting subtest: bad-close [117.331155] Subtest bad-close: SUCCESS (0.000s) [117.400744] [011/165] (940s left) gem_basic (create-close) [117.428055] Starting subtest: create-close [117.429892] Subtest create-close: SUCCESS (0.000s) [117.516358] [012/165] (940s left) gem_basic (create-fd-close) [117.544460] Starting subtest: create-fd-close [117.545769] Subtest create-fd-close: SUCCESS (0.000s) [117.618948] [013/165] (940s left) gem_busy (busy@all-engines) [117.657386] Starting subtest: busy [117.658230] Starting dynamic subtest: all-engines [117.678980] Dynamic subtest all-engines: SUCCESS (0.022s) [117.679852] Subtest busy: SUCCESS (0.022s) [118.013467] [014/165] (940s left) gem_close_race (basic-process) [118.053707] Starting subtest: basic-process [118.092024] Subtest basic-process: SUCCESS (0.038s) [118.286356] [015/165] (939s left) gem_close_race (basic-threads) [118.319299] Starting subtest: basic-threads [119.541502] Subtest basic-threads: SUCCESS (1.222s) [119.736336] [016/165] (938s left) gem_ctx_create (basic) [119.769893] Starting subtest: basic [119.770676] Subtest basic: SUCCESS (0.000s) [119.954672] [017/165] (938s left) gem_ctx_create (basic-files) [119.988262] Starting subtest: basic-files [121.999260] Subtest basic-files: SUCCESS (2.008s) [122.253685] [018/165] (936s left) gem_ctx_exec (basic) [122.293939] Starting subtest: basic [122.296159] Subtest basic: SUCCESS (0.002s) [122.404779] [019/165] (935s left) gem_exec_basic (basic) [122.436910] Starting subtest: basic [122.437671] Starting dynamic subtest: rcs0-smem [122.438338] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [122.441835] Starting dynamic subtest: bcs0-smem [122.442573] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [122.445907] Starting dynamic subtest: vcs0-smem [122.446741] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [122.449961] Starting dynamic subtest: vcs1-smem [122.450743] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [122.453981] Starting dynamic subtest: vecs0-smem [122.454853] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [122.455615] Subtest basic: SUCCESS (0.002s) [122.625806] [020/165] (935s left) gem_exec_create (basic) [122.661234] Starting subtest: basic [122.661996] Starting dynamic subtest: smem [124.748055] Dynamic subtest smem: SUCCESS (2.086s) [124.749654] Subtest basic: SUCCESS (2.086s) [124.934905] [021/165] (933s left) gem_exec_fence (basic-busy) [125.094439] Starting subtest: basic-busy [125.095425] Starting dynamic subtest: rcs0 [125.164373] Dynamic subtest rcs0: SUCCESS (0.079s) [125.168065] Starting dynamic subtest: bcs0 [125.216136] Dynamic subtest bcs0: SUCCESS (0.050s) [125.223720] Starting dynamic subtest: vcs0 [125.268140] Dynamic subtest vcs0: SUCCESS (0.052s) [125.280934] Starting dynamic subtest: vcs1 [125.319437] Dynamic subtest vcs1: SUCCESS (0.051s) [125.333196] Starting dynamic subtest: vecs0 [125.366431] Dynamic subtest vecs0: SUCCESS (0.047s) [125.367724] Subtest basic-busy: SUCCESS (0.281s) [125.873824] [022/165] (932s left) gem_exec_fence (basic-wait) [126.036284] Starting subtest: basic-wait [126.037641] Starting dynamic subtest: rcs0 [126.095603] Dynamic subtest rcs0: SUCCESS (0.067s) [126.104688] Starting dynamic subtest: bcs0 [126.145379] Dynamic subtest bcs0: SUCCESS (0.049s) [126.157780] Starting dynamic subtest: vcs0 [126.191969] Dynamic subtest vcs0: SUCCESS (0.047s) [126.199954] Starting dynamic subtest: vcs1 [126.246630] Dynamic subtest vcs1: SUCCESS (0.054s) [126.258220] Starting dynamic subtest: vecs0 [126.295574] Dynamic subtest vecs0: SUCCESS (0.048s) [126.298324] Subtest basic-wait: SUCCESS (0.267s) [126.787558] [023/165] (931s left) gem_exec_fence (basic-await) [126.951765] Starting subtest: basic-await [126.952421] Starting dynamic subtest: rcs0 [127.012154] Dynamic subtest rcs0: SUCCESS (0.069s) [127.018371] Starting dynamic subtest: bcs0 [127.085172] Dynamic subtest bcs0: SUCCESS (0.072s) [127.092892] Starting dynamic subtest: vcs0 [127.155537] Dynamic subtest vcs0: SUCCESS (0.070s) [127.167065] Starting dynamic subtest: vcs1 [127.232143] Dynamic subtest vcs1: SUCCESS (0.076s) [127.239630] Starting dynamic subtest: vecs0 [127.306594] Dynamic subtest vecs0: SUCCESS (0.074s) [127.308681] Subtest basic-await: SUCCESS (0.363s) [127.821403] [024/165] (930s left) gem_exec_fence (nb-await) [127.984673] Starting subtest: nb-await [127.985620] Starting dynamic subtest: rcs0 [128.034840] Dynamic subtest rcs0: SUCCESS (0.057s) [128.042837] Starting dynamic subtest: bcs0 [128.092750] Dynamic subtest bcs0: SUCCESS (0.058s) [128.100057] Starting dynamic subtest: vcs0 [128.152456] Dynamic subtest vcs0: SUCCESS (0.059s) [128.158401] Starting dynamic subtest: vcs1 [128.208485] Dynamic subtest vcs1: SUCCESS (0.056s) [128.221504] Starting dynamic subtest: vecs0 [128.272270] Dynamic subtest vecs0: SUCCESS (0.063s) [128.274852] Subtest nb-await: SUCCESS (0.295s) [128.755663] [025/165] (929s left) gem_exec_gttfill (basic) [128.790842] Starting subtest: basic [131.036355] Subtest basic: SUCCESS (2.236s) [131.204847] [026/165] (927s left) gem_exec_parallel (engines) [131.289985] Starting subtest: engines [131.290854] Starting dynamic subtest: basic [132.591219] Dynamic subtest basic: SUCCESS (1.301s) [132.596047] Starting dynamic subtest: contexts [134.252619] Dynamic subtest contexts: SUCCESS (1.652s) [134.257835] Starting dynamic subtest: fds [136.001328] Dynamic subtest fds: SUCCESS (1.758s) [136.008016] Starting dynamic subtest: userptr [137.282047] Dynamic subtest userptr: SUCCESS (1.280s) [137.283465] Subtest engines: SUCCESS (5.992s) [137.478046] [027/165] (920s left) gem_exec_store (basic) [137.512681] Starting subtest: basic [137.600341] Subtest basic: SUCCESS (0.086s) [137.787541] [028/165] (920s left) gem_flink_basic (bad-flink) [137.820804] Starting subtest: bad-flink [137.821767] Subtest bad-flink: SUCCESS (0.000s) [137.881691] [029/165] (920s left) gem_flink_basic (bad-open) [137.915282] Starting subtest: bad-open [137.916225] Subtest bad-open: SUCCESS (0.000s) [137.985429] [030/165] (920s left) gem_flink_basic (basic) [138.015772] Starting subtest: basic [138.016445] Subtest basic: SUCCESS (0.000s) [138.104707] [031/165] (920s left) gem_flink_basic (double-flink) [138.133625] Starting subtest: double-flink [138.134415] Subtest double-flink: SUCCESS (0.000s) [138.218031] [032/165] (920s left) gem_flink_basic (flink-lifetime) [138.248046] Starting subtest: flink-lifetime [138.248819] Subtest flink-lifetime: SUCCESS (0.001s) [138.336373] [033/165] (920s left) gem_huc_copy (huc-copy) [138.370039] Starting subtest: huc-copy [138.371597] Subtest huc-copy: SUCCESS (0.002s) [138.469969] [034/165] (919s left) gem_linear_blits (basic) [138.554682] Starting subtest: basic [138.558532] Subtest basic: SUCCESS (0.004s) [138.686301] [035/165] (919s left) gem_mmap (basic) [138.748575] Starting subtest: basic [138.752128] Subtest basic: SUCCESS (0.000s) [138.822136] [036/165] (919s left) gem_mmap_gtt (basic) [138.859641] Starting subtest: basic [138.860575] Subtest basic: SUCCESS (0.000s) [138.904926] [037/165] (919s left) gem_render_linear_blits (basic) [138.942835] Starting subtest: basic [138.962516] Subtest basic: SUCCESS (0.019s) [139.038124] [038/165] (919s left) gem_render_tiled_blits (basic) [139.069446] Starting subtest: basic [139.091893] Subtest basic: SUCCESS (0.023s) [139.152583] [039/165] (919s left) gem_ringfill (basic-all) [139.489598] Starting subtest: basic-all [140.622179] Subtest basic-all: SUCCESS (1.124s) [140.718514] [040/165] (917s left) gem_softpin (allocator-basic) [140.755569] Starting subtest: allocator-basic [140.799318] Subtest allocator-basic: SUCCESS (0.044s) [140.913081] [041/165] (917s left) gem_softpin (allocator-basic-reserve) [140.944101] Starting subtest: allocator-basic-reserve [140.991000] Subtest allocator-basic-reserve: SUCCESS (0.047s) [141.103272] [042/165] (917s left) gem_softpin (safe-alignment) [141.135455] Starting subtest: safe-alignment [141.142076] Subtest safe-alignment: SUCCESS (0.007s) [141.251109] [043/165] (917s left) gem_sync (basic-all) [141.294214] Starting subtest: basic-all [143.767052] Subtest basic-all: SUCCESS (2.478s) [143.960404] [044/165] (914s left) gem_sync (basic-each) [144.001448] Starting subtest: basic-each [146.185690] Subtest basic-each: SUCCESS (2.185s) [146.369382] [045/165] (912s left) gem_tiled_blits (basic) [146.447823] Starting subtest: basic [146.457860] Subtest basic: SUCCESS (0.010s) [146.574427] [046/165] (912s left) gem_tiled_fence_blits (basic) [146.682752] Starting subtest: basic [146.702860] Subtest basic: SUCCESS (0.020s) [146.818742] [047/165] (911s left) gem_tiled_pread_basic [146.924390] [048/165] (911s left) gem_wait (busy@all-engines) [146.961062] Starting subtest: busy [146.961898] Starting dynamic subtest: all-engines [147.513532] Dynamic subtest all-engines: SUCCESS (0.548s) [147.514991] Subtest busy: SUCCESS (0.549s) [147.723312] [049/165] (910s left) gem_wait (wait@all-engines) [147.760711] Starting subtest: wait [147.761493] Starting dynamic subtest: all-engines [148.812532] Dynamic subtest all-engines: SUCCESS (1.051s) [148.814348] Subtest wait: SUCCESS (1.051s) [149.017304] [050/165] (909s left) i915_getparams_basic (basic-eu-total) [149.048511] Starting subtest: basic-eu-total [149.050176] Subtest basic-eu-total: SUCCESS (0.000s) [149.116715] [051/165] (909s left) i915_getparams_basic (basic-subslice-total) [149.153433] Starting subtest: basic-subslice-total [149.155287] Subtest basic-subslice-total: SUCCESS (0.000s) [149.217468] [052/165] (909s left) i915_hangman (error-state-basic) [149.250182] Starting subtest: error-state-basic [149.336406] Subtest error-state-basic: SUCCESS (0.086s) [149.416387] [053/165] (909s left) i915_pciid [149.517431] [054/165] (909s left) kms_addfb_basic (addfb25-4-tiled) [151.457579] Starting subtest: addfb25-4-tiled [151.458475] Subtest addfb25-4-tiled: SUCCESS (0.000s) [151.539276] [055/165] (907s left) kms_addfb_basic (addfb25-bad-modifier) [151.574350] Starting subtest: addfb25-bad-modifier [151.575157] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [153.565542] [056/165] (905s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [153.594060] Starting subtest: addfb25-framebuffer-vs-set-tiling [153.594728] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [155.586586] [057/165] (903s left) kms_addfb_basic (addfb25-modifier-no-flag) [155.615905] Starting subtest: addfb25-modifier-no-flag [155.616821] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [157.605514] [058/165] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy) [157.639605] Starting subtest: addfb25-x-tiled-legacy [157.640448] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [159.628596] [059/165] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [159.663531] Starting subtest: addfb25-x-tiled-mismatch-legacy [159.664439] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [161.671294] [060/165] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [163.608063] Starting subtest: addfb25-yf-tiled-legacy [163.608825] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [163.691576] [061/165] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [165.629034] Starting subtest: addfb25-y-tiled-legacy [165.629708] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [165.719359] [062/165] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [167.662152] Starting subtest: addfb25-y-tiled-small-legacy [167.662922] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [167.741696] [063/165] (891s left) kms_addfb_basic (bad-pitch-0) [167.774749] Starting subtest: bad-pitch-0 [167.775553] Subtest bad-pitch-0: SUCCESS (0.000s) [169.772432] [064/165] (889s left) kms_addfb_basic (bad-pitch-1024) [169.799895] Starting subtest: bad-pitch-1024 [169.800764] Subtest bad-pitch-1024: SUCCESS (0.000s) [171.792322] [065/165] (887s left) kms_addfb_basic (bad-pitch-128) [171.828933] Starting subtest: bad-pitch-128 [171.829692] Subtest bad-pitch-128: SUCCESS (0.000s) [173.816545] [066/165] (885s left) kms_addfb_basic (bad-pitch-256) [173.850205] Starting subtest: bad-pitch-256 [173.850996] Subtest bad-pitch-256: SUCCESS (0.000s) [175.843629] [067/165] (883s left) kms_addfb_basic (bad-pitch-32) [175.881048] Starting subtest: bad-pitch-32 [175.881962] Subtest bad-pitch-32: SUCCESS (0.000s) [177.867800] [068/165] (880s left) kms_addfb_basic (bad-pitch-63) [177.898799] Starting subtest: bad-pitch-63 [177.899775] Subtest bad-pitch-63: SUCCESS (0.000s) [179.884682] [069/165] (878s left) kms_addfb_basic (bad-pitch-65536) [179.912748] Starting subtest: bad-pitch-65536 [179.913513] Subtest bad-pitch-65536: SUCCESS (0.000s) [181.905973] [070/165] (876s left) kms_addfb_basic (bad-pitch-999) [181.937983] Starting subtest: bad-pitch-999 [181.938845] Subtest bad-pitch-999: SUCCESS (0.000s) [183.930644] [071/165] (874s left) kms_addfb_basic (basic) [183.961932] Starting subtest: basic [183.962924] Subtest basic: SUCCESS (0.000s) [185.961255] [072/165] (872s left) kms_addfb_basic (basic-x-tiled-legacy) [185.989113] Starting subtest: basic-x-tiled-legacy [185.989798] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [187.979708] [073/165] (870s left) kms_addfb_basic (basic-y-tiled-legacy) [188.008969] Starting subtest: basic-y-tiled-legacy [188.009871] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [190.006465] [074/165] (868s left) kms_addfb_basic (bo-too-small) [191.947574] Starting subtest: bo-too-small [191.948314] Subtest bo-too-small: SUCCESS (0.000s) [192.042132] [075/165] (866s left) kms_addfb_basic (bo-too-small-due-to-tiling) [193.975754] Starting subtest: bo-too-small-due-to-tiling [193.976431] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [194.058692] [076/165] (864s left) kms_addfb_basic (clobberred-modifier) [194.087145] Starting subtest: clobberred-modifier [194.088029] Subtest clobberred-modifier: SUCCESS (0.000s) [196.089346] [077/165] (862s left) kms_addfb_basic (framebuffer-vs-set-tiling) [196.117633] Starting subtest: framebuffer-vs-set-tiling [196.118513] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [198.108667] [078/165] (860s left) kms_addfb_basic (invalid-get-prop) [198.137074] Starting subtest: invalid-get-prop [198.137978] Subtest invalid-get-prop: SUCCESS (0.000s) [200.131159] [079/165] (858s left) kms_addfb_basic (invalid-get-prop-any) [200.165186] Starting subtest: invalid-get-prop-any [200.166107] Subtest invalid-get-prop-any: SUCCESS (0.000s) [202.156425] [080/165] (856s left) kms_addfb_basic (invalid-set-prop) [202.185571] Starting subtest: invalid-set-prop [202.186269] Subtest invalid-set-prop: SUCCESS (0.000s) [204.177598] [081/165] (854s left) kms_addfb_basic (invalid-set-prop-any) [204.205070] Starting subtest: invalid-set-prop-any [204.206283] Subtest invalid-set-prop-any: SUCCESS (0.000s) [206.201282] [082/165] (852s left) kms_addfb_basic (no-handle) [206.228329] Starting subtest: no-handle [206.229339] Subtest no-handle: SUCCESS (0.000s) [208.225311] [083/165] (850s left) kms_addfb_basic (size-max) [210.159576] Starting subtest: size-max [210.160461] Subtest size-max: SUCCESS (0.000s) [210.241539] [084/165] (848s left) kms_addfb_basic (small-bo) [212.178088] Starting subtest: small-bo [212.178785] Subtest small-bo: SUCCESS (0.000s) [212.264963] [085/165] (846s left) kms_addfb_basic (tile-pitch-mismatch) [212.294613] Starting subtest: tile-pitch-mismatch [212.295479] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [214.285127] [086/165] (844s left) kms_addfb_basic (too-high) [216.227019] Starting subtest: too-high [216.228069] Subtest too-high: SUCCESS (0.000s) [216.312146] [087/165] (842s left) kms_addfb_basic (too-wide) [218.252268] Starting subtest: too-wide [218.253291] Subtest too-wide: SUCCESS (0.000s) [218.335507] [088/165] (840s left) kms_addfb_basic (unused-handle) [218.363085] Starting subtest: unused-handle [218.363946] Subtest unused-handle: SUCCESS (0.000s) [220.368137] [089/165] (838s left) kms_addfb_basic (unused-modifier) [220.402665] Starting subtest: unused-modifier [220.405230] Subtest unused-modifier: SUCCESS (0.000s) [222.394383] [090/165] (836s left) kms_addfb_basic (unused-offsets) [222.429214] Starting subtest: unused-offsets [222.430052] Subtest unused-offsets: SUCCESS (0.000s) [224.420078] [091/165] (834s left) kms_addfb_basic (unused-pitches) [224.456392] Starting subtest: unused-pitches [224.457182] Subtest unused-pitches: SUCCESS (0.000s) [226.464188] [092/165] (832s left) kms_busy (basic) [228.403077] Starting subtest: basic [228.404136] Starting dynamic subtest: flip [230.397998] Dynamic subtest flip: SUCCESS (1.994s) [230.412496] Starting dynamic subtest: modeset [234.443064] Dynamic subtest modeset: SUCCESS (4.024s) [234.448516] Subtest basic: SUCCESS (6.019s) [235.455323] [093/165] (823s left) kms_prop_blob (basic) [235.488608] Starting subtest: basic [235.489412] Subtest basic: SUCCESS (0.000s) [235.550244] [094/165] (823s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [237.519429] Starting subtest: basic-busy-flip-before-cursor-atomic [237.521069] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [237.622337] [095/165] (821s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [239.583220] Starting subtest: basic-busy-flip-before-cursor-legacy [239.584647] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [239.701933] [096/165] (819s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [241.664914] Starting subtest: basic-flip-after-cursor-atomic [244.033554] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.368s) [245.122071] [097/165] (814s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [247.083280] Starting subtest: basic-flip-after-cursor-legacy [249.408139] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.325s) [250.495278] [098/165] (808s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [252.458973] Starting subtest: basic-flip-after-cursor-varying-size [254.778210] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.319s) [255.875494] [099/165] (803s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [257.837855] Starting subtest: basic-flip-before-cursor-atomic [260.161559] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.324s) [261.248104] [100/165] (797s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [263.210037] Starting subtest: basic-flip-before-cursor-legacy [265.539316] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.329s) [266.628220] [101/165] (792s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [268.598356] Starting subtest: basic-flip-before-cursor-varying-size [270.971743] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.373s) [272.064063] [102/165] (787s left) kms_dsc (dsc-basic) [274.002798] Subtest dsc-basic: SKIP (0.000s) [274.029246] [103/165] (785s left) kms_flip (basic-flip-vs-dpms) [275.033214] Starting subtest: basic-flip-vs-dpms [275.035738] Starting dynamic subtest: A-eDP1 [277.747503] Dynamic subtest A-eDP1: SUCCESS (2.712s) [277.752073] Starting dynamic subtest: B-eDP1 [280.108223] Dynamic subtest B-eDP1: SUCCESS (2.360s) [280.112933] Starting dynamic subtest: C-eDP1 [282.481949] Dynamic subtest C-eDP1: SUCCESS (2.373s) [282.487546] Starting dynamic subtest: D-eDP1 [284.848205] Dynamic subtest D-eDP1: SUCCESS (2.366s) [284.854131] Starting dynamic subtest: A-DP3 [285.681049] Dynamic subtest A-DP3: SUCCESS (0.831s) [285.688674] Starting dynamic subtest: B-DP3 [286.457893] Dynamic subtest B-DP3: SUCCESS (0.776s) [286.465089] Starting dynamic subtest: C-DP3 [287.235954] Dynamic subtest C-DP3: SUCCESS (0.778s) [287.240959] Starting dynamic subtest: D-DP3 [288.018795] Dynamic subtest D-DP3: SUCCESS (0.783s) [288.019846] Subtest basic-flip-vs-dpms: SUCCESS (12.987s) [288.499669] [104/165] (770s left) kms_flip (basic-flip-vs-modeset) [289.517199] Starting subtest: basic-flip-vs-modeset [289.519347] Starting dynamic subtest: A-eDP1 [292.275075] Dynamic subtest A-eDP1: SUCCESS (2.753s) [292.280381] Starting dynamic subtest: B-eDP1 [294.642278] Dynamic subtest B-eDP1: SUCCESS (2.370s) [294.648478] Starting dynamic subtest: C-eDP1 [297.009632] Dynamic subtest C-eDP1: SUCCESS (2.366s) [297.014020] Starting dynamic subtest: D-eDP1 [299.372641] Dynamic subtest D-eDP1: SUCCESS (2.363s) [299.378117] Starting dynamic subtest: A-DP3 [300.190779] Dynamic subtest A-DP3: SUCCESS (0.817s) [300.195552] Starting dynamic subtest: B-DP3 [300.961762] Dynamic subtest B-DP3: SUCCESS (0.769s) [300.969206] Starting dynamic subtest: C-DP3 [301.724858] Dynamic subtest C-DP3: SUCCESS (0.763s) [301.729788] Starting dynamic subtest: D-DP3 [302.495617] Dynamic subtest D-DP3: SUCCESS (0.770s) [302.496455] Subtest basic-flip-vs-modeset: SUCCESS (12.979s) [302.965623] [105/165] (756s left) kms_flip (basic-flip-vs-wf_vblank) [303.975129] Starting subtest: basic-flip-vs-wf_vblank [303.976058] Starting dynamic subtest: A-eDP1 [306.015627] Dynamic subtest A-eDP1: SUCCESS (2.040s) [306.027192] Starting dynamic subtest: B-eDP1 [308.104437] Dynamic subtest B-eDP1: SUCCESS (2.086s) [308.114988] Starting dynamic subtest: C-eDP1 [310.131997] Dynamic subtest C-eDP1: SUCCESS (2.025s) [310.143137] Starting dynamic subtest: D-eDP1 [312.178400] Dynamic subtest D-eDP1: SUCCESS (2.045s) [312.188793] Starting dynamic subtest: A-DP3 [313.519700] Dynamic subtest A-DP3: SUCCESS (1.335s) [313.531374] Starting dynamic subtest: B-DP3 [314.596209] Dynamic subtest B-DP3: SUCCESS (1.074s) [314.607174] Starting dynamic subtest: C-DP3 [315.688060] Dynamic subtest C-DP3: SUCCESS (1.087s) [315.696861] Starting dynamic subtest: D-DP3 [316.769279] Dynamic subtest D-DP3: SUCCESS (1.076s) [316.771059] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.796s) [317.284481] [106/165] (742s left) kms_flip (basic-plain-flip) [318.285304] Starting subtest: basic-plain-flip [318.287591] Starting dynamic subtest: A-eDP1 [320.046733] Dynamic subtest A-eDP1: SUCCESS (1.758s) [320.057803] Starting dynamic subtest: B-eDP1 [321.835881] Dynamic subtest B-eDP1: SUCCESS (1.786s) [321.848941] Starting dynamic subtest: C-eDP1 [323.609711] Dynamic subtest C-eDP1: SUCCESS (1.771s) [323.617312] Starting dynamic subtest: D-eDP1 [325.335271] Dynamic subtest D-eDP1: SUCCESS (1.720s) [325.341559] Starting dynamic subtest: A-DP3 [326.391320] Dynamic subtest A-DP3: SUCCESS (1.052s) [326.399514] Starting dynamic subtest: B-DP3 [327.182504] Dynamic subtest B-DP3: SUCCESS (0.788s) [327.190636] Starting dynamic subtest: C-DP3 [327.974104] Dynamic subtest C-DP3: SUCCESS (0.787s) [327.979667] Starting dynamic subtest: D-DP3 [328.771534] Dynamic subtest D-DP3: SUCCESS (0.793s) [328.773107] Subtest basic-plain-flip: SUCCESS (10.486s) [329.326525] [107/165] (730s left) kms_force_connector_basic (force-connector-state) [329.362297] Starting subtest: force-connector-state [332.028241] Subtest force-connector-state: SUCCESS (2.666s) [334.946452] [108/165] (724s left) kms_force_connector_basic (force-edid) [334.975996] Starting subtest: force-edid [335.004940] Subtest force-edid: SUCCESS (0.030s) [337.058734] [109/165] (722s left) kms_force_connector_basic (force-load-detect) [337.086559] Starting subtest: force-load-detect [337.088036] Subtest force-load-detect: SKIP (0.000s) [338.147684] [110/165] (721s left) kms_force_connector_basic (prune-stale-modes) [338.179631] Starting subtest: prune-stale-modes [338.208034] Subtest prune-stale-modes: SUCCESS (0.029s) [340.263565] [111/165] (719s left) kms_frontbuffer_tracking (basic) [342.208404] Starting subtest: basic [347.152083] Subtest basic: SUCCESS (4.946s) [348.537943] [112/165] (710s left) kms_hdmi_inject (inject-audio) [349.138952] Starting subtest: inject-audio [349.234735] Subtest inject-audio: SUCCESS (0.094s) [350.927496] [113/165] (708s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [352.865466] Starting subtest: compare-crc-sanitycheck-xr24 [352.866323] Starting dynamic subtest: pipe-A-eDP-1 [354.815162] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s) [354.820969] Starting dynamic subtest: pipe-B-DP-3 [355.270730] Dynamic subtest pipe-B-DP-3: SUCCESS (0.455s) [355.275575] Starting dynamic subtest: pipe-C-DP-3 [355.751532] Dynamic subtest pipe-C-DP-3: SUCCESS (0.480s) [355.756282] Starting dynamic subtest: pipe-D-DP-3 [356.218429] Dynamic subtest pipe-D-DP-3: SUCCESS (0.465s) [356.219309] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.353s) [356.698303] [114/165] (702s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [358.636044] Starting subtest: compare-crc-sanitycheck-nv12 [358.637171] Starting dynamic subtest: pipe-A-eDP-1 [360.684925] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.049s) [360.689870] Starting dynamic subtest: pipe-B-DP-3 [361.297764] Dynamic subtest pipe-B-DP-3: SUCCESS (0.612s) [361.303292] Starting dynamic subtest: pipe-C-DP-3 [361.907964] Dynamic subtest pipe-C-DP-3: SUCCESS (0.609s) [361.913911] Starting dynamic subtest: pipe-D-DP-3 [362.517543] Dynamic subtest pipe-D-DP-3: SUCCESS (0.608s) [362.518483] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.883s) [362.993273] [115/165] (696s left) kms_pipe_crc_basic (hang-read-crc) [364.948074] Starting subtest: hang-read-crc [364.949923] Starting dynamic subtest: pipe-A-eDP-1 [368.495465] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.557s) [368.501295] Starting dynamic subtest: pipe-B-DP-3 [369.710407] Dynamic subtest pipe-B-DP-3: SUCCESS (1.213s) [369.715143] Starting dynamic subtest: pipe-C-DP-3 [370.923520] Dynamic subtest pipe-C-DP-3: SUCCESS (1.212s) [370.931221] Starting dynamic subtest: pipe-D-DP-3 [372.156901] Dynamic subtest pipe-D-DP-3: SUCCESS (1.231s) [372.157793] Subtest hang-read-crc: SUCCESS (7.218s) [372.622510] [116/165] (686s left) kms_pipe_crc_basic (nonblocking-crc) [374.558253] Starting subtest: nonblocking-crc [374.559174] Starting dynamic subtest: pipe-A-eDP-1 [376.632552] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s) [376.637898] Starting dynamic subtest: pipe-B-DP-3 [377.270117] Dynamic subtest pipe-B-DP-3: SUCCESS (0.636s) [377.274889] Starting dynamic subtest: pipe-C-DP-3 [377.908868] Dynamic subtest pipe-C-DP-3: SUCCESS (0.637s) [377.913835] Starting dynamic subtest: pipe-D-DP-3 [378.532655] Dynamic subtest pipe-D-DP-3: SUCCESS (0.623s) [378.533296] Subtest nonblocking-crc: SUCCESS (3.975s) [378.994652] [117/165] (680s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [380.932023] Starting subtest: nonblocking-crc-frame-sequence [380.932803] Starting dynamic subtest: pipe-A-eDP-1 [382.980418] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.047s) [382.985673] Starting dynamic subtest: pipe-B-DP-3 [383.617531] Dynamic subtest pipe-B-DP-3: SUCCESS (0.637s) [383.623411] Starting dynamic subtest: pipe-C-DP-3 [384.256849] Dynamic subtest pipe-C-DP-3: SUCCESS (0.638s) [384.262845] Starting dynamic subtest: pipe-D-DP-3 [384.897661] Dynamic subtest pipe-D-DP-3: SUCCESS (0.639s) [384.898535] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.966s) [385.365352] [118/165] (674s left) kms_pipe_crc_basic (read-crc) [387.303815] Starting subtest: read-crc [387.304962] Starting dynamic subtest: pipe-A-eDP-1 [389.326996] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.024s) [389.332766] Starting dynamic subtest: pipe-B-DP-3 [389.897966] Dynamic subtest pipe-B-DP-3: SUCCESS (0.568s) [389.902976] Starting dynamic subtest: pipe-C-DP-3 [390.469162] Dynamic subtest pipe-C-DP-3: SUCCESS (0.570s) [390.474030] Starting dynamic subtest: pipe-D-DP-3 [391.043500] Dynamic subtest pipe-D-DP-3: SUCCESS (0.574s) [391.044196] Subtest read-crc: SUCCESS (3.741s) [391.510587] [119/165] (667s left) kms_pipe_crc_basic (read-crc-frame-sequence) [393.445616] Starting subtest: read-crc-frame-sequence [393.446608] Starting dynamic subtest: pipe-A-eDP-1 [395.474276] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.028s) [395.479374] Starting dynamic subtest: pipe-B-DP-3 [396.064019] Dynamic subtest pipe-B-DP-3: SUCCESS (0.589s) [396.068747] Starting dynamic subtest: pipe-C-DP-3 [396.638194] Dynamic subtest pipe-C-DP-3: SUCCESS (0.573s) [396.642921] Starting dynamic subtest: pipe-D-DP-3 [397.211889] Dynamic subtest pipe-D-DP-3: SUCCESS (0.572s) [397.212746] Subtest read-crc-frame-sequence: SUCCESS (3.767s) [397.674660] [120/165] (661s left) kms_pm_backlight (basic-brightness) [399.610781] Starting subtest: basic-brightness [400.840610] Starting dynamic subtest: eDP-1 [401.154990] Dynamic subtest eDP-1: SUCCESS (0.314s) [401.155907] Subtest basic-brightness: SUCCESS (1.545s) [402.227760] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1817 [max: 8192] direct dependencies: 18300 [max: 32768] indirect dependencies: 140276 all direct dependencies: 386454 dependency chains: 27764 [max: 131072] dependency chain hlocks used: 121721 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 292 in-softirq chains: 645 in-process chains: 26827 stack-trace entries: 174612 [max: 1048576] number of stack traces: 8758 number of stack hash chains: 6850 combined max dependencies: 782982888 hardirq-safe locks: 104 hardirq-unsafe locks: 1086 softirq-safe locks: 220 softirq-unsafe locks: 994 irq-safe locks: 235 irq-unsafe locks: 1086 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 326 softirq-read-safe locks: 7 softirq-read-unsafe locks: 321 irq-read-safe locks: 7 irq-read-unsafe locks: 326 uncategorized locks: 286 unused locks: 1 max locking depth: 16 max bfs queue depth: 413 max lock class index: 1816 chain lookup misses: 28190 chain lookup hits: 461164963 cyclic checks: 28198 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5020 find-mask backwards checks: 2729 hardirq on events: 230247343 hardirq off events: 230247327 redundant hardirq ons: 36 redundant hardirq offs: 24 softirq on events: 1240249 softirq off events: 1240249 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 96 large chain blocks: 1 [402.228894] Closing watchdogs Done.