[101.298406] Initializing watchdogs [101.298451] /dev/watchdog0 [101.302297] [001/160] (960s left) i915_module_load (load) [101.337598] Starting subtest: load [113.051336] Subtest load: SUCCESS (11.714s) [113.066486] [002/160] (948s left) core_auth (basic-auth) [113.120383] Starting subtest: basic-auth [113.121859] Subtest basic-auth: SUCCESS (0.001s) [114.173901] [003/160] (947s left) debugfs_test (read_all_entries) [114.228100] Starting subtest: read_all_entries [114.460124] Subtest read_all_entries: SUCCESS (0.232s) [116.489558] [004/160] (945s left) debugfs_test (basic-hwmon) [116.548849] Starting subtest: basic-hwmon [116.550320] Subtest basic-hwmon: SKIP (0.000s) [118.581782] [005/160] (943s left) fbdev (eof) [118.631394] Starting subtest: eof [118.632316] Subtest eof: SUCCESS (0.000s) [118.681330] [006/160] (943s left) fbdev (info) [118.707184] Starting subtest: info [118.708344] Subtest info: SUCCESS (0.000s) [118.767063] [007/160] (943s left) fbdev (nullptr) [118.814748] Starting subtest: nullptr [118.815730] Subtest nullptr: SUCCESS (0.000s) [118.865777] [008/160] (943s left) fbdev (read) [118.897753] Starting subtest: read [121.515703] Subtest read: SUCCESS (2.609s) [121.573064] [009/160] (940s left) fbdev (write) [121.620383] Starting subtest: write [123.363534] Subtest write: SUCCESS (1.734s) [123.422713] [010/160] (938s left) gem_basic (bad-close) [123.470455] Starting subtest: bad-close [123.472474] Subtest bad-close: SUCCESS (0.000s) [123.555747] [011/160] (938s left) gem_basic (create-close) [123.592877] Starting subtest: create-close [123.594517] Subtest create-close: SUCCESS (0.000s) [123.673751] [012/160] (938s left) gem_basic (create-fd-close) [123.715061] Starting subtest: create-fd-close [123.716922] Subtest create-fd-close: SUCCESS (0.000s) [123.805969] [013/160] (938s left) gem_busy (busy@all-engines) [123.858465] Starting subtest: busy [123.859398] Starting dynamic subtest: all-engines [123.886118] Dynamic subtest all-engines: SUCCESS (0.028s) [123.886970] Subtest busy: SUCCESS (0.028s) [124.242776] [014/160] (937s left) gem_close_race (basic-process) [124.288614] Starting subtest: basic-process [124.325999] Subtest basic-process: SUCCESS (0.037s) [124.521503] [015/160] (937s left) gem_close_race (basic-threads) [124.571177] Starting subtest: basic-threads [125.793508] Subtest basic-threads: SUCCESS (1.221s) [125.977420] [016/160] (935s left) gem_ctx_create (basic) [126.026425] Starting subtest: basic [126.027346] Subtest basic: SUCCESS (0.000s) [126.218356] [017/160] (935s left) gem_ctx_create (basic-files) [126.263699] Starting subtest: basic-files [128.271147] Subtest basic-files: SUCCESS (2.008s) [128.472778] [018/160] (933s left) gem_ctx_exec (basic) [128.521060] Starting subtest: basic [128.523396] Subtest basic: SUCCESS (0.003s) [128.627221] [019/160] (933s left) gem_exec_basic (basic) [128.673264] Starting subtest: basic [128.674239] Starting dynamic subtest: rcs0-smem [128.675216] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [128.678804] Starting dynamic subtest: bcs0-smem [128.680067] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [128.684469] Starting dynamic subtest: vcs0-smem [128.685580] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [128.689857] Starting dynamic subtest: vcs1-smem [128.690735] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [128.694058] Starting dynamic subtest: vecs0-smem [128.694898] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [128.695768] Subtest basic: SUCCESS (0.003s) [128.861421] [020/160] (933s left) gem_exec_create (basic) [128.907561] Starting subtest: basic [128.908290] Starting dynamic subtest: smem [130.999862] Dynamic subtest smem: SUCCESS (2.092s) [131.001207] Subtest basic: SUCCESS (2.092s) [131.188770] [021/160] (930s left) gem_exec_fence (basic-busy) [131.362680] Starting subtest: basic-busy [131.363403] Starting dynamic subtest: rcs0 [131.439474] Dynamic subtest rcs0: SUCCESS (0.084s) [131.451385] Starting dynamic subtest: bcs0 [131.489690] Dynamic subtest bcs0: SUCCESS (0.050s) [131.500638] Starting dynamic subtest: vcs0 [131.538926] Dynamic subtest vcs0: SUCCESS (0.048s) [131.552604] Starting dynamic subtest: vcs1 [131.585824] Dynamic subtest vcs1: SUCCESS (0.047s) [131.593134] Starting dynamic subtest: vecs0 [131.634513] Dynamic subtest vecs0: SUCCESS (0.047s) [131.636776] Subtest basic-busy: SUCCESS (0.280s) [132.130152] [022/160] (929s left) gem_exec_fence (basic-wait) [132.306205] Starting subtest: basic-wait [132.307079] Starting dynamic subtest: rcs0 [132.346739] Dynamic subtest rcs0: SUCCESS (0.048s) [132.354188] Starting dynamic subtest: bcs0 [132.396584] Dynamic subtest bcs0: SUCCESS (0.049s) [132.410284] Starting dynamic subtest: vcs0 [132.447642] Dynamic subtest vcs0: SUCCESS (0.051s) [132.459982] Starting dynamic subtest: vcs1 [132.496465] Dynamic subtest vcs1: SUCCESS (0.048s) [132.509609] Starting dynamic subtest: vecs0 [132.551118] Dynamic subtest vecs0: SUCCESS (0.054s) [132.553294] Subtest basic-wait: SUCCESS (0.253s) [133.056510] [023/160] (928s left) gem_exec_fence (basic-await) [133.232680] Starting subtest: basic-await [133.233486] Starting dynamic subtest: rcs0 [133.296506] Dynamic subtest rcs0: SUCCESS (0.072s) [133.305504] Starting dynamic subtest: bcs0 [133.370731] Dynamic subtest bcs0: SUCCESS (0.073s) [133.378214] Starting dynamic subtest: vcs0 [133.444348] Dynamic subtest vcs0: SUCCESS (0.074s) [133.450233] Starting dynamic subtest: vcs1 [133.513997] Dynamic subtest vcs1: SUCCESS (0.069s) [133.521708] Starting dynamic subtest: vecs0 [133.585539] Dynamic subtest vecs0: SUCCESS (0.071s) [133.587480] Subtest basic-await: SUCCESS (0.361s) [134.076874] [024/160] (927s left) gem_exec_fence (nb-await) [134.253165] Starting subtest: nb-await [134.253871] Starting dynamic subtest: rcs0 [134.302827] Dynamic subtest rcs0: SUCCESS (0.056s) [134.311257] Starting dynamic subtest: bcs0 [134.364721] Dynamic subtest bcs0: SUCCESS (0.062s) [134.373137] Starting dynamic subtest: vcs0 [134.426365] Dynamic subtest vcs0: SUCCESS (0.060s) [134.439926] Starting dynamic subtest: vcs1 [134.491616] Dynamic subtest vcs1: SUCCESS (0.065s) [134.497988] Starting dynamic subtest: vecs0 [134.550750] Dynamic subtest vecs0: SUCCESS (0.058s) [134.553204] Subtest nb-await: SUCCESS (0.305s) [135.045382] [025/160] (927s left) gem_exec_gttfill (basic) [135.095091] Starting subtest: basic [137.348494] Subtest basic: SUCCESS (2.244s) [137.521700] [026/160] (924s left) gem_exec_parallel (engines) [137.617438] Starting subtest: engines [137.618324] Starting dynamic subtest: basic [139.186690] Dynamic subtest basic: SUCCESS (1.569s) [139.197114] Starting dynamic subtest: contexts [141.149406] Dynamic subtest contexts: SUCCESS (1.954s) [141.153976] Starting dynamic subtest: fds [143.451098] Dynamic subtest fds: SUCCESS (2.310s) [143.456119] Starting dynamic subtest: userptr [145.007053] Dynamic subtest userptr: SUCCESS (1.556s) [145.008828] Subtest engines: SUCCESS (7.389s) [145.203144] [027/160] (916s left) gem_exec_store (basic) [145.256366] Starting subtest: basic [145.346669] Subtest basic: SUCCESS (0.089s) [145.530050] [028/160] (916s left) gem_flink_basic (bad-flink) [145.572589] Starting subtest: bad-flink [145.573666] Subtest bad-flink: SUCCESS (0.000s) [145.647312] [029/160] (916s left) gem_flink_basic (bad-open) [145.682190] Starting subtest: bad-open [145.683888] Subtest bad-open: SUCCESS (0.000s) [145.771190] [030/160] (916s left) gem_flink_basic (basic) [145.814323] Starting subtest: basic [145.815075] Subtest basic: SUCCESS (0.000s) [145.888941] [031/160] (916s left) gem_flink_basic (double-flink) [145.936191] Starting subtest: double-flink [145.937277] Subtest double-flink: SUCCESS (0.000s) [146.015492] [032/160] (916s left) gem_flink_basic (flink-lifetime) [146.060275] Starting subtest: flink-lifetime [146.061184] Subtest flink-lifetime: SUCCESS (0.001s) [146.150973] [033/160] (915s left) gem_huc_copy (huc-copy) [146.205273] Starting subtest: huc-copy [146.207209] Subtest huc-copy: SUCCESS (0.002s) [146.305545] [034/160] (915s left) gem_linear_blits (basic) [146.425947] Starting subtest: basic [146.431809] Subtest basic: SUCCESS (0.006s) [146.561308] [035/160] (915s left) gem_mmap (basic) [146.641055] Starting subtest: basic [146.644814] Subtest basic: SUCCESS (0.000s) [146.731018] [036/160] (915s left) gem_mmap_gtt (basic) [146.780158] Starting subtest: basic [146.781149] Subtest basic: SUCCESS (0.001s) [146.851239] [037/160] (915s left) gem_render_linear_blits (basic) [146.909073] Starting subtest: basic [146.930249] Subtest basic: SUCCESS (0.021s) [147.010396] [038/160] (915s left) gem_render_tiled_blits (basic) [147.058087] Starting subtest: basic [147.083851] Subtest basic: SUCCESS (0.026s) [147.157172] [039/160] (915s left) gem_ringfill (basic-all) [147.496790] Starting subtest: basic-all [148.634589] Subtest basic-all: SUCCESS (1.131s) [148.746665] [040/160] (913s left) gem_softpin (allocator-basic) [148.797399] Starting subtest: allocator-basic [148.844280] Subtest allocator-basic: SUCCESS (0.047s) [148.954392] [041/160] (913s left) gem_softpin (allocator-basic-reserve) [149.002379] Starting subtest: allocator-basic-reserve [149.045369] Subtest allocator-basic-reserve: SUCCESS (0.046s) [149.159251] [042/160] (913s left) gem_softpin (safe-alignment) [149.207632] Starting subtest: safe-alignment [149.214663] Subtest safe-alignment: SUCCESS (0.007s) [149.325357] [043/160] (912s left) gem_sync (basic-all) [149.376756] Starting subtest: basic-all [151.918481] Subtest basic-all: SUCCESS (2.541s) [152.106216] [044/160] (910s left) gem_sync (basic-each) [152.150689] Starting subtest: basic-each [154.442789] Subtest basic-each: SUCCESS (2.292s) [154.631591] [045/160] (907s left) gem_tiled_blits (basic) [154.747778] Starting subtest: basic [154.758369] Subtest basic: SUCCESS (0.011s) [154.892895] [046/160] (907s left) gem_tiled_fence_blits (basic) [155.052940] Starting subtest: basic [155.072204] Subtest basic: SUCCESS (0.020s) [155.190337] [047/160] (907s left) gem_tiled_pread_basic [155.305344] [048/160] (907s left) gem_wait (busy@all-engines) [155.355160] Starting subtest: busy [155.356039] Starting dynamic subtest: all-engines [155.908467] Dynamic subtest all-engines: SUCCESS (0.549s) [155.909873] Subtest busy: SUCCESS (0.550s) [156.110238] [049/160] (906s left) gem_wait (wait@all-engines) [156.156397] Starting subtest: wait [156.157331] Starting dynamic subtest: all-engines [157.216063] Dynamic subtest all-engines: SUCCESS (1.058s) [157.218159] Subtest wait: SUCCESS (1.058s) [157.424270] [050/160] (904s left) i915_getparams_basic (basic-eu-total) [157.477567] Starting subtest: basic-eu-total [157.480098] Subtest basic-eu-total: SUCCESS (0.000s) [157.556413] [051/160] (904s left) i915_getparams_basic (basic-subslice-total) [157.600331] Starting subtest: basic-subslice-total [157.602143] Subtest basic-subslice-total: SUCCESS (0.000s) [157.690260] [052/160] (904s left) i915_hangman (error-state-basic) [157.742226] Starting subtest: error-state-basic [157.832392] Subtest error-state-basic: SUCCESS (0.090s) [157.913974] [053/160] (904s left) i915_pciid [158.043152] [054/160] (904s left) kms_addfb_basic (addfb25-4-tiled) [160.007898] Starting subtest: addfb25-4-tiled [160.008852] Subtest addfb25-4-tiled: SUCCESS (0.000s) [160.097644] [055/160] (902s left) kms_addfb_basic (addfb25-bad-modifier) [160.144196] Starting subtest: addfb25-bad-modifier [160.145258] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [162.144099] [056/160] (900s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [162.193462] Starting subtest: addfb25-framebuffer-vs-set-tiling [162.194379] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [164.191175] [057/160] (898s left) kms_addfb_basic (addfb25-modifier-no-flag) [164.232187] Starting subtest: addfb25-modifier-no-flag [164.233081] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [166.224461] [058/160] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [166.269277] Starting subtest: addfb25-x-tiled-legacy [166.270244] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [168.262255] [059/160] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [168.301961] Starting subtest: addfb25-x-tiled-mismatch-legacy [168.302867] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [170.295953] [060/160] (892s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [172.251250] Starting subtest: addfb25-yf-tiled-legacy [172.252212] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [172.333252] [061/160] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy) [174.287754] Starting subtest: addfb25-y-tiled-legacy [174.288833] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [174.373953] [062/160] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [176.341638] Starting subtest: addfb25-y-tiled-small-legacy [176.342671] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [176.424416] [063/160] (886s left) kms_addfb_basic (bad-pitch-0) [176.470015] Starting subtest: bad-pitch-0 [176.471076] Subtest bad-pitch-0: SUCCESS (0.000s) [178.463411] [064/160] (884s left) kms_addfb_basic (bad-pitch-1024) [178.510066] Starting subtest: bad-pitch-1024 [178.511017] Subtest bad-pitch-1024: SUCCESS (0.000s) [180.506665] [065/160] (882s left) kms_addfb_basic (bad-pitch-128) [180.551051] Starting subtest: bad-pitch-128 [180.551892] Subtest bad-pitch-128: SUCCESS (0.000s) [182.540475] [066/160] (879s left) kms_addfb_basic (bad-pitch-256) [182.588123] Starting subtest: bad-pitch-256 [182.588891] Subtest bad-pitch-256: SUCCESS (0.000s) [184.574194] [067/160] (877s left) kms_addfb_basic (bad-pitch-32) [184.618317] Starting subtest: bad-pitch-32 [184.619272] Subtest bad-pitch-32: SUCCESS (0.000s) [186.607813] [068/160] (875s left) kms_addfb_basic (bad-pitch-63) [186.657449] Starting subtest: bad-pitch-63 [186.658568] Subtest bad-pitch-63: SUCCESS (0.000s) [188.649880] [069/160] (873s left) kms_addfb_basic (bad-pitch-65536) [188.699429] Starting subtest: bad-pitch-65536 [188.700617] Subtest bad-pitch-65536: SUCCESS (0.000s) [190.691358] [070/160] (871s left) kms_addfb_basic (bad-pitch-999) [190.730986] Starting subtest: bad-pitch-999 [190.731720] Subtest bad-pitch-999: SUCCESS (0.000s) [192.724590] [071/160] (869s left) kms_addfb_basic (basic) [192.772718] Starting subtest: basic [192.773853] Subtest basic: SUCCESS (0.000s) [194.766233] [072/160] (867s left) kms_addfb_basic (basic-x-tiled-legacy) [194.811130] Starting subtest: basic-x-tiled-legacy [194.812078] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [196.818582] [073/160] (865s left) kms_addfb_basic (basic-y-tiled-legacy) [196.865238] Starting subtest: basic-y-tiled-legacy [196.866275] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [198.856980] [074/160] (863s left) kms_addfb_basic (bo-too-small) [200.806984] Starting subtest: bo-too-small [200.807882] Subtest bo-too-small: SUCCESS (0.000s) [200.891940] [075/160] (861s left) kms_addfb_basic (bo-too-small-due-to-tiling) [202.846094] Starting subtest: bo-too-small-due-to-tiling [202.847057] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [202.935267] [076/160] (859s left) kms_addfb_basic (clobberred-modifier) [202.978555] Starting subtest: clobberred-modifier [202.979338] Subtest clobberred-modifier: SUCCESS (0.000s) [204.981800] [077/160] (857s left) kms_addfb_basic (framebuffer-vs-set-tiling) [205.024108] Starting subtest: framebuffer-vs-set-tiling [205.025058] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [207.016118] [078/160] (855s left) kms_addfb_basic (invalid-get-prop) [207.058214] Starting subtest: invalid-get-prop [207.059211] Subtest invalid-get-prop: SUCCESS (0.000s) [209.051092] [079/160] (853s left) kms_addfb_basic (invalid-get-prop-any) [209.099754] Starting subtest: invalid-get-prop-any [209.100761] Subtest invalid-get-prop-any: SUCCESS (0.000s) [211.091997] [080/160] (851s left) kms_addfb_basic (invalid-set-prop) [211.136430] Starting subtest: invalid-set-prop [211.137256] Subtest invalid-set-prop: SUCCESS (0.000s) [213.131409] [081/160] (849s left) kms_addfb_basic (invalid-set-prop-any) [213.173093] Starting subtest: invalid-set-prop-any [213.174042] Subtest invalid-set-prop-any: SUCCESS (0.000s) [215.178221] [082/160] (847s left) kms_addfb_basic (no-handle) [215.218125] Starting subtest: no-handle [215.218936] Subtest no-handle: SUCCESS (0.000s) [217.210994] [083/160] (845s left) kms_addfb_basic (size-max) [219.162780] Starting subtest: size-max [219.163913] Subtest size-max: SUCCESS (0.000s) [219.260125] [084/160] (843s left) kms_addfb_basic (small-bo) [221.219512] Starting subtest: small-bo [221.220253] Subtest small-bo: SUCCESS (0.000s) [221.306847] [085/160] (841s left) kms_addfb_basic (tile-pitch-mismatch) [221.358611] Starting subtest: tile-pitch-mismatch [221.359777] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [223.355154] [086/160] (839s left) kms_addfb_basic (too-high) [225.322785] Starting subtest: too-high [225.323730] Subtest too-high: SUCCESS (0.000s) [225.405276] [087/160] (837s left) kms_addfb_basic (too-wide) [227.359392] Starting subtest: too-wide [227.360423] Subtest too-wide: SUCCESS (0.000s) [227.447365] [088/160] (835s left) kms_addfb_basic (unused-handle) [227.482135] Starting subtest: unused-handle [227.483048] Subtest unused-handle: SUCCESS (0.000s) [229.476430] [089/160] (833s left) kms_addfb_basic (unused-modifier) [229.520040] Starting subtest: unused-modifier [229.521137] Subtest unused-modifier: SUCCESS (0.000s) [231.511380] [090/160] (831s left) kms_addfb_basic (unused-offsets) [231.557565] Starting subtest: unused-offsets [231.558758] Subtest unused-offsets: SUCCESS (0.000s) [233.551441] [091/160] (829s left) kms_addfb_basic (unused-pitches) [233.588898] Starting subtest: unused-pitches [233.589935] Subtest unused-pitches: SUCCESS (0.000s) [235.576801] [092/160] (827s left) kms_busy (basic) [237.526490] Starting subtest: basic [237.527465] Starting dynamic subtest: flip [239.566116] Dynamic subtest flip: SUCCESS (2.039s) [239.572541] Starting dynamic subtest: modeset [243.575543] Dynamic subtest modeset: SUCCESS (4.006s) [243.585777] Subtest basic: SUCCESS (6.046s) [244.609242] [093/160] (818s left) kms_prop_blob (basic) [244.653011] Starting subtest: basic [244.653933] Subtest basic: SUCCESS (0.000s) [244.731062] [094/160] (818s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [246.717075] Starting subtest: basic-busy-flip-before-cursor-atomic [246.719077] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [246.826471] [095/160] (816s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [248.815037] Starting subtest: basic-busy-flip-before-cursor-legacy [248.816751] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [248.917658] [096/160] (813s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [250.899994] Starting subtest: basic-flip-after-cursor-atomic [253.315413] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.415s) [254.407888] [097/160] (808s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [256.381563] Starting subtest: basic-flip-after-cursor-legacy [258.750704] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.369s) [259.833730] [098/160] (803s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [261.819530] Starting subtest: basic-flip-after-cursor-varying-size [264.197281] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.382s) [265.267416] [099/160] (797s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [267.239973] Starting subtest: basic-flip-before-cursor-atomic [269.637281] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.398s) [270.724416] [100/160] (792s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [272.710080] Starting subtest: basic-flip-before-cursor-legacy [275.079536] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.370s) [276.160904] [101/160] (786s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [278.131546] Starting subtest: basic-flip-before-cursor-varying-size [280.515799] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.384s) [281.598995] [102/160] (781s left) kms_dsc (dsc-basic) [283.546796] Starting subtest: dsc-basic [283.548250] Subtest dsc-basic: SKIP (0.000s) [283.625631] [103/160] (779s left) kms_flip (basic-flip-vs-dpms) [285.579842] Starting subtest: basic-flip-vs-dpms [285.581515] Starting dynamic subtest: A-eDP1 [288.368311] Dynamic subtest A-eDP1: SUCCESS (2.786s) [288.376773] Starting dynamic subtest: B-eDP1 [290.734268] Dynamic subtest B-eDP1: SUCCESS (2.366s) [290.739745] Starting dynamic subtest: C-eDP1 [293.106798] Dynamic subtest C-eDP1: SUCCESS (2.372s) [293.113503] Starting dynamic subtest: D-eDP1 [295.472324] Dynamic subtest D-eDP1: SUCCESS (2.365s) [295.480345] Starting dynamic subtest: A-DP3 [296.305437] Dynamic subtest A-DP3: SUCCESS (0.832s) [296.310130] Starting dynamic subtest: B-DP3 [297.099302] Dynamic subtest B-DP3: SUCCESS (0.793s) [297.106504] Starting dynamic subtest: C-DP3 [297.888887] Dynamic subtest C-DP3: SUCCESS (0.789s) [297.893531] Starting dynamic subtest: D-DP3 [298.681432] Dynamic subtest D-DP3: SUCCESS (0.793s) [298.682412] Subtest basic-flip-vs-dpms: SUCCESS (13.103s) [299.162798] [104/160] (763s left) kms_flip (basic-flip-vs-modeset) [301.118043] Starting subtest: basic-flip-vs-modeset [301.120639] Starting dynamic subtest: A-eDP1 [303.919717] Dynamic subtest A-eDP1: SUCCESS (2.799s) [303.925772] Starting dynamic subtest: B-eDP1 [306.297986] Dynamic subtest B-eDP1: SUCCESS (2.376s) [306.303107] Starting dynamic subtest: C-eDP1 [308.659032] Dynamic subtest C-eDP1: SUCCESS (2.361s) [308.663869] Starting dynamic subtest: D-eDP1 [311.024083] Dynamic subtest D-eDP1: SUCCESS (2.365s) [311.032714] Starting dynamic subtest: A-DP3 [311.851198] Dynamic subtest A-DP3: SUCCESS (0.825s) [311.856557] Starting dynamic subtest: B-DP3 [312.640308] Dynamic subtest B-DP3: SUCCESS (0.788s) [312.647755] Starting dynamic subtest: C-DP3 [313.424470] Dynamic subtest C-DP3: SUCCESS (0.784s) [313.429436] Starting dynamic subtest: D-DP3 [314.218643] Dynamic subtest D-DP3: SUCCESS (0.787s) [314.219485] Subtest basic-flip-vs-modeset: SUCCESS (13.094s) [314.696266] [105/160] (748s left) kms_flip (basic-flip-vs-wf_vblank) [316.652237] Starting subtest: basic-flip-vs-wf_vblank [316.654621] Starting dynamic subtest: A-eDP1 [318.753273] Dynamic subtest A-eDP1: SUCCESS (2.088s) [318.758896] Starting dynamic subtest: B-eDP1 [320.784196] Dynamic subtest B-eDP1: SUCCESS (2.037s) [320.792647] Starting dynamic subtest: C-eDP1 [322.807225] Dynamic subtest C-eDP1: SUCCESS (2.018s) [322.814315] Starting dynamic subtest: D-eDP1 [324.853639] Dynamic subtest D-eDP1: SUCCESS (2.045s) [324.862792] Starting dynamic subtest: A-DP3 [326.196828] Dynamic subtest A-DP3: SUCCESS (1.338s) [326.209751] Starting dynamic subtest: B-DP3 [327.283244] Dynamic subtest B-DP3: SUCCESS (1.081s) [327.291230] Starting dynamic subtest: C-DP3 [328.364233] Dynamic subtest C-DP3: SUCCESS (1.082s) [328.374948] Starting dynamic subtest: D-DP3 [329.616858] Dynamic subtest D-DP3: SUCCESS (1.249s) [329.618723] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.965s) [330.145667] [106/160] (732s left) kms_flip (basic-plain-flip) [332.106723] Starting subtest: basic-plain-flip [332.107611] Starting dynamic subtest: A-eDP1 [333.908565] Dynamic subtest A-eDP1: SUCCESS (1.799s) [333.916272] Starting dynamic subtest: B-eDP1 [335.662158] Dynamic subtest B-eDP1: SUCCESS (1.750s) [335.669570] Starting dynamic subtest: C-eDP1 [337.438245] Dynamic subtest C-eDP1: SUCCESS (1.770s) [337.442890] Starting dynamic subtest: D-eDP1 [339.165217] Dynamic subtest D-eDP1: SUCCESS (1.725s) [339.171330] Starting dynamic subtest: A-DP3 [340.228866] Dynamic subtest A-DP3: SUCCESS (1.058s) [340.238549] Starting dynamic subtest: B-DP3 [341.026149] Dynamic subtest B-DP3: SUCCESS (0.796s) [341.031052] Starting dynamic subtest: C-DP3 [341.828480] Dynamic subtest C-DP3: SUCCESS (0.800s) [341.837126] Starting dynamic subtest: D-DP3 [342.623644] Dynamic subtest D-DP3: SUCCESS (0.793s) [342.626469] Subtest basic-plain-flip: SUCCESS (10.520s) [343.150588] [107/160] (719s left) kms_force_connector_basic (force-connector-state) [343.202300] Starting subtest: force-connector-state [345.880626] Subtest force-connector-state: SUCCESS (2.678s) [349.788272] [108/160] (713s left) kms_force_connector_basic (force-edid) [349.842904] Starting subtest: force-edid [349.873553] Subtest force-edid: SUCCESS (0.032s) [351.946130] [109/160] (711s left) kms_force_connector_basic (force-load-detect) [351.985178] Starting subtest: force-load-detect [351.996249] Subtest force-load-detect: SKIP (0.000s) [353.048944] [110/160] (709s left) kms_force_connector_basic (prune-stale-modes) [353.097381] Starting subtest: prune-stale-modes [353.128083] Subtest prune-stale-modes: SUCCESS (0.031s) [355.188672] [111/160] (707s left) kms_frontbuffer_tracking (basic) [357.144059] Starting subtest: basic [362.076916] Subtest basic: SUCCESS (4.933s) [363.462601] [112/160] (699s left) kms_hdmi_inject (inject-audio) [364.055949] Starting subtest: inject-audio [364.153607] Subtest inject-audio: SUCCESS (0.094s) [367.149768] [113/160] (695s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [369.098908] Starting subtest: compare-crc-sanitycheck-xr24 [369.099957] Starting dynamic subtest: pipe-A-eDP-1 [371.054489] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s) [371.060288] Starting dynamic subtest: pipe-B-DP-3 [371.514683] Dynamic subtest pipe-B-DP-3: SUCCESS (0.460s) [371.519404] Starting dynamic subtest: pipe-C-DP-3 [371.983063] Dynamic subtest pipe-C-DP-3: SUCCESS (0.467s) [371.987940] Starting dynamic subtest: pipe-D-DP-3 [372.448837] Dynamic subtest pipe-D-DP-3: SUCCESS (0.465s) [372.449680] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.351s) [372.938662] [114/160] (690s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [374.885804] Starting subtest: compare-crc-sanitycheck-nv12 [374.886753] Starting dynamic subtest: pipe-A-eDP-1 [377.010751] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.123s) [377.015495] Starting dynamic subtest: pipe-B-DP-3 [377.619657] Dynamic subtest pipe-B-DP-3: SUCCESS (0.608s) [377.625498] Starting dynamic subtest: pipe-C-DP-3 [378.225293] Dynamic subtest pipe-C-DP-3: SUCCESS (0.605s) [378.231273] Starting dynamic subtest: pipe-D-DP-3 [378.835145] Dynamic subtest pipe-D-DP-3: SUCCESS (0.608s) [378.836048] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.949s) [379.315637] [115/160] (683s left) kms_pipe_crc_basic (hang-read-crc) [381.278572] Starting subtest: hang-read-crc [381.279573] Starting dynamic subtest: pipe-A-eDP-1 [384.819127] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.540s) [384.823969] Starting dynamic subtest: pipe-B-DP-3 [386.044163] Dynamic subtest pipe-B-DP-3: SUCCESS (1.224s) [386.051437] Starting dynamic subtest: pipe-C-DP-3 [387.273040] Dynamic subtest pipe-C-DP-3: SUCCESS (1.227s) [387.278010] Starting dynamic subtest: pipe-D-DP-3 [388.506151] Dynamic subtest pipe-D-DP-3: SUCCESS (1.233s) [388.507035] Subtest hang-read-crc: SUCCESS (7.228s) [388.982497] [116/160] (674s left) kms_pipe_crc_basic (nonblocking-crc) [390.937199] Starting subtest: nonblocking-crc [390.938045] Starting dynamic subtest: pipe-A-eDP-1 [393.025137] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s) [393.033168] Starting dynamic subtest: pipe-B-DP-3 [393.654969] Dynamic subtest pipe-B-DP-3: SUCCESS (0.628s) [393.659953] Starting dynamic subtest: pipe-C-DP-3 [394.298020] Dynamic subtest pipe-C-DP-3: SUCCESS (0.641s) [394.305146] Starting dynamic subtest: pipe-D-DP-3 [394.918449] Dynamic subtest pipe-D-DP-3: SUCCESS (0.621s) [394.919314] Subtest nonblocking-crc: SUCCESS (3.982s) [395.383146] [117/160] (667s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [397.344467] Starting subtest: nonblocking-crc-frame-sequence [397.345484] Starting dynamic subtest: pipe-A-eDP-1 [399.411016] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.066s) [399.415794] Starting dynamic subtest: pipe-B-DP-3 [400.054187] Dynamic subtest pipe-B-DP-3: SUCCESS (0.641s) [400.061815] Starting dynamic subtest: pipe-C-DP-3 [400.691625] Dynamic subtest pipe-C-DP-3: SUCCESS (0.637s) [400.697088] Starting dynamic subtest: pipe-D-DP-3 [401.342666] Dynamic subtest pipe-D-DP-3: SUCCESS (0.649s) [401.343554] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.999s) [401.812507] [118/160] (661s left) kms_pipe_crc_basic (read-crc) [403.767048] Starting subtest: read-crc [403.768101] Starting dynamic subtest: pipe-A-eDP-1 [405.852363] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.080s) [405.857265] Starting dynamic subtest: pipe-B-DP-3 [406.408628] Dynamic subtest pipe-B-DP-3: SUCCESS (0.558s) [406.415807] Starting dynamic subtest: pipe-C-DP-3 [406.983772] Dynamic subtest pipe-C-DP-3: SUCCESS (0.575s) [406.992998] Starting dynamic subtest: pipe-D-DP-3 [407.563146] Dynamic subtest pipe-D-DP-3: SUCCESS (0.578s) [407.564082] Subtest read-crc: SUCCESS (3.796s) [408.050273] [119/160] (655s left) kms_pipe_crc_basic (read-crc-frame-sequence) [410.008221] Starting subtest: read-crc-frame-sequence [410.009207] Starting dynamic subtest: pipe-A-eDP-1 [412.050582] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.042s) [412.056318] Starting dynamic subtest: pipe-B-DP-3 [412.630069] Dynamic subtest pipe-B-DP-3: SUCCESS (0.578s) [412.634853] Starting dynamic subtest: pipe-C-DP-3 [413.205949] Dynamic subtest pipe-C-DP-3: SUCCESS (0.575s) [413.210863] Starting dynamic subtest: pipe-D-DP-3 [413.789148] Dynamic subtest pipe-D-DP-3: SUCCESS (0.582s) [413.790153] Subtest read-crc-frame-sequence: SUCCESS (3.781s) [414.255375] [120/160] (648s left) kms_pm_backlight (basic-brightness) [416.216229] Starting subtest: basic-brightness [417.415831] Starting dynamic subtest: eDP-1 [417.716992] Dynamic subtest eDP-1: SUCCESS (0.301s) [417.717623] Subtest basic-brightness: SUCCESS (1.501s) [418.736272] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1818 [max: 8192] direct dependencies: 18880 [max: 32768] indirect dependencies: 139795 all direct dependencies: 385948 dependency chains: 30433 [max: 131072] dependency chain hlocks used: 133711 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 289 in-softirq chains: 673 in-process chains: 29471 stack-trace entries: 174470 [max: 1048576] number of stack traces: 8804 number of stack hash chains: 6821 combined max dependencies: 1465629824 hardirq-safe locks: 102 hardirq-unsafe locks: 1086 softirq-safe locks: 219 softirq-unsafe locks: 993 irq-safe locks: 236 irq-unsafe locks: 1086 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 327 softirq-read-safe locks: 8 softirq-read-unsafe locks: 322 irq-read-safe locks: 8 irq-read-unsafe locks: 327 uncategorized locks: 287 unused locks: 1 max locking depth: 16 max bfs queue depth: 436 max lock class index: 1817 chain lookup misses: 30879 chain lookup hits: 504674354 cyclic checks: 31086 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5185 find-mask backwards checks: 2730 hardirq on events: 256369584 hardirq off events: 256369568 redundant hardirq ons: 24 redundant hardirq offs: 22 softirq on events: 1219885 softirq off events: 1219885 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 116 large chain blocks: 1 [418.737275] Closing watchdogs Done.