[43.313099] Initializing watchdogs
[43.313158]   /dev/watchdog0
[43.320984] [001/144] (960s left) kms_invalid_mode (clock-too-high)
[43.481917] Starting subtest: clock-too-high
[43.484249] Starting dynamic subtest: pipe-A-eDP-1
[43.488864] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[43.494748] Starting dynamic subtest: pipe-B-eDP-1
[43.498908] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[43.505590] Starting dynamic subtest: pipe-C-eDP-1
[43.510138] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[43.516513] Starting dynamic subtest: pipe-D-eDP-1
[43.521237] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[43.525659] Subtest clock-too-high: SKIP (0.002s)
[43.542848] [002/144] (960s left) gem_tiled_fence_blits (normal)
[43.612810] Subtest normal: SKIP (0.000s)
[43.675287] [003/144] (960s left) gem_mmap_wc (write-gtt-read-wc)
[43.743311] Subtest write-gtt-read-wc: SKIP (0.000s)
[43.788982] [004/144] (960s left) core_auth (many-magics)
[43.854411] Starting subtest: many-magics
[44.324238] Subtest many-magics: SUCCESS (0.470s)
[44.536240] [005/144] (959s left) kms_frontbuffer_tracking (psr-slowdraw)
[44.657306] Starting subtest: psr-slowdraw
[67.734076] Subtest psr-slowdraw: SUCCESS (23.078s)
[67.835586] [006/144] (936s left) syncobj_wait (wait-for-submit-snapshot)
[67.904450] Starting subtest: wait-for-submit-snapshot
[67.986173] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[68.051435] [007/144] (935s left) i915_hangman (gt-error-state-capture)
[68.125268] Starting subtest: gt-error-state-capture
[68.127920] Starting dynamic subtest: rcs0
[79.450601] Dynamic subtest rcs0: SUCCESS (11.323s)
[79.463239] Starting dynamic subtest: bcs0
[91.419437] Dynamic subtest bcs0: SUCCESS (11.969s)
[91.432892] Starting dynamic subtest: vcs0
[103.450083] Dynamic subtest vcs0: SUCCESS (12.030s)
[103.466072] Starting dynamic subtest: vcs1
[115.417881] Dynamic subtest vcs1: SUCCESS (11.967s)
[115.430238] Starting dynamic subtest: vecs0
[127.386580] Dynamic subtest vecs0: SUCCESS (11.968s)
[127.401356] Starting dynamic subtest: ccs0
[139.418392] Dynamic subtest ccs0: SUCCESS (12.032s)
[139.421514] Subtest gt-error-state-capture: SUCCESS (71.292s)
[139.522538] [008/144] (864s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-mtl-mc-ccs)
[139.967810] Starting subtest: pipe-D-bad-rotation-90-4-tiled-mtl-mc-ccs
[141.040623] Subtest pipe-D-bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (1.069s)
[142.220690] [009/144] (861s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[142.390473] Starting subtest: cursor-rapid-movement-64x64
[142.397757] Starting dynamic subtest: pipe-A-eDP-1
[143.044697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s)
[143.075576] Starting dynamic subtest: pipe-D-eDP-1
[144.329112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.263s)
[144.331374] Subtest cursor-rapid-movement-64x64: SUCCESS (1.935s)
[145.211362] [010/144] (858s left) perf (gen12-unprivileged-single-ctx-counters)
[145.392534] Starting subtest: gen12-unprivileged-single-ctx-counters
[145.394955] Starting dynamic subtest: rcs0
[145.439444] Dynamic subtest rcs0: SUCCESS (0.046s)
[145.442965] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.046s)
[145.477445] [011/144] (858s left) i915_pm_rps (thresholds-idle)
[145.588537] Starting subtest: thresholds-idle
[145.591770] Starting dynamic subtest: gt0
[145.600894] Dynamic subtest gt0: SKIP (0.007s)
[145.614227] Starting dynamic subtest: gt1
[145.620188] Dynamic subtest gt1: SKIP (0.001s)
[145.625313] Subtest thresholds-idle: SKIP (0.009s)
[145.666715] [012/144] (858s left) gem_exec_reloc (basic-wc-read-active)
[145.764765] Subtest basic-wc-read-active: SKIP (0.000s)
[145.821079] [013/144] (858s left) gem_softpin (full)
[145.892988] Starting subtest: full
[145.911142] Subtest full: SUCCESS (0.018s)
[146.014323] [014/144] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[146.113167] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[146.117455] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[146.190516] [015/144] (857s left) gem_ringfill (basic-all)
[151.487673] Starting subtest: basic-all
[152.661922] Subtest basic-all: SUCCESS (1.176s)
[152.773088] [016/144] (851s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[152.863643] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[152.866206] Starting dynamic subtest: pipe-A-eDP-1
[158.093148] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.232s)
[158.106305] Starting dynamic subtest: pipe-B-eDP-1
[164.285199] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.189s)
[164.295110] Starting dynamic subtest: pipe-C-eDP-1
[165.640862] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[165.657209] Starting dynamic subtest: pipe-D-eDP-1
[167.083486] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.440s)
[167.086074] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (14.224s)
[168.328054] [017/144] (835s left) gem_exec_whisper (basic-forked-all)
[168.411035] Starting subtest: basic-forked-all
[192.240195] Subtest basic-forked-all: SUCCESS (23.826s)
[192.419727] [018/144] (811s left) syncobj_basic (bad-fd-to-handle)
[192.470064] Starting subtest: bad-fd-to-handle
[192.472823] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[192.556872] [019/144] (811s left) gem_sync (basic-all)
[192.642544] Starting subtest: basic-all
[196.476698] Subtest basic-all: SUCCESS (3.847s)
[196.657708] [020/144] (807s left) gem_pxp (reject-modify-context-protection-on)
[199.322655] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[199.352095] [021/144] (804s left) gem_exec_params (rs-invalid)
[199.423836] Starting subtest: rs-invalid
[199.427958] Subtest rs-invalid: SUCCESS (0.002s)
[199.528759] [022/144] (804s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[199.616347] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[200.697226] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.083s)
[200.825229] [023/144] (803s left) gem_partial_pwrite_pread (write-display)
[200.906891] Subtest write-display: SKIP (0.000s)
[200.960794] [024/144] (803s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[201.063359] Starting subtest: fbcpsr-tiling-linear
[205.757480] Subtest fbcpsr-tiling-linear: SUCCESS (4.697s)
[205.874121] [025/144] (798s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[205.947683] Starting subtest: fbc-pr-sprite-mmap-cpu
[205.953540] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[206.048899] [026/144] (798s left) v3d/v3d_mmap (mmap-bad-flags)
[206.149932] Subtest mmap-bad-flags: SKIP (0.000s)
[206.201520] [027/144] (798s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[206.299773] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[211.585499] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.287s)
[211.702888] [028/144] (792s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-gen12-rc-ccs)
[212.118943] Starting subtest: pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs
[212.124341] Subtest pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[212.987296] [029/144] (791s left) gem_eio (in-flight-contexts-1us)
[213.288540] Starting subtest: in-flight-contexts-1us
[226.470624] Subtest in-flight-contexts-1us: SUCCESS (13.180s)
[226.593083] [030/144] (777s left) syncobj_timeline (invalid-transfer-non-existent-point)
[226.663226] Starting subtest: invalid-transfer-non-existent-point
[226.665700] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[226.745789] [031/144] (777s left) api_intel_bb (misplaced-blitter)
[226.802857] Starting subtest: misplaced-blitter
[226.816806] Subtest misplaced-blitter: SUCCESS (0.016s)
[226.907163] [032/144] (777s left) gen9_exec_parse (batch-zero-length)
[226.980067] Subtest batch-zero-length: SKIP (0.000s)
[227.029255] [033/144] (777s left) kms_prop_blob (basic)
[227.098250] Starting subtest: basic
[227.100270] Subtest basic: SUCCESS (0.000s)
[227.173284] [034/144] (777s left) gem_wait (busy)
[227.259190] Starting subtest: busy
[227.261691] Starting dynamic subtest: all-engines
[228.475597] Dynamic subtest all-engines: SUCCESS (1.215s)
[228.490313] Starting dynamic subtest: rcs0
[229.016129] Dynamic subtest rcs0: SUCCESS (0.540s)
[229.030960] Starting dynamic subtest: bcs0
[229.556600] Dynamic subtest bcs0: SUCCESS (0.540s)
[229.571498] Starting dynamic subtest: vcs0
[231.482886] Dynamic subtest vcs0: SUCCESS (1.925s)
[231.497279] Starting dynamic subtest: vcs1
[233.468477] Dynamic subtest vcs1: SUCCESS (1.984s)
[233.483624] Starting dynamic subtest: vecs0
[235.451259] Dynamic subtest vecs0: SUCCESS (1.983s)
[235.466652] Starting dynamic subtest: ccs0
[235.994712] Dynamic subtest ccs0: SUCCESS (0.541s)
[235.997364] Subtest busy: SUCCESS (8.733s)
[236.198871] [035/144] (768s left) gem_mmap (bad-offset)
[236.268128] Subtest bad-offset: SKIP (0.000s)
[236.316563] [036/144] (768s left) syncobj_wait (multi-wait-submitted)
[236.387894] Starting subtest: multi-wait-submitted
[236.495372] Subtest multi-wait-submitted: SUCCESS (0.108s)
[236.568577] [037/144] (768s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[237.009066] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs
[237.014818] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[237.875487] [038/144] (766s left) gem_ctx_engines (independent)
[237.943879] Starting subtest: independent
[237.946685] Starting dynamic subtest: rcs0
[238.119680] Dynamic subtest rcs0: SUCCESS (0.174s)
[238.134797] Starting dynamic subtest: bcs0
[238.333328] Dynamic subtest bcs0: SUCCESS (0.213s)
[238.347959] Starting dynamic subtest: vcs0
[238.602234] Dynamic subtest vcs0: SUCCESS (0.269s)
[238.609529] Starting dynamic subtest: vcs1
[238.894981] Dynamic subtest vcs1: SUCCESS (0.292s)
[238.902959] Starting dynamic subtest: vecs0
[239.187568] Dynamic subtest vecs0: SUCCESS (0.292s)
[239.196097] Starting dynamic subtest: ccs0
[239.604432] Dynamic subtest ccs0: SUCCESS (0.416s)
[239.619871] Starting dynamic subtest: all-engines
[240.939291] Dynamic subtest all-engines: SUCCESS (1.336s)
[240.941725] Subtest independent: SUCCESS (2.996s)
[241.629571] [039/144] (763s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-ccs)
[242.028705] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-ccs
[242.033644] Subtest pipe-A-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[242.936057] [040/144] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[243.045081] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[243.048890] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[243.131826] [041/144] (761s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[243.219534] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[243.222056] Starting dynamic subtest: pipe-A-default-mode
[243.510933] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[243.516450] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.288s)
[244.408633] [042/144] (760s left) gem_mmap_gtt (basic)
[244.494411] Subtest basic: SKIP (0.000s)
[244.546437] [043/144] (760s left) dmabuf_sync_file (import-basic)
[244.610583] Starting subtest: import-basic
[244.613233] Subtest import-basic: SUCCESS (0.003s)
[244.651413] [044/144] (760s left) gem_userptr_blits (readonly-pwrite-unsync)
[244.729930] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[244.840143] [045/144] (760s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[244.897333] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[244.949329] [046/144] (760s left) prime_mmap_kms (buffer-sharing)
[245.023744] Starting subtest: buffer-sharing
[245.491714] Subtest buffer-sharing: SUCCESS (0.469s)
[246.394132] [047/144] (758s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-rc-ccs)
[246.813100] Starting subtest: pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs
[246.820419] Subtest pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[247.672926] [048/144] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[247.767740] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[247.772305] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[247.847478] [049/144] (757s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[247.913652] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[247.915868] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[248.002557] [050/144] (757s left) kms_sequence (queue-idle)
[248.096214] Starting subtest: queue-idle
[248.098890] Starting dynamic subtest: pipe-A-eDP-1
[249.930891] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.832s)
[249.945870] Starting dynamic subtest: pipe-B-eDP-1
[252.538503] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.607s)
[252.553846] Starting dynamic subtest: pipe-C-eDP-1
[255.079143] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.536s)
[255.095086] Starting dynamic subtest: pipe-D-eDP-1
[257.642486] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.560s)
[257.645677] Subtest queue-idle: SUCCESS (9.545s)
[258.554860] [051/144] (746s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-gen12-mc-ccs)
[258.955748] Starting subtest: pipe-B-bad-aux-stride-y-tiled-gen12-mc-ccs
[258.961961] Subtest pipe-B-bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[259.832678] [052/144] (745s left) kms_pm_rpm (fences-dpms)
[261.595446] Starting subtest: fences-dpms
[261.601696] Subtest fences-dpms: SKIP (0.000s)
[262.187630] [053/144] (743s left) gem_exec_schedule (noreorder-priority)
[262.376679] Starting subtest: noreorder-priority
[262.379599] Starting dynamic subtest: rcs0
[263.512926] Dynamic subtest rcs0: SUCCESS (1.137s)
[263.528685] Starting dynamic subtest: vcs0
[265.455520] Dynamic subtest vcs0: SUCCESS (1.940s)
[265.477812] Starting dynamic subtest: vcs1
[267.441938] Dynamic subtest vcs1: SUCCESS (1.986s)
[267.457794] Starting dynamic subtest: vecs0
[269.410166] Dynamic subtest vecs0: SUCCESS (1.966s)
[269.426392] Starting dynamic subtest: ccs0
[270.552842] Dynamic subtest ccs0: SUCCESS (1.143s)
[270.555602] Subtest noreorder-priority: SUCCESS (8.178s)
[270.738479] [054/144] (734s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[270.836059] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[270.840459] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[270.922835] [055/144] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[271.011475] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[275.638369] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.632s)
[275.745309] [056/144] (729s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[275.823993] Subtest writes-after-reads-snoop: SKIP (0.000s)
[275.887881] [057/144] (729s left) syncobj_timeline (32bits-limit)
[275.970626] Starting subtest: 32bits-limit
[275.973138] Subtest 32bits-limit: SUCCESS (0.001s)
[276.057360] [058/144] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[276.146514] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[276.150375] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[276.222858] [059/144] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[276.328659] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[276.333054] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[276.410858] [060/144] (728s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-mc-ccs)
[276.847064] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs
[276.852335] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[277.663809] [061/144] (727s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[277.769613] Starting subtest: psr-rgb101010-draw-mmap-gtt
[277.774292] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[277.843514] [062/144] (727s left) kms_psr (psr2-cursor-mmap-gtt)
[277.909783] Starting subtest: psr2-cursor-mmap-gtt
[277.912591] Starting dynamic subtest: eDP-1
[279.710563] Dynamic subtest eDP-1: SUCCESS (1.800s)
[279.713217] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.801s)
[280.635274] [063/144] (724s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-ccs)
[281.013206] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-ccs
[281.018464] Subtest pipe-A-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[281.914329] [064/144] (723s left) kms_cursor_crc (cursor-random-32x10)
[282.082405] Starting subtest: cursor-random-32x10
[282.118071] Subtest cursor-random-32x10: SKIP (0.029s)
[282.413308] [065/144] (723s left) fbdev (nullptr)
[282.483996] Starting subtest: nullptr
[282.486400] Subtest nullptr: SUCCESS (0.000s)
[282.546807] [066/144] (723s left) gem_render_copy_redux (normal)
[282.612972] Starting subtest: normal
[283.020723] Subtest normal: SUCCESS (0.408s)
[283.114316] [067/144] (722s left) kms_chamelium_color (ctm-red-to-blue)
[283.216742] Subtest ctm-red-to-blue: SKIP (0.000s)
[283.242753] [068/144] (722s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[283.318693] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[283.322806] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[284.541891] [069/144] (721s left) kms_atomic_transition (modeset-transition-nonblocking)
[284.624890] Starting subtest: modeset-transition-nonblocking
[284.627439] Starting dynamic subtest: 1x-outputs
[296.796205] Dynamic subtest 1x-outputs: SUCCESS (12.172s)
[297.096456] Subtest modeset-transition-nonblocking: SUCCESS (12.471s)
[297.975556] [070/144] (707s left) kms_psr (fbc-psr-cursor-render)
[298.054392] Starting subtest: fbc-psr-cursor-render
[298.056798] Starting dynamic subtest: eDP-1
[298.061564] Dynamic subtest eDP-1: SKIP (0.000s)
[298.066322] Subtest fbc-psr-cursor-render: SKIP (0.002s)
[298.175928] [071/144] (707s left) v3d/v3d_submit_cl (valid-multisync-submission)
[298.262222] Subtest valid-multisync-submission: SKIP (0.000s)
[298.310452] [072/144] (707s left) gem_ctx_shared (q-smoketest-all)
[298.367363] Starting subtest: Q-smoketest-all
[330.784425] Subtest Q-smoketest-all: SUCCESS (32.364s)
[332.445335] [073/144] (673s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-ccs)
[332.841985] Starting subtest: pipe-B-crc-primary-basic-y-tiled-ccs
[332.848184] Subtest pipe-B-crc-primary-basic-y-tiled-ccs: SKIP (0.000s)
[333.759388] [074/144] (672s left) syncobj_timeline (etime-multi-wait-all-submitted)
[333.835768] Starting subtest: etime-multi-wait-all-submitted
[333.944105] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[334.015687] [075/144] (671s left) sysfs_defaults (readonly)
[334.100587] Starting subtest: readonly
[334.103943] Starting dynamic subtest: vecs0
[334.106778] Dynamic subtest vecs0: SUCCESS (0.001s)
[334.120892] Starting dynamic subtest: ccs0
[334.123438] Dynamic subtest ccs0: SUCCESS (0.001s)
[334.131927] Starting dynamic subtest: vcs0
[334.134419] Dynamic subtest vcs0: SUCCESS (0.001s)
[334.141454] Starting dynamic subtest: bcs0
[334.143702] Dynamic subtest bcs0: SUCCESS (0.001s)
[334.150160] Starting dynamic subtest: rcs0
[334.152334] Dynamic subtest rcs0: SUCCESS (0.000s)
[334.158166] Starting dynamic subtest: vcs1
[334.160334] Dynamic subtest vcs1: SUCCESS (0.000s)
[334.162537] Subtest readonly: SUCCESS (0.011s)
[334.178068] [076/144] (671s left) kms_feature_discovery (psr1)
[334.268166] Starting subtest: psr1
[334.270591] Subtest psr1: SUCCESS (0.000s)
[334.330930] [077/144] (671s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[334.408815] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[334.414743] Starting dynamic subtest: A-eDP1
[343.393995] Dynamic subtest A-eDP1: SUCCESS (8.982s)
[343.411228] Starting dynamic subtest: B-eDP1
[352.419471] Dynamic subtest B-eDP1: SUCCESS (9.024s)
[352.437634] Starting dynamic subtest: C-eDP1
[361.434769] Dynamic subtest C-eDP1: SUCCESS (9.010s)
[361.450759] Starting dynamic subtest: D-eDP1
[370.391480] Dynamic subtest D-eDP1: SUCCESS (8.958s)
[370.398843] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.990s)
[371.642961] [078/144] (634s left) kms_atomic_interruptible (legacy-setmode)
[371.734136] Starting subtest: legacy-setmode
[371.736454] Starting dynamic subtest: pipe-A-eDP-1
[378.630157] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.895s)
[378.632813] Subtest legacy-setmode: SUCCESS (6.897s)
[379.513408] [079/144] (626s left) gem_mmap_offset (bad-extensions)
[379.586978] Starting subtest: bad-extensions
[379.589776] Subtest bad-extensions: SUCCESS (0.000s)
[379.673066] [080/144] (626s left) prime_busy (before)
[379.741273] Starting subtest: before
[379.747687] Starting dynamic subtest: rcs0
[379.764354] Dynamic subtest rcs0: SUCCESS (0.020s)
[379.780882] Starting dynamic subtest: bcs0
[379.808209] Dynamic subtest bcs0: SUCCESS (0.043s)
[379.824382] Starting dynamic subtest: vcs0
[379.852910] Dynamic subtest vcs0: SUCCESS (0.043s)
[379.868976] Starting dynamic subtest: vcs1
[379.897603] Dynamic subtest vcs1: SUCCESS (0.043s)
[379.913491] Starting dynamic subtest: vecs0
[379.942593] Dynamic subtest vecs0: SUCCESS (0.044s)
[379.958585] Starting dynamic subtest: ccs0
[379.987225] Dynamic subtest ccs0: SUCCESS (0.044s)
[380.098247] Subtest before: SUCCESS (0.356s)
[380.169221] [081/144] (625s left) gem_ctx_persistence (hostile)
[380.262270] Starting subtest: hostile
[385.513268] Subtest hostile: SUCCESS (5.246s)
[385.611090] [082/144] (620s left) fbdev (write)
[385.658264] Starting subtest: write
[386.052361] Subtest write: SUCCESS (0.394s)
[386.104971] [083/144] (619s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers)
[386.212210] Starting subtest: plane-downscale-factor-0-25-with-modifiers
[386.215301] Starting dynamic subtest: pipe-A-eDP-1
[386.247979] Dynamic subtest pipe-A-eDP-1: SKIP (0.032s)
[386.258243] Starting dynamic subtest: pipe-B-eDP-1
[386.301593] Dynamic subtest pipe-B-eDP-1: SKIP (0.053s)
[386.309826] Starting dynamic subtest: pipe-C-eDP-1
[386.355125] Dynamic subtest pipe-C-eDP-1: SKIP (0.052s)
[386.363481] Starting dynamic subtest: pipe-D-eDP-1
[386.396245] Dynamic subtest pipe-D-eDP-1: SKIP (0.040s)
[386.399900] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.182s)
[386.485409] [084/144] (619s left) gem_ctx_param (non-root-set)
[386.561925] Starting subtest: non-root-set
[386.588911] Subtest non-root-set: SUCCESS (0.026s)
[386.665117] [085/144] (619s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[386.753527] Starting subtest: y-tiled-64bpp-rotate-90
[386.758270] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[386.834531] [086/144] (619s left) gem_partial_pwrite_pread (reads)
[386.910546] Subtest reads: SKIP (0.000s)
[386.959992] [087/144] (619s left) kms_chamelium_hpd (dp-hpd-fast)
[387.338962] Subtest dp-hpd-fast: SKIP (0.000s)
[388.187043] [088/144] (617s left) vc4/vc4_tiling (get-bad-handle)
[388.275774] Subtest get-bad-handle: SKIP (0.000s)
[388.328098] [089/144] (617s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[388.418402] Starting subtest: yf-tiled-16bpp-rotate-270
[388.423185] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[388.495535] [090/144] (617s left) kms_psr2_sf (fbc-overlay-plane-move-continuous-sf)
[393.788959] Starting subtest: fbc-overlay-plane-move-continuous-sf
[393.791684] Starting dynamic subtest: pipe-A-eDP-1
[394.627523] Dynamic subtest pipe-A-eDP-1: SKIP (0.834s)
[394.642854] Starting dynamic subtest: pipe-B-eDP-1
[395.852266] Dynamic subtest pipe-B-eDP-1: SKIP (1.222s)
[395.857072] Subtest fbc-overlay-plane-move-continuous-sf: SKIP (2.062s)
[397.118867] [091/144] (609s left) gem_pxp (create-valid-protected-context)
[399.773065] Subtest create-valid-protected-context: SKIP (0.000s)
[399.808137] [092/144] (606s left) gem_exec_balancer (invalid-balancer)
[399.895279] Starting subtest: invalid-balancer
[400.480269] Subtest invalid-balancer: SUCCESS (0.583s)
[400.748927] [093/144] (605s left) kms_cursor_edge_walk (64x64-top-bottom)
[400.869043] Starting subtest: 64x64-top-bottom
[400.871385] Starting dynamic subtest: pipe-A-eDP-1
[404.420366] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.550s)
[404.436433] Starting dynamic subtest: pipe-D-eDP-1
[407.657816] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.234s)
[407.660295] Subtest 64x64-top-bottom: SUCCESS (6.789s)
[408.571240] [094/144] (597s left) kms_psr (psr-cursor-plane-onoff)
[408.640304] Starting subtest: psr-cursor-plane-onoff
[408.642743] Starting dynamic subtest: eDP-1
[410.468238] Dynamic subtest eDP-1: SUCCESS (1.827s)
[410.471099] Subtest psr-cursor-plane-onoff: SUCCESS (1.828s)
[411.384608] [095/144] (594s left) v3d/v3d_wait_bo (bad-pad)
[411.480800] Subtest bad-pad: SKIP (0.000s)
[411.532942] [096/144] (594s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[411.632630] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[416.427856] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.799s)
[416.536484] [097/144] (589s left) kms_psr (fbc-psr-sprite-blt)
[416.648745] Starting subtest: fbc-psr-sprite-blt
[416.651341] Starting dynamic subtest: eDP-1
[416.656257] Dynamic subtest eDP-1: SKIP (0.000s)
[416.660220] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[416.764091] [098/144] (589s left) gem_exec_fence (basic-await)
[416.962054] Starting subtest: basic-await
[416.964647] Starting dynamic subtest: rcs0
[417.047738] Dynamic subtest rcs0: SUCCESS (0.086s)
[417.064120] Starting dynamic subtest: bcs0
[417.148151] Dynamic subtest bcs0: SUCCESS (0.099s)
[417.164233] Starting dynamic subtest: vcs0
[417.231507] Dynamic subtest vcs0: SUCCESS (0.082s)
[417.247240] Starting dynamic subtest: vcs1
[417.316211] Dynamic subtest vcs1: SUCCESS (0.083s)
[417.331638] Starting dynamic subtest: vecs0
[417.399593] Dynamic subtest vecs0: SUCCESS (0.082s)
[417.415525] Starting dynamic subtest: ccs0
[417.495665] Dynamic subtest ccs0: SUCCESS (0.095s)
[417.498532] Subtest basic-await: SUCCESS (0.536s)
[419.498426] [099/144] (587s left) gem_exec_schedule (submit-golden-slice)
[419.587338] Starting subtest: submit-golden-slice
[419.590042] Starting dynamic subtest: rcs0
[419.614039] Dynamic subtest rcs0: SUCCESS (0.038s)
[419.629426] Starting dynamic subtest: bcs0
[419.710804] Dynamic subtest bcs0: SUCCESS (0.096s)
[419.726584] Starting dynamic subtest: vcs0
[419.793367] Dynamic subtest vcs0: SUCCESS (0.082s)
[419.802049] Starting dynamic subtest: vcs1
[419.867594] Dynamic subtest vcs1: SUCCESS (0.073s)
[419.874446] Starting dynamic subtest: vecs0
[419.961864] Dynamic subtest vecs0: SUCCESS (0.093s)
[419.977335] Starting dynamic subtest: ccs0
[420.026063] Dynamic subtest ccs0: SUCCESS (0.063s)
[420.029293] Subtest submit-golden-slice: SUCCESS (0.451s)
[421.511100] [100/144] (585s left) gem_exec_schedule (u-semaphore-noskip)
[421.609943] Starting subtest: u-semaphore-noskip
[422.148438] Subtest u-semaphore-noskip: SUCCESS (0.540s)
[422.492549] [101/144] (584s left) api_intel_bb (bb-with-allocator)
[422.576550] Starting subtest: bb-with-allocator
[422.594924] Subtest bb-with-allocator: SUCCESS (0.020s)
[422.701586] [102/144] (583s left) gem_ctx_persistence (engines-mixed)
[422.776202] Starting subtest: engines-mixed
[422.778954] Starting dynamic subtest: rcs0
[422.859596] Dynamic subtest rcs0: SUCCESS (0.084s)
[422.876641] Starting dynamic subtest: bcs0
[422.917775] Dynamic subtest bcs0: SUCCESS (0.057s)
[422.935347] Starting dynamic subtest: vcs0
[422.973700] Dynamic subtest vcs0: SUCCESS (0.054s)
[422.989862] Starting dynamic subtest: vcs1
[423.024978] Dynamic subtest vcs1: SUCCESS (0.050s)
[423.041155] Starting dynamic subtest: vecs0
[423.083141] Dynamic subtest vecs0: SUCCESS (0.057s)
[423.098805] Starting dynamic subtest: ccs0
[423.139070] Dynamic subtest ccs0: SUCCESS (0.055s)
[423.141972] Subtest engines-mixed: SUCCESS (0.363s)
[423.215872] [103/144] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[423.336967] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[423.341921] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[423.422397] [104/144] (583s left) kms_addfb_basic (basic-x-tiled-legacy)
[423.505997] Starting subtest: basic-x-tiled-legacy
[423.509943] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[423.606195] [105/144] (583s left) kms_legacy_colorkey (basic)
[423.692468] Starting subtest: basic
[423.694706] Starting dynamic subtest: pipe-A
[423.737343] Dynamic subtest pipe-A: SUCCESS (0.045s)
[423.753186] Starting dynamic subtest: pipe-B
[423.755452] Dynamic subtest pipe-B: SUCCESS (0.001s)
[423.766762] Starting dynamic subtest: pipe-C
[423.769290] Dynamic subtest pipe-C: SUCCESS (0.001s)
[423.778291] Starting dynamic subtest: pipe-D
[423.780718] Dynamic subtest pipe-D: SUCCESS (0.001s)
[423.783215] Subtest basic: SUCCESS (0.052s)
[423.801143] [106/144] (582s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[424.209344] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[424.214891] Subtest pipe-C-crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[425.056841] [107/144] (581s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[425.174736] Starting subtest: cursorA-vs-flipA-atomic-transitions
[436.390251] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.212s)
[437.273806] [108/144] (569s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[437.395558] Starting subtest: flip-vs-cursor-busy-crc-atomic
[438.329953] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.933s)
[439.227621] [109/144] (567s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[439.317417] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[443.895773] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.580s)
[444.005774] [110/144] (562s left) kms_vrr (flip-basic-fastset)
[444.105879] Starting subtest: flip-basic-fastset
[444.110663] Subtest flip-basic-fastset: SKIP (0.000s)
[444.173904] [111/144] (562s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[444.607846] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs
[444.613304] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[445.450811] [112/144] (561s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[445.515668] Starting subtest: invalid-multi-wait-unsubmitted
[445.518280] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[445.593579] [113/144] (561s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[445.687205] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[445.691074] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[445.773392] [114/144] (561s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[445.872268] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[445.877377] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[445.947645] [115/144] (561s left) gem_exec_fair (basic-pace-share)
[446.057586] Subtest basic-pace-share: SKIP (0.000s)
[446.112285] [116/144] (560s left) gem_exec_params (invalid-flag)
[446.184233] Starting subtest: invalid-flag
[446.187308] Subtest invalid-flag: SUCCESS (0.000s)
[446.279187] [117/144] (560s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[446.667846] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[446.673085] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.001s)
[447.546346] [118/144] (559s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[447.606637] Starting subtest: multi-wait-all-for-submit-submitted
[447.711462] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[447.784470] [119/144] (559s left) syncobj_timeline (reset-multiple-signaled)
[447.846046] Starting subtest: reset-multiple-signaled
[447.848767] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[447.921417] [120/144] (559s left) kms_addfb_basic (unused-handle)
[447.979688] Starting subtest: unused-handle
[447.982246] Subtest unused-handle: SUCCESS (0.000s)
[448.068438] [121/144] (559s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[448.449599] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[449.309375] [122/144] (557s left) gem_tiled_partial_pwrite_pread (reads)
[449.403053] Subtest reads: SKIP (0.000s)
[449.469986] [123/144] (557s left) kms_addfb_basic (size-max)
[449.567023] Starting subtest: size-max
[449.569493] Subtest size-max: SUCCESS (0.000s)
[449.648440] [124/144] (557s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[449.711228] Starting subtest: wait-all-for-submit-delayed-submit
[449.812293] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[449.885397] [125/144] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[449.978313] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[455.201175] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.231s)
[455.306494] [126/144] (551s left) vc4/vc4_label_bo (set-label)
[455.367151] Subtest set-label: SKIP (0.000s)
[455.405127] [127/144] (551s left) gem_caching (read-writes)
[455.469644] Subtest read-writes: SKIP (0.000s)
[455.507220] [128/144] (551s left) gem_mmap_gtt (basic-small-bo-tiledx)
[455.557513] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[455.596427] [129/144] (551s left) gem_exec_params (batch-first)
[455.657941] Starting subtest: batch-first
[455.670690] Subtest batch-first: SUCCESS (0.013s)
[455.766842] [130/144] (551s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[455.864937] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[455.895127] [131/144] (551s left) kms_content_protection (lic-type-0)
[456.027920] Starting subtest: lic-type-0
[459.535266] Subtest lic-type-0: SKIP (3.503s)
[460.797061] [132/144] (546s left) syncobj_wait (single-wait-all-for-submit-submitted)
[460.863579] Starting subtest: single-wait-all-for-submit-submitted
[460.968164] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[461.041749] [133/144] (546s left) i915_pm_rpm (reg-read-ioctl)
[462.579066] Starting subtest: reg-read-ioctl
[470.260426] Subtest reg-read-ioctl: SUCCESS (7.681s)
[471.071485] [134/144] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[471.171928] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[475.984616] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.813s)
[476.120216] [135/144] (531s left) kms_plane_alpha_blend (constant-alpha-mid)
[476.208805] Starting subtest: constant-alpha-mid
[476.499310] Starting dynamic subtest: pipe-A-eDP-1
[477.516752] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.015s)
[477.533360] Starting dynamic subtest: pipe-D-eDP-1
[479.233825] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.715s)
[479.236165] Subtest constant-alpha-mid: SUCCESS (3.025s)
[480.121948] [136/144] (527s left) kms_ccs (pipe-b-missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[480.515975] Starting subtest: pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs
[480.519110] Subtest pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[481.403690] [137/144] (526s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[481.527348] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[482.362865] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.836s)
[482.500330] [138/144] (525s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[482.904157] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs
[482.907307] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[483.773779] [139/144] (523s left) gem_mmap_wc (close)
[483.849773] Subtest close: SKIP (0.000s)
[483.902107] [140/144] (523s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[483.994687] Starting subtest: fb-8bpc-vs-panel-6bpc
[483.997043] Starting dynamic subtest: pipe-A-eDP-1
[485.425087] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.430s)
[485.428233] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.431s)
[486.322992] [141/144] (521s left) kms_atomic_transition (plane-all-modeset-transition)
[486.432670] Starting subtest: plane-all-modeset-transition
[486.436654] Subtest plane-all-modeset-transition: SKIP (0.000s)
[486.496333] [142/144] (521s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[486.923452] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[488.712714] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (1.786s)
[489.915591] [143/144] (517s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[490.010993] Starting subtest: x-tiled-16bpp-rotate-0
[491.512307] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.502s)
[491.637167] [144/144] (516s left) kms_pm_backlight (fade)
[491.734716] Starting subtest: fade
[491.794129] Starting dynamic subtest: eDP-1
[494.465488] Dynamic subtest eDP-1: SUCCESS (2.670s)
[494.468332] Subtest fade: SUCCESS (2.732s)
[495.351160] Closing watchdogs
Done.