[589.961925] Initializing watchdogs [589.961975] /dev/watchdog0 [589.966046] [001/171] (960s left) i915_module_load (load) [590.046629] Starting subtest: load [605.117376] Subtest load: SUCCESS (15.070s) [605.127742] [002/171] (945s left) core_auth (basic-auth) [605.166141] Starting subtest: basic-auth [605.167134] Subtest basic-auth: SUCCESS (0.000s) [605.252530] [003/171] (945s left) debugfs_test (read_all_entries) [605.290603] Starting subtest: read_all_entries [605.612773] Subtest read_all_entries: SUCCESS (0.320s) [609.548310] [004/171] (940s left) debugfs_test (basic-hwmon) [609.595157] Starting subtest: basic-hwmon [609.597030] Subtest basic-hwmon: SKIP (0.000s) [613.449489] [005/171] (937s left) fbdev (eof) [613.501372] Starting subtest: eof [613.502473] Subtest eof: SUCCESS (0.000s) [613.585799] [006/171] (936s left) fbdev (info) [613.621147] Starting subtest: info [613.622021] Subtest info: SUCCESS (0.000s) [613.717392] [007/171] (936s left) fbdev (nullptr) [613.768238] Starting subtest: nullptr [613.769164] Subtest nullptr: SUCCESS (0.000s) [613.849894] [008/171] (936s left) fbdev (read) [613.900701] Starting subtest: read [621.871719] Subtest read: SUCCESS (7.967s) [621.964914] [009/171] (928s left) fbdev (write) [622.018680] Starting subtest: write [627.542867] Subtest write: SUCCESS (5.524s) [627.641595] [010/171] (922s left) gem_basic (bad-close) [627.679050] Starting subtest: bad-close [627.680416] Subtest bad-close: SUCCESS (0.000s) [627.758178] [011/171] (922s left) gem_basic (create-close) [627.792922] Starting subtest: create-close [627.794515] Subtest create-close: SUCCESS (0.000s) [627.887296] [012/171] (922s left) gem_basic (create-fd-close) [627.931478] Starting subtest: create-fd-close [627.932870] Subtest create-fd-close: SUCCESS (0.000s) [628.026992] [013/171] (922s left) gem_busy (busy@all-engines) [628.070104] Starting subtest: busy [628.071192] Starting dynamic subtest: all-engines [628.090254] Dynamic subtest all-engines: SUCCESS (0.021s) [628.091115] Subtest busy: SUCCESS (0.021s) [628.440140] [014/171] (922s left) gem_close_race (basic-process) [628.482264] Starting subtest: basic-process [628.515756] Subtest basic-process: SUCCESS (0.032s) [628.714806] [015/171] (921s left) gem_close_race (basic-threads) [628.756569] Starting subtest: basic-threads [629.975775] Subtest basic-threads: SUCCESS (1.218s) [630.175378] [016/171] (920s left) gem_ctx_create (basic) [630.216571] Starting subtest: basic [630.217283] Subtest basic: SUCCESS (0.000s) [630.412553] [017/171] (920s left) gem_ctx_create (basic-files) [630.453050] Starting subtest: basic-files [632.461213] Subtest basic-files: SUCCESS (2.008s) [632.863201] [018/171] (917s left) gem_ctx_exec (basic) [632.900908] Starting subtest: basic [632.902827] Subtest basic: SUCCESS (0.003s) [633.008742] [019/171] (917s left) gem_exec_basic (basic) [633.050541] Starting subtest: basic [633.051353] Starting dynamic subtest: rcs0-smem [633.052143] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [633.056656] Starting dynamic subtest: bcs0-smem [633.057401] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [633.060841] Starting dynamic subtest: vcs0-smem [633.061718] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [633.064937] Starting dynamic subtest: vcs1-smem [633.065782] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [633.069050] Starting dynamic subtest: vecs0-smem [633.069864] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [633.070715] Subtest basic: SUCCESS (0.002s) [633.262549] [020/171] (917s left) gem_exec_create (basic) [633.302905] Starting subtest: basic [633.304028] Starting dynamic subtest: smem [635.388046] Dynamic subtest smem: SUCCESS (2.084s) [635.389710] Subtest basic: SUCCESS (2.085s) [635.588344] [021/171] (915s left) gem_exec_fence (basic-busy) [635.754397] Starting subtest: basic-busy [635.756310] Starting dynamic subtest: rcs0 [635.817310] Dynamic subtest rcs0: SUCCESS (0.071s) [635.830339] Starting dynamic subtest: bcs0 [635.866233] Dynamic subtest bcs0: SUCCESS (0.049s) [635.877771] Starting dynamic subtest: vcs0 [635.914373] Dynamic subtest vcs0: SUCCESS (0.047s) [635.923625] Starting dynamic subtest: vcs1 [635.961794] Dynamic subtest vcs1: SUCCESS (0.048s) [635.967046] Starting dynamic subtest: vecs0 [636.006209] Dynamic subtest vecs0: SUCCESS (0.044s) [636.008315] Subtest basic-busy: SUCCESS (0.261s) [636.532120] [022/171] (914s left) gem_exec_fence (basic-wait) [636.700946] Starting subtest: basic-wait [636.702878] Starting dynamic subtest: rcs0 [636.762997] Dynamic subtest rcs0: SUCCESS (0.070s) [636.775381] Starting dynamic subtest: bcs0 [636.811506] Dynamic subtest bcs0: SUCCESS (0.048s) [636.822731] Starting dynamic subtest: vcs0 [636.865096] Dynamic subtest vcs0: SUCCESS (0.053s) [636.872769] Starting dynamic subtest: vcs1 [636.915333] Dynamic subtest vcs1: SUCCESS (0.050s) [636.927762] Starting dynamic subtest: vecs0 [636.962664] Dynamic subtest vecs0: SUCCESS (0.047s) [636.964859] Subtest basic-wait: SUCCESS (0.271s) [637.459995] [023/171] (913s left) gem_exec_fence (basic-await) [637.629669] Starting subtest: basic-await [637.630521] Starting dynamic subtest: rcs0 [637.692548] Dynamic subtest rcs0: SUCCESS (0.071s) [637.699972] Starting dynamic subtest: bcs0 [637.762539] Dynamic subtest bcs0: SUCCESS (0.070s) [637.770765] Starting dynamic subtest: vcs0 [637.833507] Dynamic subtest vcs0: SUCCESS (0.070s) [637.844206] Starting dynamic subtest: vcs1 [637.907895] Dynamic subtest vcs1: SUCCESS (0.074s) [637.917452] Starting dynamic subtest: vecs0 [637.981122] Dynamic subtest vecs0: SUCCESS (0.073s) [637.982743] Subtest basic-await: SUCCESS (0.359s) [638.490488] [024/171] (912s left) gem_exec_fence (nb-await) [638.659571] Starting subtest: nb-await [638.660395] Starting dynamic subtest: rcs0 [638.710401] Dynamic subtest rcs0: SUCCESS (0.058s) [638.716688] Starting dynamic subtest: bcs0 [638.768596] Dynamic subtest bcs0: SUCCESS (0.057s) [638.777559] Starting dynamic subtest: vcs0 [638.828247] Dynamic subtest vcs0: SUCCESS (0.059s) [638.840286] Starting dynamic subtest: vcs1 [638.891702] Dynamic subtest vcs1: SUCCESS (0.063s) [638.895725] Starting dynamic subtest: vecs0 [638.948414] Dynamic subtest vecs0: SUCCESS (0.056s) [638.951727] Subtest nb-await: SUCCESS (0.297s) [639.444381] [025/171] (911s left) gem_exec_gttfill (basic) [639.484973] Starting subtest: basic [642.217460] Subtest basic: SUCCESS (2.723s) [642.404310] [026/171] (908s left) gem_exec_parallel (engines) [642.483289] Starting subtest: engines [642.484153] Starting dynamic subtest: basic [643.959053] Dynamic subtest basic: SUCCESS (1.475s) [643.969815] Starting dynamic subtest: contexts [645.703068] Dynamic subtest contexts: SUCCESS (1.735s) [645.711462] Starting dynamic subtest: fds [647.576466] Dynamic subtest fds: SUCCESS (1.873s) [647.584460] Starting dynamic subtest: userptr [648.949973] Dynamic subtest userptr: SUCCESS (1.382s) [648.952077] Subtest engines: SUCCESS (6.466s) [649.149975] [027/171] (901s left) gem_exec_store (basic) [649.191553] Starting subtest: basic [649.273654] Subtest basic: SUCCESS (0.081s) [649.467410] [028/171] (901s left) gem_flink_basic (bad-flink) [649.504867] Starting subtest: bad-flink [649.505808] Subtest bad-flink: SUCCESS (0.000s) [649.587313] [029/171] (901s left) gem_flink_basic (bad-open) [649.624119] Starting subtest: bad-open [649.624857] Subtest bad-open: SUCCESS (0.000s) [649.703497] [030/171] (901s left) gem_flink_basic (basic) [649.739741] Starting subtest: basic [649.740514] Subtest basic: SUCCESS (0.000s) [649.852894] [031/171] (900s left) gem_flink_basic (double-flink) [649.889716] Starting subtest: double-flink [649.890834] Subtest double-flink: SUCCESS (0.000s) [649.984727] [032/171] (900s left) gem_flink_basic (flink-lifetime) [650.021336] Starting subtest: flink-lifetime [650.022198] Subtest flink-lifetime: SUCCESS (0.001s) [650.117409] [033/171] (900s left) gem_huc_copy (huc-copy) [650.157576] Starting subtest: huc-copy [650.159480] Subtest huc-copy: SUCCESS (0.002s) [650.272155] [034/171] (900s left) gem_linear_blits (basic) [650.362752] Starting subtest: basic [650.367817] Subtest basic: SUCCESS (0.005s) [650.510525] [035/171] (900s left) gem_mmap (basic) [650.583524] Starting subtest: basic [650.587733] Subtest basic: SUCCESS (0.000s) [650.689160] [036/171] (900s left) gem_mmap_gtt (basic) [650.732306] Starting subtest: basic [650.733130] Subtest basic: SUCCESS (0.000s) [650.792593] [037/171] (900s left) gem_render_linear_blits (basic) [650.830973] Starting subtest: basic [650.849442] Subtest basic: SUCCESS (0.018s) [650.941342] [038/171] (899s left) gem_render_tiled_blits (basic) [650.979201] Starting subtest: basic [651.005109] Subtest basic: SUCCESS (0.026s) [651.092105] [039/171] (899s left) gem_ringfill (basic-all) [651.415243] Starting subtest: basic-all [652.558158] Subtest basic-all: SUCCESS (1.136s) [652.677125] [040/171] (898s left) gem_softpin (allocator-basic) [652.718715] Starting subtest: allocator-basic [652.767063] Subtest allocator-basic: SUCCESS (0.048s) [652.891477] [041/171] (897s left) gem_softpin (allocator-basic-reserve) [652.929043] Starting subtest: allocator-basic-reserve [652.977152] Subtest allocator-basic-reserve: SUCCESS (0.048s) [653.101626] [042/171] (897s left) gem_softpin (safe-alignment) [653.140922] Starting subtest: safe-alignment [653.148083] Subtest safe-alignment: SUCCESS (0.007s) [653.272610] [043/171] (897s left) gem_sync (basic-all) [653.316846] Starting subtest: basic-all [655.700902] Subtest basic-all: SUCCESS (2.385s) [655.905257] [044/171] (894s left) gem_sync (basic-each) [655.948145] Starting subtest: basic-each [658.235614] Subtest basic-each: SUCCESS (2.287s) [658.439447] [045/171] (892s left) gem_tiled_blits (basic) [658.524870] Starting subtest: basic [658.534048] Subtest basic: SUCCESS (0.010s) [658.674325] [046/171] (892s left) gem_tiled_fence_blits (basic) [658.801116] Starting subtest: basic [658.884670] Subtest basic: SUCCESS (0.084s) [659.018527] [047/171] (891s left) gem_tiled_pread_basic [659.150080] [048/171] (891s left) gem_wait (busy@all-engines) [659.200061] Starting subtest: busy [659.201151] Starting dynamic subtest: all-engines [659.750767] Dynamic subtest all-engines: SUCCESS (0.550s) [659.752618] Subtest busy: SUCCESS (0.550s) [659.969328] [049/171] (890s left) gem_wait (wait@all-engines) [660.011147] Starting subtest: wait [660.011999] Starting dynamic subtest: all-engines [661.062498] Dynamic subtest all-engines: SUCCESS (1.050s) [661.064357] Subtest wait: SUCCESS (1.051s) [661.285570] [050/171] (889s left) i915_getparams_basic (basic-eu-total) [661.322040] Starting subtest: basic-eu-total [661.323650] Subtest basic-eu-total: SUCCESS (0.000s) [661.405487] [051/171] (889s left) i915_getparams_basic (basic-subslice-total) [661.442423] Starting subtest: basic-subslice-total [661.443890] Subtest basic-subslice-total: SUCCESS (0.000s) [661.521043] [052/171] (889s left) i915_hangman (error-state-basic) [661.562941] Starting subtest: error-state-basic [661.733217] Subtest error-state-basic: SUCCESS (0.171s) [661.826730] [053/171] (889s left) i915_pciid [661.944017] [054/171] (889s left) kms_addfb_basic (addfb25-bad-modifier) [661.981857] Starting subtest: addfb25-bad-modifier [661.982785] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [665.858457] [055/171] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [665.894849] Starting subtest: addfb25-framebuffer-vs-set-tiling [665.895856] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [669.770767] [056/171] (881s left) kms_addfb_basic (addfb25-modifier-no-flag) [669.806124] Starting subtest: addfb25-modifier-no-flag [669.806999] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [673.680052] [057/171] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy) [673.717871] Starting subtest: addfb25-x-tiled-legacy [673.718863] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [677.590310] [058/171] (873s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [677.625420] Starting subtest: addfb25-x-tiled-mismatch-legacy [677.626239] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [681.484185] [059/171] (869s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [685.282113] Starting subtest: addfb25-yf-tiled-legacy [685.283109] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [685.378454] [060/171] (865s left) kms_addfb_basic (addfb25-y-tiled-legacy) [689.180130] Starting subtest: addfb25-y-tiled-legacy [689.180824] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [689.275166] [061/171] (861s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [693.074223] Starting subtest: addfb25-y-tiled-small-legacy [693.074930] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [693.168363] [062/171] (857s left) kms_addfb_basic (bad-pitch-0) [693.204012] Starting subtest: bad-pitch-0 [693.204835] Subtest bad-pitch-0: SUCCESS (0.000s) [697.070442] [063/171] (854s left) kms_addfb_basic (bad-pitch-1024) [697.108886] Starting subtest: bad-pitch-1024 [697.109798] Subtest bad-pitch-1024: SUCCESS (0.000s) [700.983719] [064/171] (850s left) kms_addfb_basic (bad-pitch-128) [701.022706] Starting subtest: bad-pitch-128 [701.023498] Subtest bad-pitch-128: SUCCESS (0.000s) [704.902233] [065/171] (846s left) kms_addfb_basic (bad-pitch-256) [704.938194] Starting subtest: bad-pitch-256 [704.939034] Subtest bad-pitch-256: SUCCESS (0.000s) [708.794268] [066/171] (842s left) kms_addfb_basic (bad-pitch-32) [708.830675] Starting subtest: bad-pitch-32 [708.831542] Subtest bad-pitch-32: SUCCESS (0.000s) [712.700808] [067/171] (838s left) kms_addfb_basic (bad-pitch-63) [712.738133] Starting subtest: bad-pitch-63 [712.739060] Subtest bad-pitch-63: SUCCESS (0.000s) [716.613290] [068/171] (834s left) kms_addfb_basic (bad-pitch-65536) [716.649538] Starting subtest: bad-pitch-65536 [716.650436] Subtest bad-pitch-65536: SUCCESS (0.000s) [720.516664] [069/171] (830s left) kms_addfb_basic (bad-pitch-999) [720.555096] Starting subtest: bad-pitch-999 [720.555895] Subtest bad-pitch-999: SUCCESS (0.000s) [724.426586] [070/171] (826s left) kms_addfb_basic (basic) [724.465082] Starting subtest: basic [724.465925] Subtest basic: SUCCESS (0.000s) [728.333488] [071/171] (822s left) kms_addfb_basic (basic-x-tiled-legacy) [728.371981] Starting subtest: basic-x-tiled-legacy [728.372818] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [732.227281] [072/171] (818s left) kms_addfb_basic (basic-y-tiled-legacy) [732.265291] Starting subtest: basic-y-tiled-legacy [732.266141] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [736.128516] [073/171] (815s left) kms_addfb_basic (bo-too-small) [739.931250] Starting subtest: bo-too-small [739.932187] Subtest bo-too-small: SUCCESS (0.000s) [740.027824] [074/171] (811s left) kms_addfb_basic (bo-too-small-due-to-tiling) [743.833677] Starting subtest: bo-too-small-due-to-tiling [743.834656] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [743.930075] [075/171] (807s left) kms_addfb_basic (clobberred-modifier) [743.966160] Starting subtest: clobberred-modifier [743.967126] Subtest clobberred-modifier: SUCCESS (0.000s) [747.830160] [076/171] (803s left) kms_addfb_basic (framebuffer-vs-set-tiling) [747.866268] Starting subtest: framebuffer-vs-set-tiling [747.867062] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [751.735903] [077/171] (799s left) kms_addfb_basic (invalid-get-prop) [751.778222] Starting subtest: invalid-get-prop [751.779112] Subtest invalid-get-prop: SUCCESS (0.000s) [755.654345] [078/171] (795s left) kms_addfb_basic (invalid-get-prop-any) [755.690178] Starting subtest: invalid-get-prop-any [755.690844] Subtest invalid-get-prop-any: SUCCESS (0.000s) [759.566716] [079/171] (791s left) kms_addfb_basic (invalid-set-prop) [759.604678] Starting subtest: invalid-set-prop [759.605575] Subtest invalid-set-prop: SUCCESS (0.000s) [763.473526] [080/171] (787s left) kms_addfb_basic (invalid-set-prop-any) [763.509471] Starting subtest: invalid-set-prop-any [763.510191] Subtest invalid-set-prop-any: SUCCESS (0.000s) [767.388955] [081/171] (783s left) kms_addfb_basic (no-handle) [767.425623] Starting subtest: no-handle [767.426638] Subtest no-handle: SUCCESS (0.000s) [771.290092] [082/171] (780s left) kms_addfb_basic (size-max) [775.092599] Starting subtest: size-max [775.093587] Subtest size-max: SUCCESS (0.000s) [775.197688] [083/171] (776s left) kms_addfb_basic (small-bo) [779.001497] Starting subtest: small-bo [779.002312] Subtest small-bo: SUCCESS (0.000s) [779.103190] [084/171] (772s left) kms_addfb_basic (tile-pitch-mismatch) [779.140190] Starting subtest: tile-pitch-mismatch [779.140933] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [783.005320] [085/171] (768s left) kms_addfb_basic (too-high) [786.808893] Starting subtest: too-high [786.809637] Subtest too-high: SUCCESS (0.000s) [786.926378] [086/171] (764s left) kms_addfb_basic (too-wide) [790.726020] Starting subtest: too-wide [790.727059] Subtest too-wide: SUCCESS (0.000s) [790.827765] [087/171] (760s left) kms_addfb_basic (unused-handle) [790.865106] Starting subtest: unused-handle [790.866114] Subtest unused-handle: SUCCESS (0.000s) [794.726369] [088/171] (756s left) kms_addfb_basic (unused-modifier) [794.763626] Starting subtest: unused-modifier [794.764580] Subtest unused-modifier: SUCCESS (0.000s) [798.632297] [089/171] (752s left) kms_addfb_basic (unused-offsets) [798.671132] Starting subtest: unused-offsets [798.672051] Subtest unused-offsets: SUCCESS (0.000s) [802.546793] [090/171] (748s left) kms_addfb_basic (unused-pitches) [802.584244] Starting subtest: unused-pitches [802.585200] Subtest unused-pitches: SUCCESS (0.000s) [806.445550] [091/171] (744s left) kms_busy (basic) [810.237798] Starting subtest: basic [810.238611] Starting dynamic subtest: flip [812.272290] Dynamic subtest flip: SUCCESS (2.033s) [812.277677] Starting dynamic subtest: modeset [815.992902] Dynamic subtest modeset: SUCCESS (3.717s) [815.993662] Subtest basic: SUCCESS (5.751s) [817.024102] [092/171] (734s left) kms_chamelium_hpd (dp-hpd-fast) [821.186722] Subtest dp-hpd-fast: SKIP (0.000s) [822.113664] [093/171] (729s left) kms_chamelium_edid (dp-edid-read) [826.275642] Subtest dp-edid-read: SKIP (0.000s) [827.191332] [094/171] (724s left) kms_chamelium_frames (dp-crc-fast) [831.341840] Subtest dp-crc-fast: SKIP (0.000s) [832.270695] [095/171] (719s left) kms_chamelium_hpd (hdmi-hpd-fast) [836.418405] Subtest hdmi-hpd-fast: SKIP (0.000s) [837.351429] [096/171] (714s left) kms_chamelium_edid (hdmi-edid-read) [841.498743] Subtest hdmi-edid-read: SKIP (0.000s) [842.448250] [097/171] (709s left) kms_chamelium_frames (hdmi-crc-fast) [846.611164] Subtest hdmi-crc-fast: SKIP (0.000s) [847.526238] [098/171] (704s left) kms_chamelium_hpd (vga-hpd-fast) [851.672197] Subtest vga-hpd-fast: SKIP (0.000s) [852.602928] [099/171] (698s left) kms_chamelium_edid (vga-edid-read) [856.753855] Subtest vga-edid-read: SKIP (0.000s) [857.683704] [100/171] (693s left) kms_prop_blob (basic) [857.724588] Starting subtest: basic [857.725546] Subtest basic: SUCCESS (0.000s) [857.807770] [101/171] (693s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [861.632109] Starting subtest: basic-busy-flip-before-cursor-atomic [861.633887] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [861.754578] [102/171] (689s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [865.582643] Starting subtest: basic-busy-flip-before-cursor-legacy [865.584481] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [865.706125] [103/171] (685s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [869.533792] Starting subtest: basic-flip-after-cursor-atomic [871.881723] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.348s) [872.957385] [104/171] (678s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [876.785121] Starting subtest: basic-flip-after-cursor-legacy [879.160604] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.376s) [880.258737] [105/171] (671s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [884.087762] Starting subtest: basic-flip-after-cursor-varying-size [886.464996] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.378s) [887.484123] [106/171] (664s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [891.312288] Starting subtest: basic-flip-before-cursor-atomic [893.697321] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.386s) [894.781755] [107/171] (656s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [898.608766] Starting subtest: basic-flip-before-cursor-legacy [900.925887] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.318s) [902.015617] [108/171] (649s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [905.839299] Starting subtest: basic-flip-before-cursor-varying-size [908.222025] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.382s) [909.306588] [109/171] (642s left) kms_flip (basic-flip-vs-dpms) [911.247291] Starting subtest: basic-flip-vs-dpms [911.247990] Starting dynamic subtest: A-eDP1 [913.966486] Dynamic subtest A-eDP1: SUCCESS (2.717s) [913.972300] Starting dynamic subtest: B-eDP1 [916.332233] Dynamic subtest B-eDP1: SUCCESS (2.366s) [916.337166] Starting dynamic subtest: C-eDP1 [918.703961] Dynamic subtest C-eDP1: SUCCESS (2.372s) [918.708698] Starting dynamic subtest: D-eDP1 [921.026050] Dynamic subtest D-eDP1: SUCCESS (2.321s) [921.031799] Starting dynamic subtest: A-DP3 [921.819969] Dynamic subtest A-DP3: SUCCESS (0.791s) [921.827498] Starting dynamic subtest: B-DP3 [922.553128] Dynamic subtest B-DP3: SUCCESS (0.733s) [922.559880] Starting dynamic subtest: C-DP3 [923.288580] Dynamic subtest C-DP3: SUCCESS (0.734s) [923.293627] Starting dynamic subtest: D-DP3 [924.219166] Dynamic subtest D-DP3: SUCCESS (0.931s) [924.220102] Subtest basic-flip-vs-dpms: SUCCESS (12.974s) [924.717401] [110/171] (626s left) kms_flip (basic-flip-vs-modeset) [926.644166] Starting subtest: basic-flip-vs-modeset [926.646492] Starting dynamic subtest: A-eDP1 [929.389787] Dynamic subtest A-eDP1: SUCCESS (2.743s) [929.394756] Starting dynamic subtest: B-eDP1 [931.753115] Dynamic subtest B-eDP1: SUCCESS (2.362s) [931.760748] Starting dynamic subtest: C-eDP1 [934.120928] Dynamic subtest C-eDP1: SUCCESS (2.368s) [934.128458] Starting dynamic subtest: D-eDP1 [936.485906] Dynamic subtest D-eDP1: SUCCESS (2.364s) [936.491849] Starting dynamic subtest: A-DP3 [937.282589] Dynamic subtest A-DP3: SUCCESS (0.794s) [937.287544] Starting dynamic subtest: B-DP3 [938.009729] Dynamic subtest B-DP3: SUCCESS (0.727s) [938.014723] Starting dynamic subtest: C-DP3 [938.729612] Dynamic subtest C-DP3: SUCCESS (0.720s) [938.734404] Starting dynamic subtest: D-DP3 [939.462510] Dynamic subtest D-DP3: SUCCESS (0.731s) [939.463491] Subtest basic-flip-vs-modeset: SUCCESS (12.818s) [939.944806] [111/171] (611s left) kms_flip (basic-flip-vs-wf_vblank) [941.881170] Starting subtest: basic-flip-vs-wf_vblank [941.883575] Starting dynamic subtest: A-eDP1 [943.922825] Dynamic subtest A-eDP1: SUCCESS (2.039s) [943.934353] Starting dynamic subtest: B-eDP1 [945.986357] Dynamic subtest B-eDP1: SUCCESS (2.061s) [945.994693] Starting dynamic subtest: C-eDP1 [948.015132] Dynamic subtest C-eDP1: SUCCESS (2.028s) [948.020053] Starting dynamic subtest: D-eDP1 [950.063891] Dynamic subtest D-eDP1: SUCCESS (2.048s) [950.069915] Starting dynamic subtest: A-DP3 [951.390573] Dynamic subtest A-DP3: SUCCESS (1.324s) [951.397416] Starting dynamic subtest: B-DP3 [952.472222] Dynamic subtest B-DP3: SUCCESS (1.080s) [952.477116] Starting dynamic subtest: C-DP3 [953.537986] Dynamic subtest C-DP3: SUCCESS (1.066s) [953.542894] Starting dynamic subtest: D-DP3 [954.608774] Dynamic subtest D-DP3: SUCCESS (1.070s) [954.609924] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.729s) [955.150511] [112/171] (596s left) kms_flip (basic-plain-flip) [957.086415] Starting subtest: basic-plain-flip [957.088822] Starting dynamic subtest: A-eDP1 [958.846267] Dynamic subtest A-eDP1: SUCCESS (1.757s) [958.855592] Starting dynamic subtest: B-eDP1 [960.615158] Dynamic subtest B-eDP1: SUCCESS (1.766s) [960.622115] Starting dynamic subtest: C-eDP1 [962.387122] Dynamic subtest C-eDP1: SUCCESS (1.771s) [962.391954] Starting dynamic subtest: D-eDP1 [964.115484] Dynamic subtest D-eDP1: SUCCESS (1.728s) [964.121630] Starting dynamic subtest: A-DP3 [965.164362] Dynamic subtest A-DP3: SUCCESS (1.046s) [965.171026] Starting dynamic subtest: B-DP3 [965.959902] Dynamic subtest B-DP3: SUCCESS (0.795s) [965.964780] Starting dynamic subtest: C-DP3 [966.740137] Dynamic subtest C-DP3: SUCCESS (0.779s) [966.747724] Starting dynamic subtest: D-DP3 [967.522060] Dynamic subtest D-DP3: SUCCESS (0.782s) [967.523058] Subtest basic-plain-flip: SUCCESS (10.437s) [968.044712] [113/171] (583s left) kms_force_connector_basic (force-connector-state) [968.083870] Starting subtest: force-connector-state [972.600709] Subtest force-connector-state: SUCCESS (4.516s) [977.362168] [114/171] (574s left) kms_force_connector_basic (force-edid) [977.400859] Starting subtest: force-edid [977.433616] Subtest force-edid: SUCCESS (0.033s) [981.356156] [115/171] (570s left) kms_force_connector_basic (force-load-detect) [981.394803] Starting subtest: force-load-detect [981.396544] Subtest force-load-detect: SKIP (0.000s) [983.400534] [116/171] (568s left) kms_force_connector_basic (prune-stale-modes) [983.441365] Starting subtest: prune-stale-modes [983.475275] Subtest prune-stale-modes: SUCCESS (0.034s) [987.396543] [117/171] (564s left) kms_frontbuffer_tracking (basic) [991.200763] Starting subtest: basic [996.143089] Subtest basic: SUCCESS (4.943s) [997.564605] [118/171] (554s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [1001.368433] Starting subtest: compare-crc-sanitycheck-xr24 [1001.369182] Starting dynamic subtest: pipe-A-eDP-1 [1003.305057] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s) [1003.310958] Starting dynamic subtest: pipe-B-DP-3 [1003.849860] Dynamic subtest pipe-B-DP-3: SUCCESS (0.542s) [1003.857456] Starting dynamic subtest: pipe-C-DP-3 [1004.304369] Dynamic subtest pipe-C-DP-3: SUCCESS (0.454s) [1004.310381] Starting dynamic subtest: pipe-D-DP-3 [1004.759229] Dynamic subtest pipe-D-DP-3: SUCCESS (0.454s) [1004.760064] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.392s) [1005.238371] [119/171] (546s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [1009.042707] Starting subtest: compare-crc-sanitycheck-nv12 [1009.043721] Starting dynamic subtest: pipe-A-eDP-1 [1011.365988] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.322s) [1011.370841] Starting dynamic subtest: pipe-B-DP-3 [1012.321899] Dynamic subtest pipe-B-DP-3: SUCCESS (0.954s) [1012.326852] Starting dynamic subtest: pipe-C-DP-3 [1013.175982] Dynamic subtest pipe-C-DP-3: SUCCESS (0.852s) [1013.181036] Starting dynamic subtest: pipe-D-DP-3 [1014.027276] Dynamic subtest pipe-D-DP-3: SUCCESS (0.850s) [1014.028250] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.985s) [1014.512499] [120/171] (537s left) kms_pipe_crc_basic (hang-read-crc) [1018.314201] Starting subtest: hang-read-crc [1018.315145] Starting dynamic subtest: pipe-A-eDP-1 [1021.883346] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.569s) [1021.890275] Starting dynamic subtest: pipe-B-DP-3 [1023.278358] Dynamic subtest pipe-B-DP-3: SUCCESS (1.393s) [1023.283510] Starting dynamic subtest: pipe-C-DP-3 [1024.562656] Dynamic subtest pipe-C-DP-3: SUCCESS (1.283s) [1024.567638] Starting dynamic subtest: pipe-D-DP-3 [1025.860952] Dynamic subtest pipe-D-DP-3: SUCCESS (1.297s) [1025.861869] Subtest hang-read-crc: SUCCESS (7.547s) [1026.325258] [121/171] (525s left) kms_pipe_crc_basic (nonblocking-crc) [1030.130533] Starting subtest: nonblocking-crc [1030.131542] Starting dynamic subtest: pipe-A-eDP-1 [1032.175696] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.043s) [1032.180657] Starting dynamic subtest: pipe-B-DP-3 [1032.895210] Dynamic subtest pipe-B-DP-3: SUCCESS (0.719s) [1032.901616] Starting dynamic subtest: pipe-C-DP-3 [1033.523338] Dynamic subtest pipe-C-DP-3: SUCCESS (0.626s) [1033.528321] Starting dynamic subtest: pipe-D-DP-3 [1034.154079] Dynamic subtest pipe-D-DP-3: SUCCESS (0.629s) [1034.154924] Subtest nonblocking-crc: SUCCESS (4.023s) [1034.610965] [122/171] (517s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [1038.406661] Starting subtest: nonblocking-crc-frame-sequence [1038.407627] Starting dynamic subtest: pipe-A-eDP-1 [1040.489829] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.083s) [1040.496044] Starting dynamic subtest: pipe-B-DP-3 [1041.193216] Dynamic subtest pipe-B-DP-3: SUCCESS (0.702s) [1041.198064] Starting dynamic subtest: pipe-C-DP-3 [1041.822079] Dynamic subtest pipe-C-DP-3: SUCCESS (0.628s) [1041.828289] Starting dynamic subtest: pipe-D-DP-3 [1042.453234] Dynamic subtest pipe-D-DP-3: SUCCESS (0.629s) [1042.454091] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.047s) [1042.906538] [123/171] (508s left) kms_pipe_crc_basic (read-crc) [1046.710470] Starting subtest: read-crc [1046.711420] Starting dynamic subtest: pipe-A-eDP-1 [1048.718811] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.008s) [1048.725136] Starting dynamic subtest: pipe-B-DP-3 [1049.370549] Dynamic subtest pipe-B-DP-3: SUCCESS (0.650s) [1049.375679] Starting dynamic subtest: pipe-C-DP-3 [1049.916666] Dynamic subtest pipe-C-DP-3: SUCCESS (0.545s) [1049.922063] Starting dynamic subtest: pipe-D-DP-3 [1050.483934] Dynamic subtest pipe-D-DP-3: SUCCESS (0.566s) [1050.484785] Subtest read-crc: SUCCESS (3.774s) [1050.944007] [124/171] (500s left) kms_pipe_crc_basic (read-crc-frame-sequence) [1054.744789] Starting subtest: read-crc-frame-sequence [1054.745665] Starting dynamic subtest: pipe-A-eDP-1 [1056.761573] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.016s) [1056.765630] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1807 [max: 8192] direct dependencies: 18130 [max: 32768] indirect dependencies: 139508 all direct dependencies: 388696 dependency chains: 26869 [max: 131072] dependency chain hlocks used: 116270 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 310 in-softirq chains: 626 in-process chains: 25933 stack-trace entries: 166129 [max: 1048576] number of stack traces: 8636 number of stack hash chains: 6813 combined max dependencies: 762084902 hardirq-safe locks: 108 hardirq-unsafe locks: 1071 softirq-safe locks: 216 softirq-unsafe locks: 981 irq-safe locks: 238 irq-unsafe locks: 1071 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 330 softirq-read-safe locks: 7 softirq-read-unsafe locks: 325 irq-read-safe locks: 7 irq-read-unsafe locks: 330 uncategorized locks: 281 unused locks: 1 max locking depth: 16 max bfs queue depth: 407 max lock class index: 1806 chain lookup misses: 27345 chain lookup hits: 781665858 cyclic checks: 27302 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4868 find-mask backwards checks: 2709 hardirq on events: 370740905 hardirq off events: 370740889 redundant hardirq ons: 30 redundant hardirq offs: 39 softirq on events: 3012252 softirq off events: 3012252 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 116 large chain blocks: 1 [1056.767196] Starting dynamic subtest: pipe-B-DP-3 [1057.394976] Dynamic subtest pipe-B-DP-3: SUCCESS (0.633s) [1057.395757] Starting dynamic subtest: pipe-C-DP-3 [1057.961057] Dynamic subtest pipe-C-DP-3: SUCCESS (0.565s) [1057.961800] Starting dynamic subtest: pipe-D-DP-3 [1058.509622] Dynamic subtest pipe-D-DP-3: SUCCESS (0.546s) [1058.510540] Subtest read-crc-frame-sequence: SUCCESS (3.764s) [1058.955695] Closing watchdogs Done.