[97.890324] Initializing watchdogs [97.890363] /dev/watchdog0 [97.894249] [001/160] (960s left) i915_module_load (load) [97.923075] Starting subtest: load [104.487592] Subtest load: SUCCESS (6.564s) [104.495881] [002/160] (953s left) core_auth (basic-auth) [104.554781] Starting subtest: basic-auth [104.555997] Subtest basic-auth: SUCCESS (0.001s) [104.639651] [003/160] (953s left) debugfs_test (read_all_entries) [104.685349] Starting subtest: read_all_entries [104.822481] Subtest read_all_entries: SUCCESS (0.136s) [106.804807] [004/160] (951s left) debugfs_test (basic-hwmon) [106.847670] Starting subtest: basic-hwmon [106.849419] Subtest basic-hwmon: SKIP (0.000s) [108.820980] [005/160] (949s left) fbdev (eof) [108.855070] Starting subtest: eof [108.856061] Subtest eof: SUCCESS (0.000s) [108.903221] [006/160] (949s left) fbdev (info) [108.928956] Starting subtest: info [108.929933] Subtest info: SUCCESS (0.000s) [108.988301] [007/160] (949s left) fbdev (nullptr) [109.038472] Starting subtest: nullptr [109.039625] Subtest nullptr: SUCCESS (0.000s) [109.091032] [008/160] (949s left) fbdev (read) [109.121278] Starting subtest: read [111.604595] Subtest read: SUCCESS (2.474s) [111.654970] [009/160] (946s left) fbdev (write) [111.688360] Starting subtest: write [113.527861] Subtest write: SUCCESS (1.830s) [113.572321] [010/160] (944s left) gem_basic (bad-close) [113.608613] Starting subtest: bad-close [113.610145] Subtest bad-close: SUCCESS (0.000s) [113.673845] [011/160] (944s left) gem_basic (create-close) [113.710598] Starting subtest: create-close [113.712215] Subtest create-close: SUCCESS (0.000s) [113.774736] [012/160] (944s left) gem_basic (create-fd-close) [113.817074] Starting subtest: create-fd-close [113.818728] Subtest create-fd-close: SUCCESS (0.000s) [113.892894] [013/160] (944s left) gem_busy (busy@all-engines) [113.932754] Starting subtest: busy [113.933414] Starting dynamic subtest: all-engines [113.971567] Dynamic subtest all-engines: SUCCESS (0.039s) [113.972337] Subtest busy: SUCCESS (0.039s) [114.312674] [014/160] (944s left) gem_close_race (basic-process) [114.361774] Starting subtest: basic-process [114.398395] Subtest basic-process: SUCCESS (0.036s) [114.579258] [015/160] (943s left) gem_close_race (basic-threads) [114.621098] Starting subtest: basic-threads [115.859900] Subtest basic-threads: SUCCESS (1.238s) [116.028515] [016/160] (942s left) gem_ctx_create (basic) [116.095480] Starting subtest: basic [116.096283] Subtest basic: SUCCESS (0.000s) [116.277322] [017/160] (942s left) gem_ctx_create (basic-files) [116.323158] Starting subtest: basic-files [118.334101] Subtest basic-files: SUCCESS (2.011s) [118.559205] [018/160] (940s left) gem_ctx_exec (basic) [118.605287] Starting subtest: basic [118.608944] Subtest basic: SUCCESS (0.004s) [118.716095] [019/160] (939s left) gem_exec_basic (basic) [118.765646] Starting subtest: basic [118.766427] Starting dynamic subtest: rcs0-smem [118.767224] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [118.772158] Starting dynamic subtest: bcs0-smem [118.772922] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [118.776531] Starting dynamic subtest: vcs0-smem [118.777281] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [118.780612] Starting dynamic subtest: vcs1-smem [118.781377] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [118.784875] Starting dynamic subtest: vecs0-smem [118.785616] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [118.786355] Subtest basic: SUCCESS (0.004s) [118.942232] [020/160] (939s left) gem_exec_create (basic) [118.990269] Starting subtest: basic [118.991298] Starting dynamic subtest: smem [121.077905] Dynamic subtest smem: SUCCESS (2.087s) [121.079855] Subtest basic: SUCCESS (2.087s) [121.260308] [021/160] (937s left) gem_exec_fence (basic-busy) [121.433076] Starting subtest: basic-busy [121.434654] Starting dynamic subtest: rcs0 [121.498791] Dynamic subtest rcs0: SUCCESS (0.074s) [121.506025] Starting dynamic subtest: bcs0 [121.546426] Dynamic subtest bcs0: SUCCESS (0.047s) [121.558827] Starting dynamic subtest: vcs0 [121.594501] Dynamic subtest vcs0: SUCCESS (0.048s) [121.606134] Starting dynamic subtest: vcs1 [121.642604] Dynamic subtest vcs1: SUCCESS (0.048s) [121.654295] Starting dynamic subtest: vecs0 [121.692645] Dynamic subtest vecs0: SUCCESS (0.050s) [121.694799] Subtest basic-busy: SUCCESS (0.268s) [122.194174] [022/160] (936s left) gem_exec_fence (basic-wait) [122.364290] Starting subtest: basic-wait [122.365763] Starting dynamic subtest: rcs0 [122.409280] Dynamic subtest rcs0: SUCCESS (0.054s) [122.417901] Starting dynamic subtest: bcs0 [122.460224] Dynamic subtest bcs0: SUCCESS (0.051s) [122.472433] Starting dynamic subtest: vcs0 [122.508503] Dynamic subtest vcs0: SUCCESS (0.048s) [122.520759] Starting dynamic subtest: vcs1 [122.556732] Dynamic subtest vcs1: SUCCESS (0.048s) [122.569248] Starting dynamic subtest: vecs0 [122.605311] Dynamic subtest vecs0: SUCCESS (0.049s) [122.607100] Subtest basic-wait: SUCCESS (0.250s) [123.084807] [023/160] (935s left) gem_exec_fence (basic-await) [123.270478] Starting subtest: basic-await [123.271287] Starting dynamic subtest: rcs0 [123.336023] Dynamic subtest rcs0: SUCCESS (0.073s) [123.342340] Starting dynamic subtest: bcs0 [123.404780] Dynamic subtest bcs0: SUCCESS (0.069s) [123.414274] Starting dynamic subtest: vcs0 [123.478118] Dynamic subtest vcs0: SUCCESS (0.073s) [123.485970] Starting dynamic subtest: vcs1 [123.549082] Dynamic subtest vcs1: SUCCESS (0.071s) [123.558428] Starting dynamic subtest: vecs0 [123.621638] Dynamic subtest vecs0: SUCCESS (0.072s) [123.623375] Subtest basic-await: SUCCESS (0.360s) [124.096223] [024/160] (934s left) gem_exec_fence (nb-await) [124.274699] Starting subtest: nb-await [124.275517] Starting dynamic subtest: rcs0 [124.324240] Dynamic subtest rcs0: SUCCESS (0.058s) [124.331609] Starting dynamic subtest: bcs0 [124.383609] Dynamic subtest bcs0: SUCCESS (0.059s) [124.395640] Starting dynamic subtest: vcs0 [124.445630] Dynamic subtest vcs0: SUCCESS (0.062s) [124.451741] Starting dynamic subtest: vcs1 [124.502819] Dynamic subtest vcs1: SUCCESS (0.057s) [124.514827] Starting dynamic subtest: vecs0 [124.564109] Dynamic subtest vecs0: SUCCESS (0.061s) [124.566162] Subtest nb-await: SUCCESS (0.298s) [125.045643] [025/160] (933s left) gem_exec_gttfill (basic) [125.091938] Starting subtest: basic [127.265662] Subtest basic: SUCCESS (2.173s) [127.444144] [026/160] (931s left) gem_exec_parallel (engines) [127.526850] Starting subtest: engines [127.527761] Starting dynamic subtest: basic [128.851621] Dynamic subtest basic: SUCCESS (1.325s) [128.859834] Starting dynamic subtest: contexts [130.708268] Dynamic subtest contexts: SUCCESS (1.847s) [130.712624] Starting dynamic subtest: fds [132.820154] Dynamic subtest fds: SUCCESS (2.121s) [132.824724] Starting dynamic subtest: userptr [134.112642] Dynamic subtest userptr: SUCCESS (1.292s) [134.114172] Subtest engines: SUCCESS (6.586s) [134.298075] [027/160] (924s left) gem_exec_store (basic) [134.340168] Starting subtest: basic [134.413205] Subtest basic: SUCCESS (0.072s) [134.575185] [028/160] (924s left) gem_flink_basic (bad-flink) [134.615635] Starting subtest: bad-flink [134.616494] Subtest bad-flink: SUCCESS (0.000s) [134.678598] [029/160] (924s left) gem_flink_basic (bad-open) [134.718598] Starting subtest: bad-open [134.719378] Subtest bad-open: SUCCESS (0.000s) [134.794203] [030/160] (923s left) gem_flink_basic (basic) [134.831838] Starting subtest: basic [134.832703] Subtest basic: SUCCESS (0.000s) [134.911191] [031/160] (923s left) gem_flink_basic (double-flink) [134.947647] Starting subtest: double-flink [134.948616] Subtest double-flink: SUCCESS (0.000s) [135.022705] [032/160] (923s left) gem_flink_basic (flink-lifetime) [135.060794] Starting subtest: flink-lifetime [135.061848] Subtest flink-lifetime: SUCCESS (0.001s) [135.126239] [033/160] (923s left) gem_huc_copy (huc-copy) [135.166053] Starting subtest: huc-copy [135.168069] Subtest huc-copy: SUCCESS (0.002s) [135.260106] [034/160] (923s left) gem_linear_blits (basic) [135.376938] Starting subtest: basic [135.382302] Subtest basic: SUCCESS (0.005s) [135.491006] [035/160] (923s left) gem_mmap (basic) [135.569729] Starting subtest: basic [135.573485] Subtest basic: SUCCESS (0.000s) [135.643794] [036/160] (923s left) gem_mmap_gtt (basic) [135.684930] Starting subtest: basic [135.685891] Subtest basic: SUCCESS (0.001s) [135.744297] [037/160] (923s left) gem_render_linear_blits (basic) [135.788293] Starting subtest: basic [135.808519] Subtest basic: SUCCESS (0.020s) [135.881581] [038/160] (922s left) gem_render_tiled_blits (basic) [135.925095] Starting subtest: basic [135.944071] Subtest basic: SUCCESS (0.019s) [136.016360] [039/160] (922s left) gem_ringfill (basic-all) [136.352473] Starting subtest: basic-all [137.468673] Subtest basic-all: SUCCESS (1.108s) [137.563111] [040/160] (921s left) gem_softpin (allocator-basic) [137.600714] Starting subtest: allocator-basic [137.646204] Subtest allocator-basic: SUCCESS (0.045s) [137.745059] [041/160] (921s left) gem_softpin (allocator-basic-reserve) [137.789835] Starting subtest: allocator-basic-reserve [137.835501] Subtest allocator-basic-reserve: SUCCESS (0.046s) [137.927437] [042/160] (920s left) gem_softpin (safe-alignment) [137.973462] Starting subtest: safe-alignment [137.981592] Subtest safe-alignment: SUCCESS (0.008s) [138.076294] [043/160] (920s left) gem_sync (basic-all) [138.120887] Starting subtest: basic-all [140.702811] Subtest basic-all: SUCCESS (2.582s) [140.882662] [044/160] (917s left) gem_sync (basic-each) [140.944718] Starting subtest: basic-each [143.281269] Subtest basic-each: SUCCESS (2.337s) [143.458964] [045/160] (915s left) gem_tiled_blits (basic) [143.566325] Starting subtest: basic [143.576278] Subtest basic: SUCCESS (0.010s) [143.692415] [046/160] (915s left) gem_tiled_fence_blits (basic) [143.823261] Starting subtest: basic [143.842884] Subtest basic: SUCCESS (0.020s) [143.953867] [047/160] (914s left) gem_tiled_pread_basic [144.066480] [048/160] (914s left) gem_wait (busy@all-engines) [144.110065] Starting subtest: busy [144.111052] Starting dynamic subtest: all-engines [144.674432] Dynamic subtest all-engines: SUCCESS (0.563s) [144.676358] Subtest busy: SUCCESS (0.563s) [144.879385] [049/160] (914s left) gem_wait (wait@all-engines) [144.924494] Starting subtest: wait [144.925225] Starting dynamic subtest: all-engines [145.980091] Dynamic subtest all-engines: SUCCESS (1.053s) [145.981247] Subtest wait: SUCCESS (1.053s) [146.165216] [050/160] (912s left) i915_getparams_basic (basic-eu-total) [146.209244] Starting subtest: basic-eu-total [146.211196] Subtest basic-eu-total: SUCCESS (0.000s) [146.274710] [051/160] (912s left) i915_getparams_basic (basic-subslice-total) [146.316836] Starting subtest: basic-subslice-total [146.318814] Subtest basic-subslice-total: SUCCESS (0.000s) [146.395576] [052/160] (912s left) i915_hangman (error-state-basic) [146.446112] Starting subtest: error-state-basic [146.532999] Subtest error-state-basic: SUCCESS (0.087s) [146.597749] [053/160] (912s left) i915_pciid [146.728054] [054/160] (912s left) kms_addfb_basic (addfb25-4-tiled) [148.694777] Starting subtest: addfb25-4-tiled [148.695530] Subtest addfb25-4-tiled: SUCCESS (0.000s) [148.758764] [055/160] (910s left) kms_addfb_basic (addfb25-bad-modifier) [148.799577] Starting subtest: addfb25-bad-modifier [148.800686] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [150.793811] [056/160] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [150.833995] Starting subtest: addfb25-framebuffer-vs-set-tiling [150.834874] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [152.826280] [057/160] (906s left) kms_addfb_basic (addfb25-modifier-no-flag) [152.872246] Starting subtest: addfb25-modifier-no-flag [152.873289] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [154.879553] [058/160] (904s left) kms_addfb_basic (addfb25-x-tiled-legacy) [154.920440] Starting subtest: addfb25-x-tiled-legacy [154.921361] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [156.909712] [059/160] (902s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [156.952011] Starting subtest: addfb25-x-tiled-mismatch-legacy [156.952982] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [158.942344] [060/160] (900s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [160.904885] Starting subtest: addfb25-yf-tiled-legacy [160.905935] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [160.996358] [061/160] (898s left) kms_addfb_basic (addfb25-y-tiled-legacy) [162.954891] Starting subtest: addfb25-y-tiled-legacy [162.956094] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [163.045299] [062/160] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [165.013852] Starting subtest: addfb25-y-tiled-small-legacy [165.014941] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [165.076069] [063/160] (893s left) kms_addfb_basic (bad-pitch-0) [165.126760] Starting subtest: bad-pitch-0 [165.127945] Subtest bad-pitch-0: SUCCESS (0.000s) [167.127653] [064/160] (891s left) kms_addfb_basic (bad-pitch-1024) [167.163835] Starting subtest: bad-pitch-1024 [167.164796] Subtest bad-pitch-1024: SUCCESS (0.000s) [169.167391] [065/160] (889s left) kms_addfb_basic (bad-pitch-128) [169.205951] Starting subtest: bad-pitch-128 [169.206890] Subtest bad-pitch-128: SUCCESS (0.000s) [171.193418] [066/160] (887s left) kms_addfb_basic (bad-pitch-256) [171.232658] Starting subtest: bad-pitch-256 [171.233440] Subtest bad-pitch-256: SUCCESS (0.000s) [173.228325] [067/160] (885s left) kms_addfb_basic (bad-pitch-32) [173.268012] Starting subtest: bad-pitch-32 [173.268944] Subtest bad-pitch-32: SUCCESS (0.000s) [175.261385] [068/160] (883s left) kms_addfb_basic (bad-pitch-63) [175.309936] Starting subtest: bad-pitch-63 [175.310840] Subtest bad-pitch-63: SUCCESS (0.000s) [177.313379] [069/160] (881s left) kms_addfb_basic (bad-pitch-65536) [177.352193] Starting subtest: bad-pitch-65536 [177.353304] Subtest bad-pitch-65536: SUCCESS (0.000s) [179.343648] [070/160] (879s left) kms_addfb_basic (bad-pitch-999) [179.388259] Starting subtest: bad-pitch-999 [179.389248] Subtest bad-pitch-999: SUCCESS (0.000s) [181.376763] [071/160] (877s left) kms_addfb_basic (basic) [181.416263] Starting subtest: basic [181.417173] Subtest basic: SUCCESS (0.000s) [183.392400] [072/160] (875s left) kms_addfb_basic (basic-x-tiled-legacy) [183.427082] Starting subtest: basic-x-tiled-legacy [183.427985] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [185.408853] [073/160] (873s left) kms_addfb_basic (basic-y-tiled-legacy) [185.448074] Starting subtest: basic-y-tiled-legacy [185.448894] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [187.444690] [074/160] (871s left) kms_addfb_basic (bo-too-small) [189.403581] Starting subtest: bo-too-small [189.404468] Subtest bo-too-small: SUCCESS (0.000s) [189.498139] [075/160] (869s left) kms_addfb_basic (bo-too-small-due-to-tiling) [191.457969] Starting subtest: bo-too-small-due-to-tiling [191.459088] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [191.529409] [076/160] (867s left) kms_addfb_basic (clobberred-modifier) [191.572069] Starting subtest: clobberred-modifier [191.572946] Subtest clobberred-modifier: SUCCESS (0.000s) [193.560204] [077/160] (865s left) kms_addfb_basic (framebuffer-vs-set-tiling) [193.604554] Starting subtest: framebuffer-vs-set-tiling [193.605673] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [195.595092] [078/160] (863s left) kms_addfb_basic (invalid-get-prop) [195.631167] Starting subtest: invalid-get-prop [195.632253] Subtest invalid-get-prop: SUCCESS (0.000s) [197.629081] [079/160] (861s left) kms_addfb_basic (invalid-get-prop-any) [197.670910] Starting subtest: invalid-get-prop-any [197.672089] Subtest invalid-get-prop-any: SUCCESS (0.000s) [199.660563] [080/160] (859s left) kms_addfb_basic (invalid-set-prop) [199.699758] Starting subtest: invalid-set-prop [199.700602] Subtest invalid-set-prop: SUCCESS (0.000s) [201.695067] [081/160] (857s left) kms_addfb_basic (invalid-set-prop-any) [201.729949] Starting subtest: invalid-set-prop-any [201.730843] Subtest invalid-set-prop-any: SUCCESS (0.000s) [203.711622] [082/160] (855s left) kms_addfb_basic (no-handle) [203.751210] Starting subtest: no-handle [203.752157] Subtest no-handle: SUCCESS (0.000s) [205.745532] [083/160] (853s left) kms_addfb_basic (size-max) [207.710677] Starting subtest: size-max [207.711857] Subtest size-max: SUCCESS (0.000s) [207.798199] [084/160] (851s left) kms_addfb_basic (small-bo) [209.771860] Starting subtest: small-bo [209.772843] Subtest small-bo: SUCCESS (0.000s) [209.866066] [085/160] (849s left) kms_addfb_basic (tile-pitch-mismatch) [209.902804] Starting subtest: tile-pitch-mismatch [209.903495] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [211.896291] [086/160] (847s left) kms_addfb_basic (too-high) [213.860846] Starting subtest: too-high [213.864812] Subtest too-high: SUCCESS (0.000s) [213.928861] [087/160] (845s left) kms_addfb_basic (too-wide) [215.894646] Starting subtest: too-wide [215.895709] Subtest too-wide: SUCCESS (0.000s) [215.963095] [088/160] (843s left) kms_addfb_basic (unused-handle) [216.006314] Starting subtest: unused-handle [216.007457] Subtest unused-handle: SUCCESS (0.000s) [217.995889] [089/160] (841s left) kms_addfb_basic (unused-modifier) [218.039437] Starting subtest: unused-modifier [218.040482] Subtest unused-modifier: SUCCESS (0.000s) [220.030373] [090/160] (839s left) kms_addfb_basic (unused-offsets) [220.073217] Starting subtest: unused-offsets [220.074087] Subtest unused-offsets: SUCCESS (0.000s) [222.062330] [091/160] (837s left) kms_addfb_basic (unused-pitches) [222.103225] Starting subtest: unused-pitches [222.104241] Subtest unused-pitches: SUCCESS (0.000s) [224.116218] [092/160] (835s left) kms_busy (basic) [226.086643] Starting subtest: basic [226.087378] Starting dynamic subtest: flip [226.636213] Dynamic subtest flip: SUCCESS (0.548s) [226.640968] Starting dynamic subtest: modeset [227.401674] Dynamic subtest modeset: SUCCESS (0.765s) [227.402345] Subtest basic: SUCCESS (1.315s) [227.566113] [093/160] (831s left) kms_prop_blob (basic) [227.613060] Starting subtest: basic [227.614279] Subtest basic: SUCCESS (0.000s) [227.681261] [094/160] (831s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [229.663836] Starting subtest: basic-busy-flip-before-cursor-atomic [229.665971] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [229.728596] [095/160] (829s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [231.696879] Starting subtest: basic-busy-flip-before-cursor-legacy [231.698901] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [231.761973] [096/160] (827s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [233.725941] Starting subtest: basic-flip-after-cursor-atomic [234.704904] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.979s) [234.866224] [097/160] (824s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [236.830734] Starting subtest: basic-flip-after-cursor-legacy [237.823568] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.993s) [237.984591] [098/160] (821s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [239.942877] Starting subtest: basic-flip-after-cursor-varying-size [240.907210] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.963s) [241.070483] [099/160] (818s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [243.037742] Starting subtest: basic-flip-before-cursor-atomic [244.008525] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.971s) [244.175945] [100/160] (815s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [246.141043] Starting subtest: basic-flip-before-cursor-legacy [247.131689] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.991s) [247.295978] [101/160] (812s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [249.264108] Starting subtest: basic-flip-before-cursor-varying-size [250.250827] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.987s) [250.410529] [102/160] (809s left) kms_dsc (dsc-basic) [252.374897] Starting subtest: dsc-basic [252.377261] Subtest dsc-basic: SKIP (0.000s) [252.440856] [103/160] (807s left) kms_flip (basic-flip-vs-dpms) [254.405850] Starting subtest: basic-flip-vs-dpms [254.407913] Starting dynamic subtest: A-DP1 [255.288917] Dynamic subtest A-DP1: SUCCESS (0.882s) [255.293965] Starting dynamic subtest: B-DP1 [256.043146] Dynamic subtest B-DP1: SUCCESS (0.753s) [256.049547] Starting dynamic subtest: C-DP1 [256.796260] Dynamic subtest C-DP1: SUCCESS (0.754s) [256.800887] Starting dynamic subtest: D-DP1 [257.552099] Dynamic subtest D-DP1: SUCCESS (0.755s) [257.553950] Subtest basic-flip-vs-dpms: SUCCESS (3.149s) [257.740116] [104/160] (801s left) kms_flip (basic-flip-vs-modeset) [259.717740] Starting subtest: basic-flip-vs-modeset [259.719733] Starting dynamic subtest: A-DP1 [260.614748] Dynamic subtest A-DP1: SUCCESS (0.895s) [260.619464] Starting dynamic subtest: B-DP1 [261.366870] Dynamic subtest B-DP1: SUCCESS (0.752s) [261.371773] Starting dynamic subtest: C-DP1 [262.121153] Dynamic subtest C-DP1: SUCCESS (0.753s) [262.128386] Starting dynamic subtest: D-DP1 [262.873801] Dynamic subtest D-DP1: SUCCESS (0.753s) [262.875877] Subtest basic-flip-vs-modeset: SUCCESS (3.159s) [263.026212] [105/160] (796s left) kms_flip (basic-flip-vs-wf_vblank) [264.985910] Starting subtest: basic-flip-vs-wf_vblank [264.988018] Starting dynamic subtest: A-DP1 [266.226651] Dynamic subtest A-DP1: SUCCESS (1.238s) [266.238508] Starting dynamic subtest: B-DP1 [267.238669] Dynamic subtest B-DP1: SUCCESS (1.009s) [267.247452] Starting dynamic subtest: C-DP1 [268.253217] Dynamic subtest C-DP1: SUCCESS (1.011s) [268.259646] Starting dynamic subtest: D-DP1 [269.288787] Dynamic subtest D-DP1: SUCCESS (1.030s) [269.291391] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.305s) [269.491354] [106/160] (790s left) kms_flip (basic-plain-flip) [271.462930] Starting subtest: basic-plain-flip [271.465328] Starting dynamic subtest: A-DP1 [272.250139] Dynamic subtest A-DP1: SUCCESS (0.784s) [272.258815] Starting dynamic subtest: B-DP1 [272.985517] Dynamic subtest B-DP1: SUCCESS (0.728s) [272.993737] Starting dynamic subtest: C-DP1 [273.714652] Dynamic subtest C-DP1: SUCCESS (0.729s) [273.722587] Starting dynamic subtest: D-DP1 [274.445309] Dynamic subtest D-DP1: SUCCESS (0.726s) [274.449989] Subtest basic-plain-flip: SUCCESS (2.988s) [274.664952] [107/160] (784s left) kms_force_connector_basic (force-connector-state) [274.733075] Starting subtest: force-connector-state [276.862332] Subtest force-connector-state: SUCCESS (2.129s) [279.017239] [108/160] (780s left) kms_force_connector_basic (force-edid) [279.084474] Starting subtest: force-edid [279.133306] Subtest force-edid: SUCCESS (0.049s) [281.217047] [109/160] (778s left) kms_force_connector_basic (force-load-detect) [281.289782] Starting subtest: force-load-detect [281.291218] Subtest force-load-detect: SKIP (0.000s) [282.368408] [110/160] (777s left) kms_force_connector_basic (prune-stale-modes) [282.435635] Starting subtest: prune-stale-modes [282.484058] Subtest prune-stale-modes: SUCCESS (0.049s) [284.569262] [111/160] (774s left) kms_frontbuffer_tracking (basic) [286.537965] Starting subtest: basic [289.983628] Subtest basic: SUCCESS (3.446s) [290.091654] [112/160] (769s left) kms_hdmi_inject (inject-audio) [290.209237] Starting subtest: inject-audio [290.339726] Subtest inject-audio: SUCCESS (0.132s) [291.543364] [113/160] (768s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [293.511976] Starting subtest: compare-crc-sanitycheck-xr24 [293.512947] Starting dynamic subtest: pipe-A-DP-1 [293.936500] Dynamic subtest pipe-A-DP-1: SUCCESS (0.423s) [293.941826] Starting dynamic subtest: pipe-B-DP-1 [294.334870] Dynamic subtest pipe-B-DP-1: SUCCESS (0.398s) [294.339797] Starting dynamic subtest: pipe-C-DP-1 [294.730381] Dynamic subtest pipe-C-DP-1: SUCCESS (0.394s) [294.735254] Starting dynamic subtest: pipe-D-DP-1 [295.130320] Dynamic subtest pipe-D-DP-1: SUCCESS (0.399s) [295.131140] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.618s) [295.288176] [114/160] (764s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [297.260795] Starting subtest: compare-crc-sanitycheck-nv12 [297.261688] Starting dynamic subtest: pipe-A-DP-1 [297.828211] Dynamic subtest pipe-A-DP-1: SUCCESS (0.566s) [297.833066] Starting dynamic subtest: pipe-B-DP-1 [298.380596] Dynamic subtest pipe-B-DP-1: SUCCESS (0.551s) [298.385690] Starting dynamic subtest: pipe-C-DP-1 [298.925062] Dynamic subtest pipe-C-DP-1: SUCCESS (0.543s) [298.929985] Starting dynamic subtest: pipe-D-DP-1 [299.469466] Dynamic subtest pipe-D-DP-1: SUCCESS (0.545s) [299.470227] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.209s) [299.635609] [115/160] (759s left) kms_pipe_crc_basic (hang-read-crc) [301.595773] Starting subtest: hang-read-crc [301.596640] Starting dynamic subtest: pipe-A-DP-1 [302.773306] Dynamic subtest pipe-A-DP-1: SUCCESS (1.176s) [302.778333] Starting dynamic subtest: pipe-B-DP-1 [303.873427] Dynamic subtest pipe-B-DP-1: SUCCESS (1.095s) [303.879840] Starting dynamic subtest: pipe-C-DP-1 [304.990151] Dynamic subtest pipe-C-DP-1: SUCCESS (1.118s) [304.996115] Starting dynamic subtest: pipe-D-DP-1 [306.113656] Dynamic subtest pipe-D-DP-1: SUCCESS (1.122s) [306.114291] Subtest hang-read-crc: SUCCESS (4.518s) [306.258419] [116/160] (753s left) kms_pipe_crc_basic (nonblocking-crc) [308.222734] Starting subtest: nonblocking-crc [308.223638] Starting dynamic subtest: pipe-A-DP-1 [308.815910] Dynamic subtest pipe-A-DP-1: SUCCESS (0.592s) [308.822576] Starting dynamic subtest: pipe-B-DP-1 [309.395870] Dynamic subtest pipe-B-DP-1: SUCCESS (0.578s) [309.400712] Starting dynamic subtest: pipe-C-DP-1 [309.975279] Dynamic subtest pipe-C-DP-1: SUCCESS (0.578s) [309.981402] Starting dynamic subtest: pipe-D-DP-1 [310.556984] Dynamic subtest pipe-D-DP-1: SUCCESS (0.580s) [310.557766] Subtest nonblocking-crc: SUCCESS (2.334s) [310.701411] [117/160] (748s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [312.671747] Starting subtest: nonblocking-crc-frame-sequence [312.672766] Starting dynamic subtest: pipe-A-DP-1 [313.311768] Dynamic subtest pipe-A-DP-1: SUCCESS (0.638s) [313.316746] Starting dynamic subtest: pipe-B-DP-1 [313.884889] Dynamic subtest pipe-B-DP-1: SUCCESS (0.572s) [313.892365] Starting dynamic subtest: pipe-C-DP-1 [314.465478] Dynamic subtest pipe-C-DP-1: SUCCESS (0.579s) [314.470522] Starting dynamic subtest: pipe-D-DP-1 [315.027328] Dynamic subtest pipe-D-DP-1: SUCCESS (0.561s) [315.028168] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.355s) [315.174407] [118/160] (744s left) kms_pipe_crc_basic (read-crc) [317.133917] Starting subtest: read-crc [317.135071] Starting dynamic subtest: pipe-A-DP-1 [317.675683] Dynamic subtest pipe-A-DP-1: SUCCESS (0.541s) [317.681914] Starting dynamic subtest: pipe-B-DP-1 [318.170357] Dynamic subtest pipe-B-DP-1: SUCCESS (0.493s) [318.175964] Starting dynamic subtest: pipe-C-DP-1 [318.682267] Dynamic subtest pipe-C-DP-1: SUCCESS (0.510s) [318.687217] Starting dynamic subtest: pipe-D-DP-1 [319.193023] Dynamic subtest pipe-D-DP-1: SUCCESS (0.509s) [319.193831] Subtest read-crc: SUCCESS (2.058s) [319.334556] [119/160] (740s left) kms_pipe_crc_basic (read-crc-frame-sequence) [321.297948] Starting subtest: read-crc-frame-sequence [321.299035] Starting dynamic subtest: pipe-A-DP-1 [321.839414] Dynamic subtest pipe-A-DP-1: SUCCESS (0.540s) [321.844359] Starting dynamic subtest: pipe-B-DP-1 [322.349596] Dynamic subtest pipe-B-DP-1: SUCCESS (0.510s) [322.355681] Starting dynamic subtest: pipe-C-DP-1 [322.882637] Dynamic subtest pipe-C-DP-1: SUCCESS (0.531s) [322.887602] Starting dynamic subtest: pipe-D-DP-1 [323.395115] Dynamic subtest pipe-D-DP-1: SUCCESS (0.511s) [323.395852] Subtest read-crc-frame-sequence: SUCCESS (2.096s) [323.544289] [120/160] (736s left) kms_pm_backlight (basic-brightness) [325.516425] Subtest basic-brightness: SKIP (0.000s) [325.540808] [121/160] (734s left) kms_pm_rpm (basic-pci-d3-state) [329.679556] Starting subtest: basic-pci-d3-state [332.445990] Subtest basic-pci-d3-state: SUCCESS (2.767s) [333.510702] [122/160] (726s left) kms_pm_rpm (basic-rte) [333.536787] Starting subtest: basic-rte [339.869171] Subtest basic-rte: SUCCESS (6.332s) [343.057814] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1795 [max: 8192] direct dependencies: 18338 [max: 32768] indirect dependencies: 135456 all direct dependencies: 361808 dependency chains: 27019 [max: 131072] dependency chain hlocks used: 114272 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 261 in-softirq chains: 623 in-process chains: 26135 stack-trace entries: 174477 [max: 1048576] number of stack traces: 8763 number of stack hash chains: 6805 combined max dependencies: 4272922368 hardirq-safe locks: 96 hardirq-unsafe locks: 1070 softirq-safe locks: 209 softirq-unsafe locks: 978 irq-safe locks: 225 irq-unsafe locks: 1070 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 327 softirq-read-safe locks: 7 softirq-read-unsafe locks: 322 irq-read-safe locks: 7 irq-read-unsafe locks: 327 uncategorized locks: 290 unused locks: 1 max locking depth: 14 max bfs queue depth: 437 max lock class index: 1794 chain lookup misses: 27456 chain lookup hits: 443953347 cyclic checks: 27585 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4556 find-mask backwards checks: 2699 hardirq on events: 208928300 hardirq off events: 208928284 redundant hardirq ons: 24 redundant hardirq offs: 26 softirq on events: 1165492 softirq off events: 1165492 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 107 large chain blocks: 1 [343.059411] Closing watchdogs Done.