[34.978907] Initializing watchdogs [34.978958] /dev/watchdog0 [34.984605] [001/165] (960s left) i915_module_load (load) [35.026429] Starting subtest: load [37.969711] Subtest load: SUCCESS (2.943s) [37.999281] [002/165] (957s left) core_auth (basic-auth) [38.057239] Starting subtest: basic-auth [38.058733] Subtest basic-auth: SUCCESS (0.001s) [38.141239] [003/165] (957s left) debugfs_test (read_all_entries) [38.181842] Starting subtest: read_all_entries [38.323882] Subtest read_all_entries: SUCCESS (0.140s) [38.575200] [004/165] (956s left) debugfs_test (basic-hwmon) [38.621902] Starting subtest: basic-hwmon [38.625580] Subtest basic-hwmon: SKIP (0.000s) [38.873913] [005/165] (956s left) fbdev (eof) [38.920564] Starting subtest: eof [38.922411] Subtest eof: SUCCESS (0.000s) [38.967205] [006/165] (956s left) fbdev (info) [38.996766] Starting subtest: info [38.998145] Subtest info: SUCCESS (0.000s) [39.056363] [007/165] (956s left) fbdev (nullptr) [39.102922] Starting subtest: nullptr [39.104587] Subtest nullptr: SUCCESS (0.000s) [39.156188] [008/165] (956s left) fbdev (read) [39.203145] Starting subtest: read [39.994213] Subtest read: SUCCESS (0.786s) [40.034097] [009/165] (955s left) fbdev (write) [40.086639] Starting subtest: write [40.613747] Subtest write: SUCCESS (0.522s) [40.650808] [010/165] (954s left) gem_basic (bad-close) [40.692257] Starting subtest: bad-close [40.695539] Subtest bad-close: SUCCESS (0.000s) [40.758462] [011/165] (954s left) gem_basic (create-close) [40.801931] Starting subtest: create-close [40.805756] Subtest create-close: SUCCESS (0.000s) [40.889960] [012/165] (954s left) gem_basic (create-fd-close) [40.925388] Starting subtest: create-fd-close [40.929131] Subtest create-fd-close: SUCCESS (0.000s) [41.005517] [013/165] (954s left) gem_busy (busy@all-engines) [41.050268] Starting subtest: busy [41.051747] Starting dynamic subtest: all-engines [41.074623] Dynamic subtest all-engines: SUCCESS (0.024s) [41.076552] Subtest busy: SUCCESS (0.024s) [41.411374] [014/165] (954s left) gem_close_race (basic-process) [41.460325] Starting subtest: basic-process [41.505628] Subtest basic-process: SUCCESS (0.044s) [41.675766] [015/165] (954s left) gem_close_race (basic-threads) [41.719474] Starting subtest: basic-threads [42.945864] Subtest basic-threads: SUCCESS (1.226s) [43.129821] [016/165] (952s left) gem_ctx_create (basic) [43.180849] Starting subtest: basic [43.183169] Subtest basic: SUCCESS (0.000s) [43.356185] [017/165] (952s left) gem_ctx_create (basic-files) [43.404875] Starting subtest: basic-files [45.415852] Subtest basic-files: SUCCESS (2.009s) [45.676031] [018/165] (950s left) gem_ctx_exec (basic) [45.724069] Starting subtest: basic [45.724892] Subtest basic: SUCCESS (0.002s) [45.822135] [019/165] (949s left) gem_exec_basic (basic) [45.864661] Starting subtest: basic [45.865458] Starting dynamic subtest: rcs0-smem [45.866175] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [45.869904] Starting dynamic subtest: bcs0-smem [45.870677] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [45.874077] Starting dynamic subtest: vcs0-smem [45.874774] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [45.878169] Starting dynamic subtest: vcs1-smem [45.878925] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [45.882961] Starting dynamic subtest: vecs0-smem [45.883723] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [45.884478] Subtest basic: SUCCESS (0.003s) [46.039568] [020/165] (949s left) gem_exec_create (basic) [46.085330] Starting subtest: basic [46.085999] Starting dynamic subtest: smem [48.177694] Dynamic subtest smem: SUCCESS (2.091s) [48.179333] Subtest basic: SUCCESS (2.092s) [48.347203] [021/165] (947s left) gem_exec_fence (basic-busy) [48.495305] Starting subtest: basic-busy [48.496188] Starting dynamic subtest: rcs0 [48.547416] Dynamic subtest rcs0: SUCCESS (0.051s) [48.557547] Starting dynamic subtest: bcs0 [48.594644] Dynamic subtest bcs0: SUCCESS (0.047s) [48.603756] Starting dynamic subtest: vcs0 [48.640969] Dynamic subtest vcs0: SUCCESS (0.046s) [48.648829] Starting dynamic subtest: vcs1 [48.692825] Dynamic subtest vcs1: SUCCESS (0.052s) [48.701826] Starting dynamic subtest: vecs0 [48.739278] Dynamic subtest vecs0: SUCCESS (0.046s) [48.740700] Subtest basic-busy: SUCCESS (0.244s) [49.234127] [022/165] (946s left) gem_exec_fence (basic-wait) [49.396569] Starting subtest: basic-wait [49.397756] Starting dynamic subtest: rcs0 [49.451482] Dynamic subtest rcs0: SUCCESS (0.055s) [49.460087] Starting dynamic subtest: bcs0 [49.495449] Dynamic subtest bcs0: SUCCESS (0.047s) [49.505573] Starting dynamic subtest: vcs0 [49.542191] Dynamic subtest vcs0: SUCCESS (0.046s) [49.552086] Starting dynamic subtest: vcs1 [49.588293] Dynamic subtest vcs1: SUCCESS (0.046s) [49.597013] Starting dynamic subtest: vecs0 [49.635802] Dynamic subtest vecs0: SUCCESS (0.047s) [49.637675] Subtest basic-wait: SUCCESS (0.243s) [50.113926] [023/165] (945s left) gem_exec_fence (basic-await) [50.276945] Starting subtest: basic-await [50.278424] Starting dynamic subtest: rcs0 [50.350349] Dynamic subtest rcs0: SUCCESS (0.078s) [50.362047] Starting dynamic subtest: bcs0 [50.429803] Dynamic subtest bcs0: SUCCESS (0.078s) [50.443643] Starting dynamic subtest: vcs0 [50.511895] Dynamic subtest vcs0: SUCCESS (0.082s) [50.524380] Starting dynamic subtest: vcs1 [50.592870] Dynamic subtest vcs1: SUCCESS (0.080s) [50.605942] Starting dynamic subtest: vecs0 [50.672899] Dynamic subtest vecs0: SUCCESS (0.080s) [50.675051] Subtest basic-await: SUCCESS (0.400s) [51.148938] [024/165] (944s left) gem_exec_fence (nb-await) [51.315989] Starting subtest: nb-await [51.317397] Starting dynamic subtest: rcs0 [51.369774] Dynamic subtest rcs0: SUCCESS (0.057s) [51.376310] Starting dynamic subtest: bcs0 [51.428164] Dynamic subtest bcs0: SUCCESS (0.058s) [51.440369] Starting dynamic subtest: vcs0 [51.487756] Dynamic subtest vcs0: SUCCESS (0.059s) [51.496723] Starting dynamic subtest: vcs1 [51.546861] Dynamic subtest vcs1: SUCCESS (0.059s) [51.561393] Starting dynamic subtest: vecs0 [51.608538] Dynamic subtest vecs0: SUCCESS (0.062s) [51.610370] Subtest nb-await: SUCCESS (0.297s) [52.098341] [025/165] (943s left) gem_exec_gttfill (basic) [52.137097] Starting subtest: basic [54.365906] Subtest basic: SUCCESS (2.229s) [54.545825] [026/165] (941s left) gem_exec_parallel (engines) [54.631512] Starting subtest: engines [54.632565] Starting dynamic subtest: basic [55.951074] Dynamic subtest basic: SUCCESS (1.319s) [55.957960] Starting dynamic subtest: contexts [57.670339] Dynamic subtest contexts: SUCCESS (1.715s) [57.676089] Starting dynamic subtest: fds [59.587085] Dynamic subtest fds: SUCCESS (1.921s) [59.594703] Starting dynamic subtest: userptr [60.893184] Dynamic subtest userptr: SUCCESS (1.306s) [60.894697] Subtest engines: SUCCESS (6.261s) [61.072195] [027/165] (934s left) gem_exec_store (basic) [61.110410] Starting subtest: basic [61.183376] Subtest basic: SUCCESS (0.072s) [61.361668] [028/165] (934s left) gem_flink_basic (bad-flink) [61.401639] Starting subtest: bad-flink [61.402445] Subtest bad-flink: SUCCESS (0.000s) [61.459488] [029/165] (934s left) gem_flink_basic (bad-open) [61.500974] Starting subtest: bad-open [61.502154] Subtest bad-open: SUCCESS (0.000s) [61.560300] [030/165] (934s left) gem_flink_basic (basic) [61.601363] Starting subtest: basic [61.602486] Subtest basic: SUCCESS (0.000s) [61.676132] [031/165] (934s left) gem_flink_basic (double-flink) [61.713460] Starting subtest: double-flink [61.714198] Subtest double-flink: SUCCESS (0.000s) [61.805881] [032/165] (934s left) gem_flink_basic (flink-lifetime) [61.843485] Starting subtest: flink-lifetime [61.844451] Subtest flink-lifetime: SUCCESS (0.001s) [61.926714] [033/165] (934s left) gem_huc_copy (huc-copy) [61.970846] Starting subtest: huc-copy [61.972408] Subtest huc-copy: SUCCESS (0.002s) [62.076294] [034/165] (933s left) gem_linear_blits (basic) [62.208657] Starting subtest: basic [62.212618] Subtest basic: SUCCESS (0.004s) [62.329409] [035/165] (933s left) gem_mmap (basic) [62.408304] Starting subtest: basic [62.412884] Subtest basic: SUCCESS (0.000s) [62.492772] [036/165] (933s left) gem_mmap_gtt (basic) [62.532175] Starting subtest: basic [62.533408] Subtest basic: SUCCESS (0.000s) [62.587518] [037/165] (933s left) gem_render_linear_blits (basic) [62.623866] Starting subtest: basic [62.640301] Subtest basic: SUCCESS (0.017s) [62.718511] [038/165] (933s left) gem_render_tiled_blits (basic) [62.757882] Starting subtest: basic [62.778103] Subtest basic: SUCCESS (0.020s) [62.851542] [039/165] (933s left) gem_ringfill (basic-all) [63.176960] Starting subtest: basic-all [64.321644] Subtest basic-all: SUCCESS (1.142s) [64.426785] [040/165] (931s left) gem_softpin (allocator-basic) [64.468539] Starting subtest: allocator-basic [64.520606] Subtest allocator-basic: SUCCESS (0.052s) [64.626154] [041/165] (931s left) gem_softpin (allocator-basic-reserve) [64.666304] Starting subtest: allocator-basic-reserve [64.718647] Subtest allocator-basic-reserve: SUCCESS (0.052s) [64.826156] [042/165] (931s left) gem_softpin (safe-alignment) [64.867132] Starting subtest: safe-alignment [64.874856] Subtest safe-alignment: SUCCESS (0.008s) [64.975695] [043/165] (931s left) gem_sync (basic-all) [65.024850] Starting subtest: basic-all [67.276401] Subtest basic-all: SUCCESS (2.251s) [67.458330] [044/165] (928s left) gem_sync (basic-each) [67.502992] Starting subtest: basic-each [69.661066] Subtest basic-each: SUCCESS (2.158s) [69.831818] [045/165] (926s left) gem_tiled_blits (basic) [69.925245] Starting subtest: basic [69.935030] Subtest basic: SUCCESS (0.010s) [70.074885] [046/165] (926s left) gem_tiled_fence_blits (basic) [70.218302] Starting subtest: basic [70.238304] Subtest basic: SUCCESS (0.020s) [70.371731] [047/165] (925s left) gem_tiled_pread_basic [70.506096] [048/165] (925s left) gem_wait (busy@all-engines) [70.552163] Starting subtest: busy [70.553175] Starting dynamic subtest: all-engines [71.093496] Dynamic subtest all-engines: SUCCESS (0.540s) [71.095250] Subtest busy: SUCCESS (0.541s) [71.301305] [049/165] (925s left) gem_wait (wait@all-engines) [71.354807] Starting subtest: wait [71.355556] Starting dynamic subtest: all-engines [72.410305] Dynamic subtest all-engines: SUCCESS (1.055s) [72.411976] Subtest wait: SUCCESS (1.055s) [72.616396] [050/165] (923s left) i915_getparams_basic (basic-eu-total) [72.657071] Starting subtest: basic-eu-total [72.658671] Subtest basic-eu-total: SUCCESS (0.000s) [72.713970] [051/165] (923s left) i915_getparams_basic (basic-subslice-total) [72.750849] Starting subtest: basic-subslice-total [72.752275] Subtest basic-subslice-total: SUCCESS (0.000s) [72.816793] [052/165] (923s left) i915_hangman (error-state-basic) [72.861077] Starting subtest: error-state-basic [72.968089] Subtest error-state-basic: SUCCESS (0.106s) [73.034152] [053/165] (923s left) i915_pciid [73.135184] [054/165] (923s left) kms_addfb_basic (addfb25-4-tiled) [73.359877] Starting subtest: addfb25-4-tiled [73.360704] Subtest addfb25-4-tiled: SUCCESS (0.000s) [73.433443] [055/165] (923s left) kms_addfb_basic (addfb25-bad-modifier) [73.468966] Starting subtest: addfb25-bad-modifier [73.469812] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [73.734309] [056/165] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [73.769991] Starting subtest: addfb25-framebuffer-vs-set-tiling [73.770805] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [74.034176] [057/165] (922s left) kms_addfb_basic (addfb25-modifier-no-flag) [74.069783] Starting subtest: addfb25-modifier-no-flag [74.071012] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [74.334928] [058/165] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy) [74.371048] Starting subtest: addfb25-x-tiled-legacy [74.372046] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [74.638393] [059/165] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [74.675895] Starting subtest: addfb25-x-tiled-mismatch-legacy [74.676549] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [74.933926] [060/165] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [75.153901] Starting subtest: addfb25-yf-tiled-legacy [75.155277] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [75.233387] [061/165] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy) [75.455023] Starting subtest: addfb25-y-tiled-legacy [75.456259] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [75.533783] [062/165] (921s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [75.751072] Starting subtest: addfb25-y-tiled-small-legacy [75.752091] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [75.817165] [063/165] (920s left) kms_addfb_basic (bad-pitch-0) [75.857478] Starting subtest: bad-pitch-0 [75.858483] Subtest bad-pitch-0: SUCCESS (0.000s) [76.114099] [064/165] (920s left) kms_addfb_basic (bad-pitch-1024) [76.151020] Starting subtest: bad-pitch-1024 [76.151990] Subtest bad-pitch-1024: SUCCESS (0.000s) [76.417225] [065/165] (920s left) kms_addfb_basic (bad-pitch-128) [76.454191] Starting subtest: bad-pitch-128 [76.455224] Subtest bad-pitch-128: SUCCESS (0.000s) [76.721417] [066/165] (919s left) kms_addfb_basic (bad-pitch-256) [76.761762] Starting subtest: bad-pitch-256 [76.762756] Subtest bad-pitch-256: SUCCESS (0.000s) [77.033606] [067/165] (919s left) kms_addfb_basic (bad-pitch-32) [77.073318] Starting subtest: bad-pitch-32 [77.074213] Subtest bad-pitch-32: SUCCESS (0.000s) [77.335975] [068/165] (919s left) kms_addfb_basic (bad-pitch-63) [77.371952] Starting subtest: bad-pitch-63 [77.373026] Subtest bad-pitch-63: SUCCESS (0.000s) [77.649553] [069/165] (919s left) kms_addfb_basic (bad-pitch-65536) [77.682664] Starting subtest: bad-pitch-65536 [77.687442] Subtest bad-pitch-65536: SUCCESS (0.000s) [77.950800] [070/165] (918s left) kms_addfb_basic (bad-pitch-999) [77.989421] Starting subtest: bad-pitch-999 [77.990199] Subtest bad-pitch-999: SUCCESS (0.000s) [78.252100] [071/165] (918s left) kms_addfb_basic (basic) [78.285988] Starting subtest: basic [78.286817] Subtest basic: SUCCESS (0.000s) [78.567127] [072/165] (918s left) kms_addfb_basic (basic-x-tiled-legacy) [78.600726] Starting subtest: basic-x-tiled-legacy [78.601797] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [78.867949] [073/165] (917s left) kms_addfb_basic (basic-y-tiled-legacy) [78.901847] Starting subtest: basic-y-tiled-legacy [78.903052] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [79.150829] [074/165] (917s left) kms_addfb_basic (bo-too-small) [79.370779] Starting subtest: bo-too-small [79.371686] Subtest bo-too-small: SUCCESS (0.000s) [79.450406] [075/165] (917s left) kms_addfb_basic (bo-too-small-due-to-tiling) [79.670952] Starting subtest: bo-too-small-due-to-tiling [79.672280] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [79.751896] [076/165] (917s left) kms_addfb_basic (clobberred-modifier) [79.786711] Starting subtest: clobberred-modifier [79.787530] Subtest clobberred-modifier: SUCCESS (0.000s) [80.051823] [077/165] (916s left) kms_addfb_basic (framebuffer-vs-set-tiling) [80.092058] Starting subtest: framebuffer-vs-set-tiling [80.092972] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [80.350570] [078/165] (916s left) kms_addfb_basic (invalid-get-prop) [80.383087] Starting subtest: invalid-get-prop [80.384148] Subtest invalid-get-prop: SUCCESS (0.000s) [80.651168] [079/165] (916s left) kms_addfb_basic (invalid-get-prop-any) [80.692128] Starting subtest: invalid-get-prop-any [80.693330] Subtest invalid-get-prop-any: SUCCESS (0.000s) [80.951350] [080/165] (915s left) kms_addfb_basic (invalid-set-prop) [80.994765] Starting subtest: invalid-set-prop [80.995954] Subtest invalid-set-prop: SUCCESS (0.000s) [81.249535] [081/165] (915s left) kms_addfb_basic (invalid-set-prop-any) [81.284238] Starting subtest: invalid-set-prop-any [81.284986] Subtest invalid-set-prop-any: SUCCESS (0.000s) [81.551099] [082/165] (915s left) kms_addfb_basic (no-handle) [81.593386] Starting subtest: no-handle [81.594136] Subtest no-handle: SUCCESS (0.000s) [81.865052] [083/165] (915s left) kms_addfb_basic (size-max) [82.084063] Starting subtest: size-max [82.085153] Subtest size-max: SUCCESS (0.000s) [82.151895] [084/165] (914s left) kms_addfb_basic (small-bo) [82.370325] Starting subtest: small-bo [82.371601] Subtest small-bo: SUCCESS (0.000s) [82.436329] [085/165] (914s left) kms_addfb_basic (tile-pitch-mismatch) [82.477209] Starting subtest: tile-pitch-mismatch [82.478070] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [82.736127] [086/165] (914s left) kms_addfb_basic (too-high) [82.954055] Starting subtest: too-high [82.954921] Subtest too-high: SUCCESS (0.000s) [83.035530] [087/165] (913s left) kms_addfb_basic (too-wide) [83.260090] Starting subtest: too-wide [83.261151] Subtest too-wide: SUCCESS (0.000s) [83.334336] [088/165] (913s left) kms_addfb_basic (unused-handle) [83.374787] Starting subtest: unused-handle [83.375596] Subtest unused-handle: SUCCESS (0.000s) [83.631623] [089/165] (913s left) kms_addfb_basic (unused-modifier) [83.668634] Starting subtest: unused-modifier [83.669511] Subtest unused-modifier: SUCCESS (0.000s) [83.934914] [090/165] (913s left) kms_addfb_basic (unused-offsets) [83.975428] Starting subtest: unused-offsets [83.976689] Subtest unused-offsets: SUCCESS (0.000s) [84.233226] [091/165] (912s left) kms_addfb_basic (unused-pitches) [84.266098] Starting subtest: unused-pitches [84.267065] Subtest unused-pitches: SUCCESS (0.000s) [84.534398] [092/165] (912s left) kms_busy (basic) [84.759082] Starting subtest: basic [84.760246] Starting dynamic subtest: flip [85.598269] Dynamic subtest flip: SUCCESS (0.838s) [85.605262] Starting dynamic subtest: modeset [89.484988] Dynamic subtest modeset: SUCCESS (3.886s) [89.486020] Subtest basic: SUCCESS (4.726s) [90.395976] [093/165] (906s left) kms_prop_blob (basic) [90.438733] Starting subtest: basic [90.439488] Subtest basic: SUCCESS (0.000s) [90.510685] [094/165] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [90.735146] Starting subtest: basic-busy-flip-before-cursor-atomic [90.737368] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [90.794025] [095/165] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [91.019018] Starting subtest: basic-busy-flip-before-cursor-legacy [91.020913] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [91.075438] [096/165] (906s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [91.291092] Starting subtest: basic-flip-after-cursor-atomic [92.492323] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.196s) [93.384108] [097/165] (903s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [93.607133] Starting subtest: basic-flip-after-cursor-legacy [94.808731] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.201s) [95.751561] [098/165] (901s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [95.972994] Starting subtest: basic-flip-after-cursor-varying-size [97.178631] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.205s) [98.119615] [099/165] (899s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [98.360973] Starting subtest: basic-flip-before-cursor-atomic [99.544815] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.184s) [100.489370] [100/165] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [100.710138] Starting subtest: basic-flip-before-cursor-legacy [101.896143] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.186s) [102.809141] [101/165] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [103.033213] Starting subtest: basic-flip-before-cursor-varying-size [104.217403] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.184s) [105.160113] [102/165] (892s left) kms_dsc (dsc-basic) [105.390951] Starting subtest: dsc-basic [105.391915] Starting dynamic subtest: pipe-A-eDP-1 [106.684833] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.293s) [106.695159] Starting dynamic subtest: pipe-B-eDP-1 [107.944082] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s) [107.953691] Starting dynamic subtest: pipe-C-eDP-1 [109.229441] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s) [109.237387] Starting dynamic subtest: pipe-D-eDP-1 [110.503538] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.274s) [110.505101] Subtest dsc-basic: SUCCESS (5.112s) [111.751903] [103/165] (885s left) kms_flip (basic-flip-vs-dpms) [111.886668] Starting subtest: basic-flip-vs-dpms [111.887787] Starting dynamic subtest: A-eDP1 [114.634846] Dynamic subtest A-eDP1: SUCCESS (2.747s) [114.640719] Starting dynamic subtest: B-eDP1 [116.987153] Dynamic subtest B-eDP1: SUCCESS (2.352s) [116.998498] Starting dynamic subtest: C-eDP1 [119.375133] Dynamic subtest C-eDP1: SUCCESS (2.386s) [119.383988] Starting dynamic subtest: D-eDP1 [121.740216] Dynamic subtest D-eDP1: SUCCESS (2.366s) [121.741807] Subtest basic-flip-vs-dpms: SUCCESS (9.857s) [122.632222] [104/165] (874s left) kms_flip (basic-flip-vs-modeset) [122.767098] Starting subtest: basic-flip-vs-modeset [122.768075] Starting dynamic subtest: A-eDP1 [125.513064] Dynamic subtest A-eDP1: SUCCESS (2.746s) [125.519513] Starting dynamic subtest: B-eDP1 [127.865236] Dynamic subtest B-eDP1: SUCCESS (2.351s) [127.871137] Starting dynamic subtest: C-eDP1 [130.234364] Dynamic subtest C-eDP1: SUCCESS (2.369s) [130.240243] Starting dynamic subtest: D-eDP1 [132.602803] Dynamic subtest D-eDP1: SUCCESS (2.368s) [132.606977] Subtest basic-flip-vs-modeset: SUCCESS (9.840s) [133.512228] [105/165] (863s left) kms_flip (basic-flip-vs-wf_vblank) [133.644971] Starting subtest: basic-flip-vs-wf_vblank [133.646106] Starting dynamic subtest: A-eDP1 [135.696835] Dynamic subtest A-eDP1: SUCCESS (2.050s) [135.709131] Starting dynamic subtest: B-eDP1 [137.728108] Dynamic subtest B-eDP1: SUCCESS (2.029s) [137.741732] Starting dynamic subtest: C-eDP1 [139.712725] Dynamic subtest C-eDP1: SUCCESS (1.982s) [139.726124] Starting dynamic subtest: D-eDP1 [141.696274] Dynamic subtest D-eDP1: SUCCESS (1.982s) [141.702586] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.059s) [142.920865] [106/165] (854s left) kms_flip (basic-plain-flip) [143.046467] Starting subtest: basic-plain-flip [143.048218] Starting dynamic subtest: A-eDP1 [144.821827] Dynamic subtest A-eDP1: SUCCESS (1.772s) [144.834594] Starting dynamic subtest: B-eDP1 [146.596974] Dynamic subtest B-eDP1: SUCCESS (1.773s) [146.609352] Starting dynamic subtest: C-eDP1 [148.324682] Dynamic subtest C-eDP1: SUCCESS (1.726s) [148.332629] Starting dynamic subtest: D-eDP1 [150.053159] Dynamic subtest D-eDP1: SUCCESS (1.727s) [150.059103] Subtest basic-plain-flip: SUCCESS (7.012s) [151.303952] [107/165] (846s left) kms_force_connector_basic (force-connector-state) [151.599742] Starting subtest: force-connector-state [152.572883] Subtest force-connector-state: SUCCESS (0.971s) [153.793630] [108/165] (843s left) kms_force_connector_basic (force-edid) [154.084933] Starting subtest: force-edid [154.604639] Subtest force-edid: SUCCESS (0.519s) [155.130033] [109/165] (842s left) kms_force_connector_basic (force-load-detect) [155.419809] Starting subtest: force-load-detect [155.421592] Subtest force-load-detect: SKIP (0.000s) [155.845666] [110/165] (841s left) kms_force_connector_basic (prune-stale-modes) [156.158774] Starting subtest: prune-stale-modes [156.717413] Subtest prune-stale-modes: SUCCESS (0.559s) [157.230211] [111/165] (840s left) kms_frontbuffer_tracking (basic) [157.455012] Starting subtest: basic [160.291926] Subtest basic: SUCCESS (2.838s) [160.396435] [112/165] (837s left) kms_hdmi_inject (inject-audio) [160.743211] Starting subtest: inject-audio [161.208868] Subtest inject-audio: SUCCESS (0.467s) [161.755453] [113/165] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [161.981147] Starting subtest: compare-crc-sanitycheck-xr24 [161.982278] Starting dynamic subtest: pipe-A-eDP-1 [162.616068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s) [162.622813] Starting dynamic subtest: pipe-B-eDP-1 [163.992882] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s) [164.003131] Starting dynamic subtest: pipe-C-eDP-1 [165.395884] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s) [165.401824] Starting dynamic subtest: pipe-D-eDP-1 [166.802860] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s) [166.803645] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.822s) [167.751742] [114/165] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [167.974218] Starting subtest: compare-crc-sanitycheck-nv12 [167.975225] Starting dynamic subtest: pipe-A-eDP-1 [168.660075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s) [168.669053] Starting dynamic subtest: pipe-B-eDP-1 [170.067118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s) [170.074854] Starting dynamic subtest: pipe-C-eDP-1 [171.495095] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.424s) [171.501888] Starting dynamic subtest: pipe-D-eDP-1 [172.883850] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.387s) [172.884904] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.909s) [173.836418] [115/165] (823s left) kms_pipe_crc_basic (hang-read-crc) [174.057198] Starting subtest: hang-read-crc [174.058133] Starting dynamic subtest: pipe-A-eDP-1 [176.332633] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.273s) [176.340119] Starting dynamic subtest: pipe-B-eDP-1 [179.240467] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.907s) [179.246621] Starting dynamic subtest: pipe-C-eDP-1 [182.187272] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.945s) [182.198148] Starting dynamic subtest: pipe-D-eDP-1 [185.129783] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.940s) [185.131077] Subtest hang-read-crc: SUCCESS (11.073s) [186.055692] [116/165] (811s left) kms_pipe_crc_basic (nonblocking-crc) [186.283746] Starting subtest: nonblocking-crc [186.284854] Starting dynamic subtest: pipe-A-eDP-1 [187.117044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s) [187.124368] Starting dynamic subtest: pipe-B-eDP-1 [188.671673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s) [188.677963] Starting dynamic subtest: pipe-C-eDP-1 [190.201479] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.531s) [190.208150] Starting dynamic subtest: pipe-D-eDP-1 [191.743389] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s) [191.744331] Subtest nonblocking-crc: SUCCESS (5.455s) [192.658527] [117/165] (804s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [192.884239] Starting subtest: nonblocking-crc-frame-sequence [192.885128] Starting dynamic subtest: pipe-A-eDP-1 [193.716285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s) [193.725197] Starting dynamic subtest: pipe-B-eDP-1 [195.260712] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.542s) [195.269236] Starting dynamic subtest: pipe-C-eDP-1 [196.794451] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.531s) [196.800104] Starting dynamic subtest: pipe-D-eDP-1 [198.333610] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.537s) [198.335073] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.449s) [199.240779] [118/165] (798s left) kms_pipe_crc_basic (read-crc) [199.460812] Starting subtest: read-crc [199.461904] Starting dynamic subtest: pipe-A-eDP-1 [200.201723] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s) [200.212720] Starting dynamic subtest: pipe-B-eDP-1 [201.656083] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s) [201.662102] Starting dynamic subtest: pipe-C-eDP-1 [203.126117] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.470s) [203.131668] Starting dynamic subtest: pipe-D-eDP-1 [204.598133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.471s) [204.599098] Subtest read-crc: SUCCESS (5.139s) [205.513244] [119/165] (792s left) kms_pipe_crc_basic (read-crc-frame-sequence) [205.736130] Starting subtest: read-crc-frame-sequence [205.737053] Starting dynamic subtest: pipe-A-eDP-1 [206.503232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.767s) [206.509999] Starting dynamic subtest: pipe-B-eDP-1 [207.989699] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [207.997080] Starting dynamic subtest: pipe-C-eDP-1 [209.463233] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.472s) [209.470222] Starting dynamic subtest: pipe-D-eDP-1 [210.940376] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.471s) [210.941126] Subtest read-crc-frame-sequence: SUCCESS (5.200s) [211.848951] [120/165] (785s left) kms_pm_backlight (basic-brightness) [212.097771] Starting subtest: basic-brightness [212.124838] Starting dynamic subtest: eDP-1 [212.640566] Dynamic subtest eDP-1: SUCCESS (0.516s) [212.641234] Subtest basic-brightness: SUCCESS (0.545s) [213.568774] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1768 [max: 8192] direct dependencies: 17670 [max: 32768] indirect dependencies: 134309 all direct dependencies: 366006 dependency chains: 25611 [max: 131072] dependency chain hlocks used: 106345 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 283 in-softirq chains: 584 in-process chains: 24744 stack-trace entries: 167520 [max: 1048576] number of stack traces: 8463 number of stack hash chains: 6673 combined max dependencies: 4111134300 hardirq-safe locks: 102 hardirq-unsafe locks: 1062 softirq-safe locks: 208 softirq-unsafe locks: 973 irq-safe locks: 226 irq-unsafe locks: 1062 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 307 softirq-read-safe locks: 7 softirq-read-unsafe locks: 302 irq-read-safe locks: 7 irq-read-unsafe locks: 307 uncategorized locks: 284 unused locks: 1 max locking depth: 14 max bfs queue depth: 394 max lock class index: 1767 chain lookup misses: 26051 chain lookup hits: 216080098 cyclic checks: 26158 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4343 find-mask backwards checks: 2646 hardirq on events: 131593020 hardirq off events: 131593004 redundant hardirq ons: 52 redundant hardirq offs: 25 softirq on events: 734752 softirq off events: 734752 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 110 large chain blocks: 1 [213.570533] Closing watchdogs Done.