[40.416373] Initializing watchdogs [40.416486] /dev/watchdog0 [40.428868] [001/140] (960s left) gem_workarounds (suspend-resume) [40.516823] Starting subtest: suspend-resume [57.682928] Subtest suspend-resume: SUCCESS (1.168s) [57.795767] [002/140] (959s left) gem_userptr_blits (coherency-sync) [57.861117] Starting subtest: coherency-sync [58.104294] Subtest coherency-sync: SKIP (0.217s) [58.194300] [003/140] (958s left) sw_sync (sync_random_merge) [58.309609] Starting subtest: sync_random_merge [58.346249] Subtest sync_random_merge: SUCCESS (0.037s) [58.391738] [004/140] (958s left) kms_scaling_modes (scaling-mode-center) [58.480563] Starting subtest: scaling-mode-center [58.483288] Starting dynamic subtest: pipe-A-eDP-1 [58.575104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s) [58.582355] Starting dynamic subtest: pipe-B-eDP-1 [59.808214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s) [59.821682] Starting dynamic subtest: pipe-C-eDP-1 [61.000989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s) [61.013786] Starting dynamic subtest: pipe-D-eDP-1 [62.215333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s) [62.217772] Subtest scaling-mode-center: SUCCESS (3.739s) [63.662432] [005/140] (953s left) kms_big_fb (x-tiled-8bpp-rotate-180) [63.738874] Starting subtest: x-tiled-8bpp-rotate-180 [65.049623] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.314s) [65.173863] [006/140] (951s left) gem_ctx_param (invalid-param-set) [65.238697] Starting subtest: invalid-param-set [65.240284] Subtest invalid-param-set: SUCCESS (0.000s) [65.293720] [007/140] (951s left) gem_exec_fence (parallel) [65.482585] Starting subtest: parallel [65.485559] Starting dynamic subtest: rcs0 [67.635755] Dynamic subtest rcs0: SUCCESS (2.154s) [67.649611] Starting dynamic subtest: bcs0 [69.783462] Dynamic subtest bcs0: SUCCESS (2.148s) [69.798537] Starting dynamic subtest: vcs0 [71.938104] Dynamic subtest vcs0: SUCCESS (2.154s) [71.952069] Starting dynamic subtest: vcs1 [74.086093] Dynamic subtest vcs1: SUCCESS (2.148s) [74.099519] Starting dynamic subtest: vecs0 [76.240243] Dynamic subtest vecs0: SUCCESS (2.153s) [76.253084] Starting dynamic subtest: ccs0 [78.389615] Dynamic subtest ccs0: SUCCESS (2.149s) [78.391710] Subtest parallel: SUCCESS (12.908s) [79.530945] [008/140] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [79.613988] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [79.618635] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [79.683595] [009/140] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [79.758032] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [79.762486] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [79.842411] [010/140] (937s left) kms_hdr (static-toggle) [79.916805] Starting subtest: static-toggle [79.921090] Subtest static-toggle: SKIP (0.000s) [79.975016] [011/140] (937s left) kms_ccs (pipe-c-missing-ccs-buffer-y-tiled-gen12-mc-ccs) [80.372210] Starting subtest: pipe-C-missing-ccs-buffer-y-tiled-gen12-mc-ccs [80.378202] Subtest pipe-C-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s) [81.242488] [012/140] (935s left) api_intel_bb (render) [81.298613] Starting subtest: render [81.301028] Starting dynamic subtest: render-none-512 [81.389339] Dynamic subtest render-none-512: SUCCESS (0.097s) [81.403535] Starting dynamic subtest: render-none-1024 [81.780973] Dynamic subtest render-none-1024: SUCCESS (0.390s) [81.795543] Starting dynamic subtest: render-x-512 [81.859792] Dynamic subtest render-x-512: SUCCESS (0.080s) [81.874298] Starting dynamic subtest: render-x-1024 [82.359630] Dynamic subtest render-x-1024: SUCCESS (0.498s) [82.367809] Starting dynamic subtest: render-y-512 [82.475271] Dynamic subtest render-y-512: SUCCESS (0.116s) [82.490221] Starting dynamic subtest: render-y-1024 [82.826375] Dynamic subtest render-y-1024: SUCCESS (0.351s) [82.829280] Subtest render: SUCCESS (1.533s) [82.914381] [013/140] (934s left) syncobj_timeline (wait-all-complex) [82.965248] Starting subtest: wait-all-complex [83.186709] Subtest wait-all-complex: SUCCESS (0.219s) [83.253376] [014/140] (933s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [83.317439] Starting subtest: map-fixed-invalidate-overlap-busy [83.321913] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [83.417441] [015/140] (933s left) gem_exec_create (basic) [83.473162] Starting subtest: basic [83.475613] Starting dynamic subtest: smem [85.567487] Dynamic subtest smem: SUCCESS (2.095s) [85.570049] Subtest basic: SUCCESS (2.095s) [85.745642] [016/140] (931s left) kms_ccs (pipe-c-bad-pixel-format-y-tiled-ccs) [86.126106] Starting subtest: pipe-C-bad-pixel-format-y-tiled-ccs [86.131203] Subtest pipe-C-bad-pixel-format-y-tiled-ccs: SKIP (0.000s) [87.006566] [017/140] (930s left) vc4/vc4_wait_bo (bad-bo) [87.077267] Subtest bad-bo: SKIP (0.000s) [87.124554] [018/140] (930s left) api_intel_bb (blit-reloc-purge-cache) [87.170429] Starting subtest: blit-reloc-purge-cache [87.175077] Subtest blit-reloc-purge-cache: SKIP (0.000s) [87.257896] [019/140] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite) [87.349100] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite [91.989970] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.649s) [92.115602] [020/140] (925s left) kms_cursor_crc (cursor-suspend) [92.207025] Starting subtest: cursor-suspend [92.209440] Starting dynamic subtest: pipe-A-eDP-1 [125.280567] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.213s) [125.291932] Starting dynamic subtest: pipe-D-eDP-1 [159.267752] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.946s) [159.270386] Subtest cursor-suspend: SUCCESS (7.163s) [160.150960] [021/140] (917s left) gem_pxp (verify-pxp-stale-buf-execution) [162.732994] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s) [162.790985] [022/140] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [162.865863] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [168.113637] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.251s) [168.229872] [023/140] (909s left) drm_read (fault-buffer) [168.363755] Starting subtest: fault-buffer [168.366446] Subtest fault-buffer: SUCCESS (0.001s) [168.465134] [024/140] (908s left) kms_psr (pr_sprite_plane_move) [168.529251] Starting subtest: pr_sprite_plane_move [168.534421] Subtest pr_sprite_plane_move: SKIP (0.000s) [168.626291] [025/140] (908s left) gem_userptr_blits (dmabuf-sync) [168.706613] Starting subtest: dmabuf-sync [168.711520] Subtest dmabuf-sync: SKIP (0.003s) [168.819094] [026/140] (908s left) gem_exec_create (forked) [168.895952] Starting subtest: forked [168.898754] Starting dynamic subtest: smem [190.302403] Dynamic subtest smem: SUCCESS (21.405s) [190.305281] Subtest forked: SUCCESS (21.406s) [190.475750] [027/140] (886s left) gem_exec_whisper (basic-forked-all) [190.520632] Starting subtest: basic-forked-all [214.325098] Subtest basic-forked-all: SUCCESS (23.804s) [214.506300] [028/140] (862s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [214.570542] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [215.290754] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.725s) [215.459019] [029/140] (862s left) gem_ctx_persistence (idempotent) [215.513175] Starting subtest: idempotent [215.516148] Subtest idempotent: SUCCESS (0.000s) [215.579232] [030/140] (861s left) kms_cursor_crc (cursor-random-256x85) [215.785982] Starting subtest: cursor-random-256x85 [215.791248] Starting dynamic subtest: pipe-A-eDP-1 [219.589733] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.799s) [219.626413] Starting dynamic subtest: pipe-D-eDP-1 [223.979058] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.366s) [223.981667] Subtest cursor-random-256x85: SUCCESS (8.192s) [224.863820] [031/140] (852s left) v3d/v3d_wait_bo (used-bo-0ns) [224.950873] Subtest used-bo-0ns: SKIP (0.000s) [224.997878] [032/140] (852s left) syncobj_wait (wait-all-interrupted) [225.050842] Starting subtest: wait-all-interrupted [225.151976] Subtest wait-all-interrupted: SUCCESS (0.103s) [225.223362] [033/140] (852s left) perf (invalid-open-flags) [225.376375] Starting subtest: invalid-open-flags [225.378254] Subtest invalid-open-flags: SUCCESS (0.000s) [225.398505] [034/140] (852s left) kms_atomic (atomic-invalid-params) [225.460056] Starting subtest: atomic-invalid-params [225.462514] Starting dynamic subtest: pipe-A-eDP-1 [225.869211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s) [225.871696] Subtest atomic-invalid-params: SUCCESS (0.411s) [226.766055] [035/140] (850s left) v3d/v3d_mmap (mmap-bo) [226.856753] Subtest mmap-bo: SKIP (0.000s) [226.906418] [036/140] (850s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [227.003943] Starting subtest: fbc-shrfb-scaledprimary [231.133186] Subtest fbc-shrfb-scaledprimary: SUCCESS (4.134s) [231.269376] [037/140] (846s left) kms_vblank (wait-forked-busy-hang) [231.313832] Starting subtest: wait-forked-busy-hang [231.316274] Starting dynamic subtest: pipe-A-eDP-1 [245.161205] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.847s) [245.177187] Starting dynamic subtest: pipe-D-eDP-1 [260.124938] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.958s) [260.127478] Subtest wait-forked-busy-hang: SUCCESS (28.812s) [261.015772] [038/140] (816s left) gem_exec_balancer (invalid-bonds) [261.075537] Starting subtest: invalid-bonds [261.079803] Subtest invalid-bonds: SKIP (0.000s) [261.317064] [039/140] (816s left) gem_eio (in-flight-internal-10ms) [261.505524] Starting subtest: in-flight-internal-10ms [263.419833] Subtest in-flight-internal-10ms: SUCCESS (1.915s) [263.533625] [040/140] (814s left) gem_ctx_isolation (dirty-switch) [263.584456] Starting subtest: dirty-switch [263.587088] Starting dynamic subtest: rcs0 [263.728610] Dynamic subtest rcs0: SUCCESS (0.145s) [263.744868] Starting dynamic subtest: bcs0 [263.934619] Dynamic subtest bcs0: SUCCESS (0.205s) [263.941316] Starting dynamic subtest: vcs0 [264.149694] Dynamic subtest vcs0: SUCCESS (0.215s) [264.159760] Starting dynamic subtest: vcs1 [265.480793] Dynamic subtest vcs1: SUCCESS (1.330s) [265.500939] Starting dynamic subtest: vecs0 [267.555340] Dynamic subtest vecs0: SUCCESS (2.075s) [267.562198] Starting dynamic subtest: ccs0 [269.540678] Dynamic subtest ccs0: SUCCESS (1.983s) [269.543367] Subtest dirty-switch: SUCCESS (5.955s) [269.761793] [041/140] (808s left) prime_mmap (test_reprime) [269.806772] Starting subtest: test_reprime [269.809388] Starting dynamic subtest: test_reprime-smem [269.828545] Dynamic subtest test_reprime-smem: SUCCESS (0.025s) [269.831403] Subtest test_reprime: SUCCESS (0.026s) [269.921339] [042/140] (807s left) kms_atomic (plane-overlay-legacy) [269.974758] Starting subtest: plane-overlay-legacy [269.976961] Starting dynamic subtest: pipe-A-eDP-1 [270.406201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s) [270.408939] Subtest plane-overlay-legacy: SUCCESS (0.434s) [271.321729] [043/140] (806s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-gen12-mc-ccs) [271.734747] Starting subtest: pipe-D-bad-rotation-90-y-tiled-gen12-mc-ccs [271.740301] Subtest pipe-D-bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.000s) [272.601041] [044/140] (805s left) gem_exec_schedule (fairslice) [272.657186] Starting subtest: fairslice [272.659602] Starting dynamic subtest: rcs0 [274.672993] Dynamic subtest rcs0: SUCCESS (2.025s) [274.689460] Starting dynamic subtest: bcs0 [276.705203] Dynamic subtest bcs0: SUCCESS (2.029s) [276.722200] Starting dynamic subtest: vcs0 [278.732338] Dynamic subtest vcs0: SUCCESS (2.027s) [278.749828] Starting dynamic subtest: vcs1 [280.758860] Dynamic subtest vcs1: SUCCESS (2.026s) [280.773626] Starting dynamic subtest: vecs0 [282.786757] Dynamic subtest vecs0: SUCCESS (2.027s) [282.803350] Starting dynamic subtest: ccs0 [284.812165] Dynamic subtest ccs0: SUCCESS (2.025s) [284.814250] Subtest fairslice: SUCCESS (12.164s) [285.117174] [045/140] (792s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [285.199818] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [285.204467] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [285.286095] [046/140] (792s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [285.349990] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [285.352456] Starting dynamic subtest: pipe-A-eDP-1 [285.357209] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [285.373872] Starting dynamic subtest: pipe-B-eDP-1 [285.379161] Dynamic subtest pipe-B-eDP-1: SKIP (0.012s) [285.393317] Starting dynamic subtest: pipe-C-eDP-1 [285.397700] Dynamic subtest pipe-C-eDP-1: SKIP (0.012s) [285.404239] Starting dynamic subtest: pipe-D-eDP-1 [285.407983] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s) [285.411955] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.043s) [285.463276] [047/140] (792s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [285.547487] Starting subtest: psr-indfb-scaledprimary [289.343495] Subtest psr-indfb-scaledprimary: SUCCESS (3.798s) [289.451139] [048/140] (788s left) gem_exec_schedule (submit-early-slice) [289.507822] Starting subtest: submit-early-slice [289.510360] Starting dynamic subtest: rcs0 [289.537811] Dynamic subtest rcs0: SUCCESS (0.042s) [289.544873] Starting dynamic subtest: bcs0 [289.640680] Dynamic subtest bcs0: SUCCESS (0.102s) [289.655402] Starting dynamic subtest: vcs0 [289.690076] Dynamic subtest vcs0: SUCCESS (0.049s) [289.698105] Starting dynamic subtest: vcs1 [289.733008] Dynamic subtest vcs1: SUCCESS (0.042s) [289.746414] Starting dynamic subtest: vecs0 [289.773770] Dynamic subtest vecs0: SUCCESS (0.040s) [289.791319] Starting dynamic subtest: ccs0 [289.823121] Dynamic subtest ccs0: SUCCESS (0.049s) [289.825653] Subtest submit-early-slice: SUCCESS (0.328s) [291.424796] [049/140] (786s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-mtl-mc-ccs) [291.807915] Starting subtest: pipe-B-crc-primary-basic-4-tiled-mtl-mc-ccs [294.397856] Subtest pipe-B-crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (2.588s) [295.577401] [050/140] (782s left) gem_exec_params (invalid-fence-in-submit) [295.634214] Starting subtest: invalid-fence-in-submit [295.640033] Subtest invalid-fence-in-submit: SUCCESS (0.006s) [295.738205] [051/140] (782s left) gem_set_tiling_vs_gtt [295.834589] [052/140] (782s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [295.906670] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [298.908696] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (3.008s) [299.042457] [053/140] (779s left) kms_lease (empty-lease) [299.123108] Starting subtest: empty-lease [299.125298] Starting dynamic subtest: pipe-A-eDP-1 [299.127424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [299.136962] Starting dynamic subtest: pipe-B-eDP-1 [299.138577] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [299.151867] Starting dynamic subtest: pipe-C-eDP-1 [299.154356] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [299.165137] Starting dynamic subtest: pipe-D-eDP-1 [299.167493] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [299.169818] Subtest empty-lease: SUCCESS (0.005s) [299.189026] [054/140] (779s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [299.238088] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [299.243334] Starting dynamic subtest: A-eDP1 [303.047101] Dynamic subtest A-eDP1: SUCCESS (3.801s) [303.065078] Starting dynamic subtest: B-eDP1 [306.505726] Dynamic subtest B-eDP1: SUCCESS (3.456s) [306.524812] Starting dynamic subtest: C-eDP1 [309.959816] Dynamic subtest C-eDP1: SUCCESS (3.453s) [309.976873] Starting dynamic subtest: D-eDP1 [313.415091] Dynamic subtest D-eDP1: SUCCESS (3.455s) [313.421351] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (14.183s) [314.328572] [055/140] (763s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [314.400985] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [314.403826] Starting dynamic subtest: pipe-A-eDP-1 [314.419640] Dynamic subtest pipe-A-eDP-1: SKIP (0.015s) [314.436080] Starting dynamic subtest: pipe-B-eDP-1 [314.441075] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s) [314.454620] Starting dynamic subtest: pipe-C-eDP-1 [314.459554] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s) [314.470496] Starting dynamic subtest: pipe-D-eDP-1 [314.474765] Dynamic subtest pipe-D-eDP-1: SKIP (0.017s) [314.479239] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.071s) [314.556732] [056/140] (763s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [314.935030] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [316.831946] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.898s) [318.040999] [057/140] (760s left) core_getstats [318.158457] [058/140] (760s left) v3d/v3d_submit_cl (bad-in-sync) [318.236942] Subtest bad-in-sync: SKIP (0.000s) [318.284207] [059/140] (760s left) kms_ccs (pipe-a-bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [318.695245] Starting subtest: pipe-A-bad-aux-stride-y-tiled-gen12-rc-ccs-cc [318.701252] Subtest pipe-A-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [319.584980] [060/140] (758s left) syncobj_wait (wait-all-complex) [319.636747] Starting subtest: wait-all-complex [319.856127] Subtest wait-all-complex: SUCCESS (0.219s) [319.927054] [061/140] (758s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [319.982128] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [319.987504] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [320.162618] [062/140] (758s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [320.256508] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [324.823479] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.570s) [324.945702] [063/140] (753s left) syncobj_basic (bad-pad-handle-to-fd) [324.999236] Starting subtest: bad-pad-handle-to-fd [325.001441] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [325.054316] [064/140] (753s left) gen9_exec_parse (allowed-single) [325.113449] Subtest allowed-single: SKIP (0.000s) [325.137721] [065/140] (753s left) gem_ctx_shared (q-promotion) [325.187428] Starting subtest: Q-promotion [325.189934] Starting dynamic subtest: rcs0 [325.307038] Dynamic subtest rcs0: SUCCESS (0.119s) [325.324985] Starting dynamic subtest: vcs0 [325.416791] Dynamic subtest vcs0: SUCCESS (0.109s) [325.446336] Starting dynamic subtest: vcs1 [325.513127] Dynamic subtest vcs1: SUCCESS (0.095s) [325.538571] Starting dynamic subtest: vecs0 [325.630477] Dynamic subtest vecs0: SUCCESS (0.116s) [325.652645] Starting dynamic subtest: ccs0 [325.732680] Dynamic subtest ccs0: SUCCESS (0.101s) [325.735384] Subtest Q-promotion: SUCCESS (0.547s) [327.401709] [066/140] (751s left) vc4/vc4_purgeable_bo (free-purged-bo) [327.495896] Subtest free-purged-bo: SKIP (0.000s) [327.548341] [067/140] (751s left) gem_mmap_gtt (ptrace) [327.618808] Subtest ptrace: SKIP (0.000s) [327.645347] [068/140] (750s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-gen12-mc-ccs) [328.067581] Starting subtest: pipe-D-bad-pixel-format-y-tiled-gen12-mc-ccs [328.073668] Subtest pipe-D-bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.000s) [328.919026] [069/140] (749s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [328.989175] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [328.991557] Starting dynamic subtest: pipe-A-default-mode [329.286451] Dynamic subtest pipe-A-default-mode: SKIP (0.292s) [329.291608] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.296s) [330.199248] [070/140] (748s left) gem_ctx_persistence (file) [330.253221] Starting subtest: file [330.328986] Subtest file: SUCCESS (0.077s) [330.424669] [071/140] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [330.476408] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [330.480855] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [330.556885] [072/140] (748s left) i915_pm_freq_api (freq-basic-api) [330.620603] Starting subtest: freq-basic-api [330.623206] Starting dynamic subtest: gt0 [330.625868] Dynamic subtest gt0: SUCCESS (0.005s) [330.642805] Starting dynamic subtest: gt1 [330.645377] Dynamic subtest gt1: SUCCESS (0.003s) [330.647948] Subtest freq-basic-api: SUCCESS (0.009s) [330.723718] [073/140] (748s left) prime_mmap (test_dup) [330.780967] Starting subtest: test_dup [330.783182] Starting dynamic subtest: test_dup-smem [330.803265] Dynamic subtest test_dup-smem: SUCCESS (0.025s) [330.805977] Subtest test_dup: SUCCESS (0.026s) [330.865841] [074/140] (747s left) dmabuf (all-tests) [330.920681] Starting subtest: all-tests [330.923231] Starting dynamic subtest: sanitycheck [330.995835] Dynamic subtest sanitycheck: SUCCESS (0.075s) [331.018638] Starting dynamic subtest: dma_fence [331.184616] Dynamic subtest dma_fence: SUCCESS (0.187s) [331.202372] Starting dynamic subtest: dma_fence_chain [340.270349] Dynamic subtest dma_fence_chain: SUCCESS (9.083s) [340.288390] Starting dynamic subtest: dma_fence_unwrap [340.341733] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s) [340.360149] Starting dynamic subtest: dma_resv [340.411149] Dynamic subtest dma_resv: SUCCESS (0.069s) [340.414097] Subtest all-tests: SUCCESS (9.491s) [340.474038] [075/140] (738s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [340.540255] Starting subtest: cursorB-vs-flipB-varying-size [340.544709] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [340.625204] [076/140] (738s left) prime_busy (before) [340.677955] Starting subtest: before [340.680935] Starting dynamic subtest: rcs0 [340.716807] Dynamic subtest rcs0: SUCCESS (0.036s) [340.728506] Starting dynamic subtest: bcs0 [340.759271] Dynamic subtest bcs0: SUCCESS (0.041s) [340.776317] Starting dynamic subtest: vcs0 [340.801738] Dynamic subtest vcs0: SUCCESS (0.041s) [340.818080] Starting dynamic subtest: vcs1 [340.843624] Dynamic subtest vcs1: SUCCESS (0.041s) [340.856765] Starting dynamic subtest: vecs0 [340.886279] Dynamic subtest vecs0: SUCCESS (0.041s) [340.899444] Starting dynamic subtest: ccs0 [340.929570] Dynamic subtest ccs0: SUCCESS (0.042s) [341.041248] Subtest before: SUCCESS (0.362s) [341.111669] [077/140] (737s left) gem_softpin (safe-alignment) [341.164718] Starting subtest: safe-alignment [341.192661] Subtest safe-alignment: SUCCESS (0.028s) [342.334457] [078/140] (736s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [342.405793] Starting subtest: fbc-rgb565-draw-mmap-gtt [342.410470] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [342.500780] [079/140] (736s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [342.566579] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [342.577233] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.013s) [342.637597] [080/140] (736s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [342.702161] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [345.917363] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.217s) [346.029826] [081/140] (732s left) kms_chamelium_hpd (vga-hpd-without-ddc) [346.374683] Subtest vga-hpd-without-ddc: SKIP (0.000s) [347.264580] [082/140] (731s left) tools_test (tools_test) [347.350876] Starting subtest: tools_test [347.425468] Subtest tools_test: SUCCESS (0.091s) [347.482492] [083/140] (731s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [347.525113] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [347.556453] [084/140] (731s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [347.913315] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc [348.770808] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.857s) [349.943458] [085/140] (729s left) kms_addfb_basic (clobberred-modifier) [349.994490] Starting subtest: clobberred-modifier [349.999079] Subtest clobberred-modifier: SKIP (0.000s) [350.094594] [086/140] (729s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [350.179243] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [350.183939] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [350.255757] [087/140] (728s left) i915_pm_rpm (sysfs-read) [352.485103] Starting subtest: sysfs-read [355.859597] Subtest sysfs-read: SUCCESS (3.369s) [356.659040] [088/140] (722s left) kms_chamelium_edid (hdmi-edid-read) [357.017041] Subtest hdmi-edid-read: SKIP (0.000s) [357.884506] [089/140] (721s left) kms_pm_dc (dc9-dpms) [358.970215] Starting subtest: dc9-dpms [360.114067] Subtest dc9-dpms: SUCCESS (1.144s) [360.176029] [090/140] (719s left) kms_draw_crc (draw-method-render) [360.235990] Starting subtest: draw-method-render [360.238472] Starting dynamic subtest: xrgb8888-untiled [360.526519] Dynamic subtest xrgb8888-untiled: SUCCESS (0.289s) [360.544589] Starting dynamic subtest: rgb565-untiled [360.780852] Dynamic subtest rgb565-untiled: SUCCESS (0.254s) [360.798391] Starting dynamic subtest: xrgb2101010-untiled [360.993653] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [361.011508] Starting dynamic subtest: xrgb8888-xtiled [361.125730] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [361.143286] Starting dynamic subtest: rgb565-xtiled [361.247320] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [361.265619] Starting dynamic subtest: xrgb2101010-xtiled [361.360199] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [361.375982] Starting dynamic subtest: xrgb8888-4tiled [361.482863] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [361.500199] Starting dynamic subtest: rgb565-4tiled [361.592195] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s) [361.609675] Starting dynamic subtest: xrgb2101010-4tiled [361.702814] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s) [361.705116] Subtest draw-method-render: SUCCESS (1.468s) [361.806330] [091/140] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [361.874217] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [361.877639] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [361.962217] [092/140] (717s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [362.312637] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-rc-ccs [362.318623] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.000s) [363.225667] [093/140] (716s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [363.296261] Starting subtest: plane-use-after-nonblocking-unbind [363.298899] Starting dynamic subtest: pipe-A-eDP-1 [363.377058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.078s) [363.694611] Starting dynamic subtest: pipe-B-eDP-1 [364.566307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.891s) [364.867431] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.570s) [365.786555] [094/140] (713s left) gem_ctx_create (basic-files) [365.854700] Starting subtest: basic-files [367.870513] Subtest basic-files: SUCCESS (2.016s) [369.409522] [095/140] (709s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [369.805663] Starting subtest: pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc [369.811751] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [370.647670] [096/140] (708s left) syncobj_wait (invalid-reset-one-illegal-handle) [370.702378] Starting subtest: invalid-reset-one-illegal-handle [370.705124] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [370.771329] [097/140] (708s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [370.831424] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [370.842964] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.013s) [370.915478] [098/140] (708s left) kms_ccs (pipe-c-crc-primary-basic-yf-tiled-ccs) [371.335672] Starting subtest: pipe-C-crc-primary-basic-yf-tiled-ccs [371.340732] Subtest pipe-C-crc-primary-basic-yf-tiled-ccs: SKIP (0.000s) [372.179323] [099/140] (707s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [372.259377] Starting subtest: nonblocking-crc-frame-sequence [372.261831] Starting dynamic subtest: pipe-A-eDP-1 [373.045156] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s) [373.060321] Starting dynamic subtest: pipe-B-eDP-1 [374.608666] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.559s) [374.622730] Starting dynamic subtest: pipe-C-eDP-1 [376.109534] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s) [376.126273] Starting dynamic subtest: pipe-D-eDP-1 [377.615176] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.501s) [377.617466] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.355s) [378.513533] [100/140] (701s left) gem_exec_basic (basic) [378.571443] Starting subtest: basic [378.573969] Starting dynamic subtest: rcs0-smem [378.579481] Dynamic subtest rcs0-smem: SUCCESS (0.005s) [378.590230] Starting dynamic subtest: bcs0-smem [378.592569] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [378.600931] Starting dynamic subtest: vcs0-smem [378.602869] Dynamic subtest vcs0-smem: SUCCESS (0.003s) [378.609447] Starting dynamic subtest: vcs1-smem [378.611387] Dynamic subtest vcs1-smem: SUCCESS (0.003s) [378.617688] Starting dynamic subtest: vecs0-smem [378.619723] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [378.625821] Starting dynamic subtest: ccs0-smem [378.627767] Dynamic subtest ccs0-smem: SUCCESS (0.003s) [378.629713] Subtest basic: SUCCESS (0.027s) [380.351451] [101/140] (699s left) gem_userptr_blits (coherency-unsync) [380.412723] Subtest coherency-unsync: SKIP (0.000s) [380.507761] [102/140] (699s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [380.894975] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [380.900449] Subtest pipe-B-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [381.739220] [103/140] (697s left) kms_psr (psr2_sprite_render) [381.815509] Starting subtest: psr2_sprite_render [381.817978] Starting dynamic subtest: eDP-1 [383.608821] Dynamic subtest eDP-1: SUCCESS (1.793s) [383.613505] Subtest psr2_sprite_render: SUCCESS (1.794s) [384.536189] [104/140] (695s left) kms_flip (flip-vs-expired-vblank-interruptible) [384.591499] Starting subtest: flip-vs-expired-vblank-interruptible [384.593843] Starting dynamic subtest: A-eDP1 [393.354291] Dynamic subtest A-eDP1: SUCCESS (8.762s) [393.365297] Starting dynamic subtest: B-eDP1 [402.058745] Dynamic subtest B-eDP1: SUCCESS (8.702s) [402.077197] Starting dynamic subtest: C-eDP1 [410.816462] Dynamic subtest C-eDP1: SUCCESS (8.754s) [410.833148] Starting dynamic subtest: D-eDP1 [419.519517] Dynamic subtest D-eDP1: SUCCESS (8.702s) [419.526968] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.936s) [420.761866] [105/140] (658s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [420.844343] Starting subtest: cursorA-vs-flipA-legacy [432.011201] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.165s) [432.921781] [106/140] (646s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-ccs) [433.308763] Starting subtest: pipe-C-bad-aux-stride-y-tiled-ccs [433.314989] Subtest pipe-C-bad-aux-stride-y-tiled-ccs: SKIP (0.000s) [434.201462] [107/140] (645s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [434.268904] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [434.273715] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [434.351241] [108/140] (645s left) gem_lmem_swapping (massive-random) [434.414221] Subtest massive-random: SKIP (0.000s) [434.457772] [109/140] (645s left) gem_busy (semaphore) [434.647233] Subtest semaphore: SKIP (0.000s) [434.856734] [110/140] (644s left) kms_flip (nonexisting-fb) [434.916838] Starting subtest: nonexisting-fb [434.919303] Starting dynamic subtest: A-eDP1 [436.147716] Dynamic subtest A-eDP1: SUCCESS (1.233s) [436.163480] Starting dynamic subtest: B-eDP1 [437.427350] Dynamic subtest B-eDP1: SUCCESS (1.278s) [437.441868] Starting dynamic subtest: C-eDP1 [438.719118] Dynamic subtest C-eDP1: SUCCESS (1.290s) [438.739604] Starting dynamic subtest: D-eDP1 [439.988733] Dynamic subtest D-eDP1: SUCCESS (1.268s) [439.996533] Subtest nonexisting-fb: SUCCESS (5.084s) [441.240717] [111/140] (638s left) gem_exec_whisper (basic-fds-all) [441.306925] Starting subtest: basic-fds-all [461.309059] Subtest basic-fds-all: SUCCESS (19.998s) [461.490703] [112/140] (618s left) kms_plane_multiple (tiling-none) [461.555952] Starting subtest: tiling-none [461.558362] Starting dynamic subtest: pipe-A-eDP-1 [465.585491] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.030s) [465.600078] Starting dynamic subtest: pipe-B-eDP-1 [470.565821] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.977s) [470.584232] Starting dynamic subtest: pipe-C-eDP-1 [475.328957] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.762s) [475.348534] Starting dynamic subtest: pipe-D-eDP-1 [480.131929] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.801s) [480.134435] Subtest tiling-none: SUCCESS (18.579s) [481.050122] [113/140] (598s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [481.135750] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [481.139805] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [481.211767] [114/140] (598s left) sw_sync (sync_multi_timeline_wait) [481.274216] Starting subtest: sync_multi_timeline_wait [481.277537] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [481.328189] [115/140] (598s left) dumb_buffer (create-valid-dumb) [481.385434] Starting subtest: create-valid-dumb [481.387461] Subtest create-valid-dumb: SUCCESS (0.000s) [481.479843] [116/140] (598s left) kms_cursor_crc (cursor-rapid-movement-256x85) [481.754388] Starting subtest: cursor-rapid-movement-256x85 [481.760046] Starting dynamic subtest: pipe-A-eDP-1 [482.326189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s) [482.362486] Starting dynamic subtest: pipe-D-eDP-1 [483.599837] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [483.602664] Subtest cursor-rapid-movement-256x85: SUCCESS (1.845s) [484.483792] [117/140] (595s left) kms_content_protection (uevent) [484.592875] Starting subtest: uevent [488.110858] Subtest uevent: SKIP (3.515s) [489.368686] [118/140] (590s left) i915_selftest (mock) [490.969295] Starting subtest: mock [490.972583] Starting dynamic subtest: sanitycheck [491.283190] Dynamic subtest sanitycheck: SUCCESS (0.314s) [491.294657] Starting dynamic subtest: shmem [491.474145] Dynamic subtest shmem: SUCCESS (0.190s) [491.485568] Starting dynamic subtest: fence [498.398989] Dynamic subtest fence: SUCCESS (6.922s) [498.411703] Starting dynamic subtest: scatterlist [499.598953] Dynamic subtest scatterlist: SUCCESS (1.200s) [499.612116] Starting dynamic subtest: syncmap [502.314113] Dynamic subtest syncmap: SUCCESS (2.713s) [502.327042] Starting dynamic subtest: uncore [502.504173] Dynamic subtest uncore: SUCCESS (0.190s) [502.515622] Starting dynamic subtest: ring [502.682703] Dynamic subtest ring: SUCCESS (0.178s) [502.694053] Starting dynamic subtest: engine [502.862116] Dynamic subtest engine: SUCCESS (0.178s) [502.873437] Starting dynamic subtest: timelines [506.072285] Dynamic subtest timelines: SUCCESS (3.208s) [506.084884] Starting dynamic subtest: requests [508.987390] Dynamic subtest requests: SUCCESS (2.913s) [509.002275] Starting dynamic subtest: objects [509.280602] Dynamic subtest objects: SUCCESS (0.292s) [509.290977] Starting dynamic subtest: phys [509.552642] Dynamic subtest phys: SUCCESS (0.271s) [509.563661] Starting dynamic subtest: dmabuf [509.831618] Dynamic subtest dmabuf: SUCCESS (0.278s) [509.842836] Starting dynamic subtest: vma [515.201000] Dynamic subtest vma: SUCCESS (5.368s) [515.213540] Starting dynamic subtest: evict [521.447530] Dynamic subtest evict: FAIL (6.201s) [521.472935] Subtest mock: FAIL (30.503s) [521.612350] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1699 [max: 8192] direct dependencies: 17430 [max: 32768] indirect dependencies: 108675 all direct dependencies: 340770 dependency chains: 24657 [max: 131072] dependency chain hlocks used: 102128 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 205 in-softirq chains: 604 in-process chains: 23848 stack-trace entries: 209050 [max: 1048576] number of stack traces: 10357 number of stack hash chains: 7694 combined max dependencies: 2972300870 hardirq-safe locks: 97 hardirq-unsafe locks: 1020 softirq-safe locks: 196 softirq-unsafe locks: 930 irq-safe locks: 220 irq-unsafe locks: 1020 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 299 softirq-read-safe locks: 7 softirq-read-unsafe locks: 294 irq-read-safe locks: 8 irq-read-unsafe locks: 299 uncategorized locks: 276 unused locks: 1 max locking depth: 16 max bfs queue depth: 444 max lock class index: 1884 chain lookup misses: 33256 chain lookup hits: 553776391 cyclic checks: 33426 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5669 find-mask backwards checks: 3150 hardirq on events: 307289800 hardirq off events: 307289778 redundant hardirq ons: 54 redundant hardirq offs: 31 softirq on events: 2068208 softirq off events: 2068208 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 485 zapped lock chains: 8116 large chain blocks: 1 [521.615354] Closing watchdogs Done.