[81.282198] Initializing watchdogs [81.282254] /dev/watchdog0 [81.287255] [001/171] (960s left) i915_module_load (load) [81.328642] Starting subtest: load [94.608078] Subtest load: SUCCESS (13.279s) [94.617266] [002/171] (947s left) core_auth (basic-auth) [94.679858] Starting subtest: basic-auth [94.681388] Subtest basic-auth: SUCCESS (0.001s) [94.746270] [003/171] (947s left) debugfs_test (read_all_entries) [94.786245] Starting subtest: read_all_entries [95.002053] Subtest read_all_entries: SUCCESS (0.215s) [98.927558] [004/171] (942s left) debugfs_test (basic-hwmon) [98.966746] Starting subtest: basic-hwmon [98.968526] Subtest basic-hwmon: SKIP (0.000s) [102.894622] [005/171] (938s left) fbdev (eof) [102.942440] Starting subtest: eof [102.943475] Subtest eof: SUCCESS (0.000s) [102.994134] [006/171] (938s left) fbdev (info) [103.028058] Starting subtest: info [103.028716] Subtest info: SUCCESS (0.000s) [103.095284] [007/171] (938s left) fbdev (nullptr) [103.141547] Starting subtest: nullptr [103.142369] Subtest nullptr: SUCCESS (0.000s) [103.194696] [008/171] (938s left) fbdev (read) [103.242217] Starting subtest: read [105.850214] Subtest read: SUCCESS (2.598s) [105.905798] [009/171] (935s left) fbdev (write) [105.958938] Starting subtest: write [107.713877] Subtest write: SUCCESS (1.746s) [107.773374] [010/171] (934s left) gem_basic (bad-close) [107.807779] Starting subtest: bad-close [107.809056] Subtest bad-close: SUCCESS (0.000s) [107.879337] [011/171] (934s left) gem_basic (create-close) [107.917044] Starting subtest: create-close [107.918307] Subtest create-close: SUCCESS (0.000s) [107.998353] [012/171] (933s left) gem_basic (create-fd-close) [108.034461] Starting subtest: create-fd-close [108.035707] Subtest create-fd-close: SUCCESS (0.000s) [108.113516] [013/171] (933s left) gem_busy (busy@all-engines) [108.156955] Starting subtest: busy [108.157787] Starting dynamic subtest: all-engines [108.178771] Dynamic subtest all-engines: SUCCESS (0.022s) [108.179489] Subtest busy: SUCCESS (0.022s) [108.529052] [014/171] (933s left) gem_close_race (basic-process) [108.576484] Starting subtest: basic-process [108.609581] Subtest basic-process: SUCCESS (0.033s) [108.799940] [015/171] (933s left) gem_close_race (basic-threads) [108.842305] Starting subtest: basic-threads [110.071723] Subtest basic-threads: SUCCESS (1.229s) [110.257786] [016/171] (931s left) gem_ctx_create (basic) [110.301579] Starting subtest: basic [110.302410] Subtest basic: SUCCESS (0.000s) [110.487751] [017/171] (931s left) gem_ctx_create (basic-files) [110.527191] Starting subtest: basic-files [112.550356] Subtest basic-files: SUCCESS (2.023s) [113.089209] [018/171] (928s left) gem_ctx_exec (basic) [113.135784] Starting subtest: basic [113.138461] Subtest basic: SUCCESS (0.003s) [113.239471] [019/171] (928s left) gem_exec_basic (basic) [113.279710] Starting subtest: basic [113.280407] Starting dynamic subtest: rcs0-smem [113.281115] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [113.284761] Starting dynamic subtest: bcs0-smem [113.285506] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [113.298671] Starting dynamic subtest: vcs0-smem [113.299498] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [113.303117] Starting dynamic subtest: vcs1-smem [113.304038] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [113.307729] Starting dynamic subtest: vecs0-smem [113.308459] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [113.309141] Subtest basic: SUCCESS (0.002s) [113.468118] [020/171] (928s left) gem_exec_create (basic) [113.506967] Starting subtest: basic [113.507845] Starting dynamic subtest: smem [115.593458] Dynamic subtest smem: SUCCESS (2.086s) [115.594876] Subtest basic: SUCCESS (2.086s) [115.782927] [021/171] (926s left) gem_exec_fence (basic-busy) [115.954981] Starting subtest: basic-busy [115.957092] Starting dynamic subtest: rcs0 [115.997748] Dynamic subtest rcs0: SUCCESS (0.052s) [116.001324] Starting dynamic subtest: bcs0 [116.042098] Dynamic subtest bcs0: SUCCESS (0.043s) [116.051293] Starting dynamic subtest: vcs0 [116.093347] Dynamic subtest vcs0: SUCCESS (0.051s) [116.102060] Starting dynamic subtest: vcs1 [116.141785] Dynamic subtest vcs1: SUCCESS (0.048s) [116.154700] Starting dynamic subtest: vecs0 [116.195114] Dynamic subtest vecs0: SUCCESS (0.053s) [116.197774] Subtest basic-busy: SUCCESS (0.249s) [116.715606] [022/171] (925s left) gem_exec_fence (basic-wait) [116.882637] Starting subtest: basic-wait [116.884248] Starting dynamic subtest: rcs0 [116.948571] Dynamic subtest rcs0: SUCCESS (0.073s) [116.958881] Starting dynamic subtest: bcs0 [116.995891] Dynamic subtest bcs0: SUCCESS (0.047s) [117.007637] Starting dynamic subtest: vcs0 [117.043600] Dynamic subtest vcs0: SUCCESS (0.048s) [117.056028] Starting dynamic subtest: vcs1 [117.099811] Dynamic subtest vcs1: SUCCESS (0.055s) [117.113124] Starting dynamic subtest: vecs0 [117.151993] Dynamic subtest vecs0: SUCCESS (0.051s) [117.154877] Subtest basic-wait: SUCCESS (0.277s) [117.632706] [023/171] (924s left) gem_exec_fence (basic-await) [117.799684] Starting subtest: basic-await [117.800378] Starting dynamic subtest: rcs0 [117.862401] Dynamic subtest rcs0: SUCCESS (0.071s) [117.869496] Starting dynamic subtest: bcs0 [117.934360] Dynamic subtest bcs0: SUCCESS (0.071s) [117.942775] Starting dynamic subtest: vcs0 [118.007354] Dynamic subtest vcs0: SUCCESS (0.073s) [118.017179] Starting dynamic subtest: vcs1 [118.079677] Dynamic subtest vcs1: SUCCESS (0.072s) [118.087735] Starting dynamic subtest: vecs0 [118.156622] Dynamic subtest vecs0: SUCCESS (0.076s) [118.158171] Subtest basic-await: SUCCESS (0.365s) [118.649552] [024/171] (923s left) gem_exec_fence (nb-await) [118.816585] Starting subtest: nb-await [118.817482] Starting dynamic subtest: rcs0 [118.868907] Dynamic subtest rcs0: SUCCESS (0.060s) [118.878116] Starting dynamic subtest: bcs0 [118.929557] Dynamic subtest bcs0: SUCCESS (0.060s) [118.934873] Starting dynamic subtest: vcs0 [118.987313] Dynamic subtest vcs0: SUCCESS (0.058s) [118.997460] Starting dynamic subtest: vcs1 [119.048681] Dynamic subtest vcs1: SUCCESS (0.061s) [119.054882] Starting dynamic subtest: vecs0 [119.106550] Dynamic subtest vecs0: SUCCESS (0.057s) [119.109246] Subtest nb-await: SUCCESS (0.298s) [119.600857] [025/171] (922s left) gem_exec_gttfill (basic) [119.642920] Starting subtest: basic [121.914485] Subtest basic: SUCCESS (2.271s) [122.090180] [026/171] (919s left) gem_exec_parallel (engines) [122.164203] Starting subtest: engines [122.165290] Starting dynamic subtest: basic [123.616903] Dynamic subtest basic: SUCCESS (1.452s) [123.625803] Starting dynamic subtest: contexts [125.371306] Dynamic subtest contexts: SUCCESS (1.745s) [125.379138] Starting dynamic subtest: fds [127.244562] Dynamic subtest fds: SUCCESS (1.874s) [127.249326] Starting dynamic subtest: userptr [128.606527] Dynamic subtest userptr: SUCCESS (1.371s) [128.607608] Subtest engines: SUCCESS (6.442s) [128.798161] [027/171] (913s left) gem_exec_store (basic) [128.841048] Starting subtest: basic [128.917175] Subtest basic: SUCCESS (0.075s) [129.104283] [028/171] (912s left) gem_flink_basic (bad-flink) [129.142733] Starting subtest: bad-flink [129.143931] Subtest bad-flink: SUCCESS (0.000s) [129.221339] [029/171] (912s left) gem_flink_basic (bad-open) [129.261067] Starting subtest: bad-open [129.261997] Subtest bad-open: SUCCESS (0.000s) [129.333349] [030/171] (912s left) gem_flink_basic (basic) [129.368066] Starting subtest: basic [129.368768] Subtest basic: SUCCESS (0.000s) [129.452432] [031/171] (912s left) gem_flink_basic (double-flink) [129.488778] Starting subtest: double-flink [129.489444] Subtest double-flink: SUCCESS (0.000s) [129.571102] [032/171] (912s left) gem_flink_basic (flink-lifetime) [129.608092] Starting subtest: flink-lifetime [129.608786] Subtest flink-lifetime: SUCCESS (0.001s) [129.686807] [033/171] (912s left) gem_huc_copy (huc-copy) [129.727718] Starting subtest: huc-copy [129.729183] Subtest huc-copy: SUCCESS (0.002s) [129.836122] [034/171] (912s left) gem_linear_blits (basic) [129.937104] Starting subtest: basic [129.941300] Subtest basic: SUCCESS (0.005s) [130.066328] [035/171] (912s left) gem_mmap (basic) [130.136000] Starting subtest: basic [130.139563] Subtest basic: SUCCESS (0.000s) [130.216961] [036/171] (911s left) gem_mmap_gtt (basic) [130.253066] Starting subtest: basic [130.253971] Subtest basic: SUCCESS (0.000s) [130.303386] [037/171] (911s left) gem_render_linear_blits (basic) [130.345158] Starting subtest: basic [130.364885] Subtest basic: SUCCESS (0.020s) [130.432774] [038/171] (911s left) gem_render_tiled_blits (basic) [130.473167] Starting subtest: basic [130.496122] Subtest basic: SUCCESS (0.023s) [130.569520] [039/171] (911s left) gem_ringfill (basic-all) [130.899988] Starting subtest: basic-all [132.029183] Subtest basic-all: SUCCESS (1.123s) [132.135298] [040/171] (910s left) gem_softpin (allocator-basic) [132.175731] Starting subtest: allocator-basic [132.219983] Subtest allocator-basic: SUCCESS (0.045s) [132.333515] [041/171] (909s left) gem_softpin (allocator-basic-reserve) [132.373090] Starting subtest: allocator-basic-reserve [132.419150] Subtest allocator-basic-reserve: SUCCESS (0.046s) [132.520131] [042/171] (909s left) gem_softpin (safe-alignment) [132.557650] Starting subtest: safe-alignment [132.564695] Subtest safe-alignment: SUCCESS (0.007s) [132.667235] [043/171] (909s left) gem_sync (basic-all) [132.711560] Starting subtest: basic-all [135.092837] Subtest basic-all: SUCCESS (2.380s) [135.286178] [044/171] (906s left) gem_sync (basic-each) [135.328248] Starting subtest: basic-each [137.555860] Subtest basic-each: SUCCESS (2.226s) [137.743454] [045/171] (904s left) gem_tiled_blits (basic) [137.827078] Starting subtest: basic [137.836745] Subtest basic: SUCCESS (0.010s) [137.967564] [046/171] (904s left) gem_tiled_fence_blits (basic) [138.106098] Starting subtest: basic [138.126432] Subtest basic: SUCCESS (0.021s) [138.253778] [047/171] (904s left) gem_tiled_pread_basic [138.364418] [048/171] (903s left) gem_wait (busy@all-engines) [138.408967] Starting subtest: busy [138.410070] Starting dynamic subtest: all-engines [138.958313] Dynamic subtest all-engines: SUCCESS (0.548s) [138.959843] Subtest busy: SUCCESS (0.548s) [139.168169] [049/171] (903s left) gem_wait (wait@all-engines) [139.211905] Starting subtest: wait [139.212853] Starting dynamic subtest: all-engines [140.263719] Dynamic subtest all-engines: SUCCESS (1.050s) [140.265672] Subtest wait: SUCCESS (1.051s) [140.464873] [050/171] (901s left) i915_getparams_basic (basic-eu-total) [140.503757] Starting subtest: basic-eu-total [140.505608] Subtest basic-eu-total: SUCCESS (0.000s) [140.565463] [051/171] (901s left) i915_getparams_basic (basic-subslice-total) [140.603450] Starting subtest: basic-subslice-total [140.604915] Subtest basic-subslice-total: SUCCESS (0.000s) [140.663737] [052/171] (901s left) i915_hangman (error-state-basic) [140.705163] Starting subtest: error-state-basic [140.794710] Subtest error-state-basic: SUCCESS (0.090s) [140.874754] [053/171] (901s left) i915_pciid [140.981088] [054/171] (901s left) kms_addfb_basic (addfb25-bad-modifier) [141.018957] Starting subtest: addfb25-bad-modifier [141.019767] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [144.873799] [055/171] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [144.911203] Starting subtest: addfb25-framebuffer-vs-set-tiling [144.912097] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [148.773730] [056/171] (893s left) kms_addfb_basic (addfb25-modifier-no-flag) [148.809757] Starting subtest: addfb25-modifier-no-flag [148.810648] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [152.669263] [057/171] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy) [152.706848] Starting subtest: addfb25-x-tiled-legacy [152.707827] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [156.567378] [058/171] (885s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [156.603021] Starting subtest: addfb25-x-tiled-mismatch-legacy [156.603791] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [160.469567] [059/171] (881s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [164.272652] Starting subtest: addfb25-yf-tiled-legacy [164.273627] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [164.365608] [060/171] (878s left) kms_addfb_basic (addfb25-y-tiled-legacy) [168.170022] Starting subtest: addfb25-y-tiled-legacy [168.170857] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [168.262267] [061/171] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [172.061525] Starting subtest: addfb25-y-tiled-small-legacy [172.062323] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [172.158379] [062/171] (870s left) kms_addfb_basic (bad-pitch-0) [172.196443] Starting subtest: bad-pitch-0 [172.197135] Subtest bad-pitch-0: SUCCESS (0.000s) [176.053915] [063/171] (866s left) kms_addfb_basic (bad-pitch-1024) [176.090492] Starting subtest: bad-pitch-1024 [176.091170] Subtest bad-pitch-1024: SUCCESS (0.000s) [179.955907] [064/171] (862s left) kms_addfb_basic (bad-pitch-128) [179.994222] Starting subtest: bad-pitch-128 [179.994966] Subtest bad-pitch-128: SUCCESS (0.000s) [183.842268] [065/171] (858s left) kms_addfb_basic (bad-pitch-256) [183.877761] Starting subtest: bad-pitch-256 [183.878488] Subtest bad-pitch-256: SUCCESS (0.000s) [187.737214] [066/171] (854s left) kms_addfb_basic (bad-pitch-32) [187.772154] Starting subtest: bad-pitch-32 [187.772989] Subtest bad-pitch-32: SUCCESS (0.000s) [191.620761] [067/171] (850s left) kms_addfb_basic (bad-pitch-63) [191.658318] Starting subtest: bad-pitch-63 [191.659175] Subtest bad-pitch-63: SUCCESS (0.000s) [195.520884] [068/171] (846s left) kms_addfb_basic (bad-pitch-65536) [195.556767] Starting subtest: bad-pitch-65536 [195.557735] Subtest bad-pitch-65536: SUCCESS (0.000s) [199.411477] [069/171] (843s left) kms_addfb_basic (bad-pitch-999) [199.447791] Starting subtest: bad-pitch-999 [199.448807] Subtest bad-pitch-999: SUCCESS (0.000s) [203.313184] [070/171] (839s left) kms_addfb_basic (basic) [203.350698] Starting subtest: basic [203.351546] Subtest basic: SUCCESS (0.000s) [207.208329] [071/171] (835s left) kms_addfb_basic (basic-x-tiled-legacy) [207.245579] Starting subtest: basic-x-tiled-legacy [207.246468] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [211.099183] [072/171] (831s left) kms_addfb_basic (basic-y-tiled-legacy) [211.137820] Starting subtest: basic-y-tiled-legacy [211.138650] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [215.004594] [073/171] (827s left) kms_addfb_basic (bo-too-small) [218.809524] Starting subtest: bo-too-small [218.810484] Subtest bo-too-small: SUCCESS (0.000s) [218.897204] [074/171] (823s left) kms_addfb_basic (bo-too-small-due-to-tiling) [222.697973] Starting subtest: bo-too-small-due-to-tiling [222.698649] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [222.792420] [075/171] (819s left) kms_addfb_basic (clobberred-modifier) [222.829144] Starting subtest: clobberred-modifier [222.830071] Subtest clobberred-modifier: SUCCESS (0.000s) [226.687319] [076/171] (815s left) kms_addfb_basic (framebuffer-vs-set-tiling) [226.724256] Starting subtest: framebuffer-vs-set-tiling [226.725243] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [230.572704] [077/171] (812s left) kms_addfb_basic (invalid-get-prop) [230.611521] Starting subtest: invalid-get-prop [230.612520] Subtest invalid-get-prop: SUCCESS (0.000s) [234.472437] [078/171] (808s left) kms_addfb_basic (invalid-get-prop-any) [234.507462] Starting subtest: invalid-get-prop-any [234.513211] Subtest invalid-get-prop-any: SUCCESS (0.000s) [238.358879] [079/171] (804s left) kms_addfb_basic (invalid-set-prop) [238.394920] Starting subtest: invalid-set-prop [238.395763] Subtest invalid-set-prop: SUCCESS (0.000s) [242.257198] [080/171] (800s left) kms_addfb_basic (invalid-set-prop-any) [242.296669] Starting subtest: invalid-set-prop-any [242.297531] Subtest invalid-set-prop-any: SUCCESS (0.000s) [246.160670] [081/171] (796s left) kms_addfb_basic (no-handle) [246.197927] Starting subtest: no-handle [246.198898] Subtest no-handle: SUCCESS (0.000s) [250.051712] [082/171] (792s left) kms_addfb_basic (size-max) [253.861558] Starting subtest: size-max [253.862382] Subtest size-max: SUCCESS (0.000s) [253.973060] [083/171] (788s left) kms_addfb_basic (small-bo) [257.775707] Starting subtest: small-bo [257.776483] Subtest small-bo: SUCCESS (0.000s) [257.864026] [084/171] (784s left) kms_addfb_basic (tile-pitch-mismatch) [257.901619] Starting subtest: tile-pitch-mismatch [257.902597] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [261.763273] [085/171] (780s left) kms_addfb_basic (too-high) [265.564787] Starting subtest: too-high [265.565796] Subtest too-high: SUCCESS (0.000s) [265.663295] [086/171] (777s left) kms_addfb_basic (too-wide) [269.466751] Starting subtest: too-wide [269.467717] Subtest too-wide: SUCCESS (0.000s) [269.558231] [087/171] (773s left) kms_addfb_basic (unused-handle) [269.595298] Starting subtest: unused-handle [269.596049] Subtest unused-handle: SUCCESS (0.000s) [273.450312] [088/171] (769s left) kms_addfb_basic (unused-modifier) [273.486324] Starting subtest: unused-modifier [273.487078] Subtest unused-modifier: SUCCESS (0.000s) [277.336817] [089/171] (765s left) kms_addfb_basic (unused-offsets) [277.373455] Starting subtest: unused-offsets [277.374157] Subtest unused-offsets: SUCCESS (0.000s) [281.235682] [090/171] (761s left) kms_addfb_basic (unused-pitches) [281.274806] Starting subtest: unused-pitches [281.275758] Subtest unused-pitches: SUCCESS (0.000s) [285.133178] [091/171] (757s left) kms_busy (basic) [288.934596] Starting subtest: basic [288.935662] Starting dynamic subtest: flip [290.931124] Dynamic subtest flip: SUCCESS (1.996s) [290.936178] Starting dynamic subtest: modeset [294.869958] Dynamic subtest modeset: SUCCESS (3.939s) [294.870905] Subtest basic: SUCCESS (5.936s) [295.915141] [092/171] (746s left) kms_chamelium_hpd (dp-hpd-fast) [300.074867] Subtest dp-hpd-fast: SKIP (0.000s) [301.053509] [093/171] (741s left) kms_chamelium_edid (dp-edid-read) [305.203621] Subtest dp-edid-read: SKIP (0.000s) [306.195593] [094/171] (736s left) kms_chamelium_frames (dp-crc-fast) [310.374871] Subtest dp-crc-fast: SKIP (0.000s) [311.363081] [095/171] (731s left) kms_chamelium_hpd (hdmi-hpd-fast) [315.526684] Subtest hdmi-hpd-fast: SKIP (0.000s) [316.441218] [096/171] (726s left) kms_chamelium_edid (hdmi-edid-read) [320.584467] Subtest hdmi-edid-read: SKIP (0.000s) [321.526045] [097/171] (721s left) kms_chamelium_frames (hdmi-crc-fast) [325.692551] Subtest hdmi-crc-fast: SKIP (0.000s) [326.609835] [098/171] (716s left) kms_chamelium_hpd (vga-hpd-fast) [330.762407] Subtest vga-hpd-fast: SKIP (0.000s) [331.694121] [099/171] (711s left) kms_chamelium_edid (vga-edid-read) [335.843161] Subtest vga-edid-read: SKIP (0.000s) [336.830727] [100/171] (706s left) kms_prop_blob (basic) [336.869380] Starting subtest: basic [336.870080] Subtest basic: SUCCESS (0.000s) [336.936500] [101/171] (705s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [340.763614] Starting subtest: basic-busy-flip-before-cursor-atomic [340.764940] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [340.880214] [102/171] (702s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [344.707884] Starting subtest: basic-busy-flip-before-cursor-legacy [344.709525] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [344.827572] [103/171] (698s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [348.656379] Starting subtest: basic-flip-after-cursor-atomic [351.031434] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.375s) [352.103447] [104/171] (690s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [355.944189] Starting subtest: basic-flip-after-cursor-legacy [358.267033] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.322s) [359.334992] [105/171] (683s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [363.183897] Starting subtest: basic-flip-after-cursor-varying-size [365.558876] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.374s) [366.632693] [106/171] (676s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [370.461153] Starting subtest: basic-flip-before-cursor-atomic [372.801553] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.339s) [373.851263] [107/171] (669s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [377.689560] Starting subtest: basic-flip-before-cursor-legacy [380.028837] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.340s) [381.103452] [108/171] (661s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [384.935855] Starting subtest: basic-flip-before-cursor-varying-size [387.260984] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.325s) [388.340997] [109/171] (654s left) kms_flip (basic-flip-vs-dpms) [390.285607] Starting subtest: basic-flip-vs-dpms [390.288031] Starting dynamic subtest: A-eDP1 [392.998713] Dynamic subtest A-eDP1: SUCCESS (2.710s) [393.003525] Starting dynamic subtest: B-eDP1 [395.369608] Dynamic subtest B-eDP1: SUCCESS (2.371s) [395.374634] Starting dynamic subtest: C-eDP1 [397.742744] Dynamic subtest C-eDP1: SUCCESS (2.372s) [397.750544] Starting dynamic subtest: D-eDP1 [400.062638] Dynamic subtest D-eDP1: SUCCESS (2.320s) [400.068912] Starting dynamic subtest: A-DP3 [400.855044] Dynamic subtest A-DP3: SUCCESS (0.790s) [400.860122] Starting dynamic subtest: B-DP3 [401.600050] Dynamic subtest B-DP3: SUCCESS (0.745s) [401.607119] Starting dynamic subtest: C-DP3 [402.345919] Dynamic subtest C-DP3: SUCCESS (0.745s) [402.356555] Starting dynamic subtest: D-DP3 [403.092605] Dynamic subtest D-DP3: SUCCESS (0.745s) [403.093486] Subtest basic-flip-vs-dpms: SUCCESS (12.807s) [403.576563] [110/171] (639s left) kms_flip (basic-flip-vs-modeset) [405.522657] Starting subtest: basic-flip-vs-modeset [405.523567] Starting dynamic subtest: A-eDP1 [408.240986] Dynamic subtest A-eDP1: SUCCESS (2.717s) [408.246821] Starting dynamic subtest: B-eDP1 [410.597361] Dynamic subtest B-eDP1: SUCCESS (2.356s) [410.602615] Starting dynamic subtest: C-eDP1 [412.969588] Dynamic subtest C-eDP1: SUCCESS (2.372s) [412.974475] Starting dynamic subtest: D-eDP1 [415.342945] Dynamic subtest D-eDP1: SUCCESS (2.373s) [415.348814] Starting dynamic subtest: A-DP3 [416.132599] Dynamic subtest A-DP3: SUCCESS (0.788s) [416.137751] Starting dynamic subtest: B-DP3 [416.873031] Dynamic subtest B-DP3: SUCCESS (0.740s) [416.878246] Starting dynamic subtest: C-DP3 [417.610584] Dynamic subtest C-DP3: SUCCESS (0.736s) [417.615925] Starting dynamic subtest: D-DP3 [418.351198] Dynamic subtest D-DP3: SUCCESS (0.741s) [418.352088] Subtest basic-flip-vs-modeset: SUCCESS (12.831s) [418.831539] [111/171] (624s left) kms_flip (basic-flip-vs-wf_vblank) [420.772892] Starting subtest: basic-flip-vs-wf_vblank [420.774547] Starting dynamic subtest: A-eDP1 [422.814359] Dynamic subtest A-eDP1: SUCCESS (2.039s) [422.826992] Starting dynamic subtest: B-eDP1 [424.893916] Dynamic subtest B-eDP1: SUCCESS (2.077s) [424.902445] Starting dynamic subtest: C-eDP1 [426.921043] Dynamic subtest C-eDP1: SUCCESS (2.025s) [426.926142] Starting dynamic subtest: D-eDP1 [428.969591] Dynamic subtest D-eDP1: SUCCESS (2.049s) [428.975810] Starting dynamic subtest: A-DP3 [430.304418] Dynamic subtest A-DP3: SUCCESS (1.332s) [430.316592] Starting dynamic subtest: B-DP3 [431.370414] Dynamic subtest B-DP3: SUCCESS (1.064s) [431.375687] Starting dynamic subtest: C-DP3 [432.436244] Dynamic subtest C-DP3: SUCCESS (1.065s) [432.441175] Starting dynamic subtest: D-DP3 [433.522585] Dynamic subtest D-DP3: SUCCESS (1.085s) [433.523494] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.751s) [434.043545] [112/171] (609s left) kms_flip (basic-plain-flip) [435.987698] Starting subtest: basic-plain-flip [435.989889] Starting dynamic subtest: A-eDP1 [437.743933] Dynamic subtest A-eDP1: SUCCESS (1.753s) [437.753263] Starting dynamic subtest: B-eDP1 [439.540044] Dynamic subtest B-eDP1: SUCCESS (1.792s) [439.553644] Starting dynamic subtest: C-eDP1 [441.294817] Dynamic subtest C-eDP1: SUCCESS (1.752s) [441.300706] Starting dynamic subtest: D-eDP1 [443.021649] Dynamic subtest D-eDP1: SUCCESS (1.726s) [443.028966] Starting dynamic subtest: A-DP3 [444.052088] Dynamic subtest A-DP3: SUCCESS (1.028s) [444.058267] Starting dynamic subtest: B-DP3 [444.836698] Dynamic subtest B-DP3: SUCCESS (0.784s) [444.841851] Starting dynamic subtest: C-DP3 [445.622226] Dynamic subtest C-DP3: SUCCESS (0.785s) [445.627414] Starting dynamic subtest: D-DP3 [446.406788] Dynamic subtest D-DP3: SUCCESS (0.784s) [446.408803] Subtest basic-plain-flip: SUCCESS (10.421s) [446.932594] [113/171] (596s left) kms_force_connector_basic (force-connector-state) [446.973314] Starting subtest: force-connector-state [451.488161] Subtest force-connector-state: SUCCESS (4.514s) [456.247333] [114/171] (586s left) kms_force_connector_basic (force-edid) [456.287111] Starting subtest: force-edid [456.318501] Subtest force-edid: SUCCESS (0.031s) [460.223127] [115/171] (582s left) kms_force_connector_basic (force-load-detect) [460.261137] Starting subtest: force-load-detect [460.262976] Subtest force-load-detect: SKIP (0.000s) [462.247856] [116/171] (580s left) kms_force_connector_basic (prune-stale-modes) [462.288567] Starting subtest: prune-stale-modes [462.316937] Subtest prune-stale-modes: SUCCESS (0.029s) [466.224428] [117/171] (576s left) kms_frontbuffer_tracking (basic) [470.029824] Starting subtest: basic [474.964076] Subtest basic: SUCCESS (4.935s) [476.329310] [118/171] (566s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [480.134276] Starting subtest: compare-crc-sanitycheck-xr24 [480.135041] Starting dynamic subtest: pipe-A-eDP-1 [482.085691] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s) [482.090935] Starting dynamic subtest: pipe-B-DP-3 [482.608937] Dynamic subtest pipe-B-DP-3: SUCCESS (0.522s) [482.614132] Starting dynamic subtest: pipe-C-DP-3 [483.196338] Dynamic subtest pipe-C-DP-3: SUCCESS (0.586s) [483.202682] Starting dynamic subtest: pipe-D-DP-3 [483.849747] Dynamic subtest pipe-D-DP-3: SUCCESS (0.653s) [483.850576] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.716s) [484.291042] [119/171] (558s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [488.092566] Starting subtest: compare-crc-sanitycheck-nv12 [488.093558] Starting dynamic subtest: pipe-A-eDP-1 [490.148151] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.055s) [490.154273] Starting dynamic subtest: pipe-B-DP-3 [490.818254] Dynamic subtest pipe-B-DP-3: SUCCESS (0.669s) [490.823526] Starting dynamic subtest: pipe-C-DP-3 [491.554723] Dynamic subtest pipe-C-DP-3: SUCCESS (0.735s) [491.559929] Starting dynamic subtest: pipe-D-DP-3 [492.348436] Dynamic subtest pipe-D-DP-3: SUCCESS (0.793s) [492.349122] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.257s) [492.805864] [120/171] (550s left) kms_pipe_crc_basic (hang-read-crc) [496.603542] Starting subtest: hang-read-crc [496.605728] Starting dynamic subtest: pipe-A-eDP-1 [500.114630] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.510s) [500.119767] Starting dynamic subtest: pipe-B-DP-3 [501.449459] Dynamic subtest pipe-B-DP-3: SUCCESS (1.334s) [501.456290] Starting dynamic subtest: pipe-C-DP-3 [502.922179] Dynamic subtest pipe-C-DP-3: SUCCESS (1.470s) [502.927511] Starting dynamic subtest: pipe-D-DP-3 [504.554684] Dynamic subtest pipe-D-DP-3: SUCCESS (1.633s) [504.555447] Subtest hang-read-crc: SUCCESS (7.951s) [504.984508] [121/171] (538s left) kms_pipe_crc_basic (nonblocking-crc) [508.823516] Starting subtest: nonblocking-crc [508.824583] Starting dynamic subtest: pipe-A-eDP-1 [510.891328] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.076s) [510.897611] Starting dynamic subtest: pipe-B-DP-3 [511.570067] Dynamic subtest pipe-B-DP-3: SUCCESS (0.677s) [511.576263] Starting dynamic subtest: pipe-C-DP-3 [512.321040] Dynamic subtest pipe-C-DP-3: SUCCESS (0.750s) [512.326025] Starting dynamic subtest: pipe-D-DP-3 [513.159056] Dynamic subtest pipe-D-DP-3: SUCCESS (0.837s) [513.159880] Subtest nonblocking-crc: SUCCESS (4.344s) [513.596025] [122/171] (529s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [517.395659] Starting subtest: nonblocking-crc-frame-sequence [517.396741] Starting dynamic subtest: pipe-A-eDP-1 [519.476867] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.081s) [519.483485] Starting dynamic subtest: pipe-B-DP-3 [520.156535] Dynamic subtest pipe-B-DP-3: SUCCESS (0.678s) [520.161788] Starting dynamic subtest: pipe-C-DP-3 [520.906051] Dynamic subtest pipe-C-DP-3: SUCCESS (0.749s) [520.911142] Starting dynamic subtest: pipe-D-DP-3 [521.743164] Dynamic subtest pipe-D-DP-3: SUCCESS (0.836s) [521.744189] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.349s) [522.182898] [123/171] (520s left) kms_pipe_crc_basic (read-crc) [525.991609] Starting subtest: read-crc [525.992524] Starting dynamic subtest: pipe-A-eDP-1 [528.004309] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.013s) [528.009213] Starting dynamic subtest: pipe-B-DP-3 [528.618997] Dynamic subtest pipe-B-DP-3: SUCCESS (0.613s) [528.626386] Starting dynamic subtest: pipe-C-DP-3 [529.318021] Dynamic subtest pipe-C-DP-3: SUCCESS (0.698s) [529.323189] Starting dynamic subtest: pipe-D-DP-3 [530.081699] Dynamic subtest pipe-D-DP-3: SUCCESS (0.763s) [530.082440] Subtest read-crc: SUCCESS (4.091s) [530.499151] [124/171] (512s left) kms_pipe_crc_basic (read-crc-frame-sequence) [534.303099] Starting subtest: read-crc-frame-sequence [534.303855] Starting dynamic subtest: pipe-A-eDP-1 [536.307165] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.004s) [536.313737] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1819 [max: 8192] direct dependencies: 18306 [max: 32768] indirect dependencies: 138946 all direct dependencies: 390170 dependency chains: 27411 [max: 131072] dependency chain hlocks used: 119769 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 294 in-softirq chains: 617 in-process chains: 26500 stack-trace entries: 172233 [max: 1048576] number of stack traces: 8685 number of stack hash chains: 6723 combined max dependencies: 536430014 hardirq-safe locks: 108 hardirq-unsafe locks: 1081 softirq-safe locks: 219 softirq-unsafe locks: 992 irq-safe locks: 236 irq-unsafe locks: 1081 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 332 softirq-read-safe locks: 7 softirq-read-unsafe locks: 327 irq-read-safe locks: 7 irq-read-unsafe locks: 332 uncategorized locks: 284 unused locks: 1 max locking depth: 16 max bfs queue depth: 411 max lock class index: 1818 chain lookup misses: 27861 chain lookup hits: 748758447 cyclic checks: 27970 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4901 find-mask backwards checks: 2734 hardirq on events: 374516204 hardirq off events: 374516188 redundant hardirq ons: 28 redundant hardirq offs: 30 softirq on events: 2539541 softirq off events: 2539541 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 120 large chain blocks: 1 [536.315061] Starting dynamic subtest: pipe-B-DP-3 [536.914438] Dynamic subtest pipe-B-DP-3: SUCCESS (0.606s) [536.915112] Starting dynamic subtest: pipe-C-DP-3 [537.581728] Dynamic subtest pipe-C-DP-3: SUCCESS (0.667s) [537.582531] Starting dynamic subtest: pipe-D-DP-3 [538.322027] Dynamic subtest pipe-D-DP-3: SUCCESS (0.739s) [538.322803] Subtest read-crc-frame-sequence: SUCCESS (4.019s) [538.756934] Closing watchdogs Done.