[39.645058] Initializing watchdogs
[39.645127]   /dev/watchdog0
[39.652502] [001/142] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[39.787449] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[41.053374] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.257s)
[41.188297] [002/142] (958s left) gem_exec_reloc (basic-wc-noreloc)
[41.239945] Subtest basic-wc-noreloc: SKIP (0.000s)
[41.265814] [003/142] (958s left) perf (enable-disable)
[41.580667] Starting subtest: enable-disable
[41.581431] Starting dynamic subtest: 0-rcs0
[42.236952] Dynamic subtest 0-rcs0: FAIL (0.613s)
[42.237649] Subtest enable-disable: FAIL (0.613s)
[42.404226] [004/142] (957s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[42.488262] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[42.489267] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[42.573409] [005/142] (957s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[42.824751] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[42.826611] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[43.050937] [006/142] (957s left) gem_lmem_swapping (heavy-verify-random-ccs)
[45.553505] Starting subtest: heavy-verify-random-ccs
[45.554349] Starting dynamic subtest: lmem0
[61.148894] Dynamic subtest lmem0: SUCCESS (15.587s)
[61.149867] Subtest heavy-verify-random-ccs: SUCCESS (15.587s)
[62.855584] [007/142] (937s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[62.910142] Subtest bad-multisync-out-sync: SKIP (0.000s)
[62.917967] [008/142] (937s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[63.827969] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[74.820652] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SUCCESS (10.992s)
[75.163066] [009/142] (925s left) kms_vblank (pipe-d-query-forked)
[75.284753] Starting subtest: pipe-D-query-forked
[77.756772] Subtest pipe-D-query-forked: SUCCESS (2.471s)
[77.951481] [010/142] (922s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[78.121269] Starting subtest: fbcpsr-tiling-linear
[78.122842] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[78.211426] [011/142] (922s left) gem_exec_reloc (basic-write-wc-noreloc)
[78.300319] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[78.330152] [012/142] (922s left) kms_vblank (pipe-c-ts-continuation-suspend)
[78.465676] Starting subtest: pipe-C-ts-continuation-suspend
[97.831088] Subtest pipe-C-ts-continuation-suspend: SUCCESS (4.153s)
[97.984621] [013/142] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[98.115629] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[98.117306] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[98.209410] [014/142] (917s left) i915_query (query-topology-garbage-items)
[98.286424] Starting subtest: query-topology-garbage-items
[98.287478] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[98.391868] [015/142] (917s left) gem_exec_schedule (u-semaphore-codependency)
[98.489745] Starting subtest: u-semaphore-codependency
[98.522429] Subtest u-semaphore-codependency: SUCCESS (0.033s)
[98.893176] [016/142] (916s left) syncobj_timeline (single-wait-available-signaled)
[98.983068] Starting subtest: single-wait-available-signaled
[98.984152] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[99.058527] [017/142] (916s left) kms_rotation_crc (exhaust-fences)
[99.171502] Starting subtest: exhaust-fences
[99.173351] Subtest exhaust-fences: SKIP (0.000s)
[99.236076] [018/142] (916s left) kms_cursor_edge_walk (64x64-left-edge)
[99.363481] Starting subtest: 64x64-left-edge
[99.364413] Starting dynamic subtest: pipe-A-DP-4
[102.803211] Dynamic subtest pipe-A-DP-4: SUCCESS (3.438s)
[102.812177] Starting dynamic subtest: pipe-D-DP-4
[106.113864] Dynamic subtest pipe-D-DP-4: SUCCESS (3.309s)
[106.114804] Subtest 64x64-left-edge: SUCCESS (6.750s)
[106.341966] [019/142] (909s left) gem_pxp (create-valid-protected-context)
[108.998857] Subtest create-valid-protected-context: SKIP (0.000s)
[109.052181] [020/142] (906s left) kms_flip (bo-too-big-interruptible)
[109.156764] Starting subtest: bo-too-big-interruptible
[109.162759] Starting dynamic subtest: A-DP4
[109.460744] Dynamic subtest A-DP4: SUCCESS (0.297s)
[109.490190] Starting dynamic subtest: B-DP4
[109.711776] Dynamic subtest B-DP4: SUCCESS (0.249s)
[109.737907] Starting dynamic subtest: C-DP4
[109.942854] Dynamic subtest C-DP4: SUCCESS (0.230s)
[109.971611] Starting dynamic subtest: D-DP4
[110.213021] Dynamic subtest D-DP4: SUCCESS (0.269s)
[110.216132] Subtest bo-too-big-interruptible: SUCCESS (1.058s)
[110.540875] [021/142] (905s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[110.695947] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[112.567626] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (1.872s)
[112.769359] [022/142] (903s left) i915_hangman (error-state-basic)
[112.834763] Starting subtest: error-state-basic
[113.100461] Subtest error-state-basic: SUCCESS (0.266s)
[113.176456] [023/142] (902s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[113.299555] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[113.300438] Starting dynamic subtest: pipe-A-valid-mode
[117.803846] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.504s)
[117.804772] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (4.505s)
[118.022909] [024/142] (897s left) perf_pmu (init-wait)
[118.104761] Starting subtest: init-wait
[118.105584] Starting dynamic subtest: rcs0
[118.106524] Dynamic subtest rcs0: SUCCESS (0.001s)
[118.113681] Starting dynamic subtest: bcs0
[118.114580] Dynamic subtest bcs0: SUCCESS (0.000s)
[118.121335] Starting dynamic subtest: vcs0
[118.122125] Dynamic subtest vcs0: SUCCESS (0.000s)
[118.129206] Starting dynamic subtest: vcs1
[118.129993] Dynamic subtest vcs1: SUCCESS (0.000s)
[118.137023] Starting dynamic subtest: vecs0
[118.137855] Dynamic subtest vecs0: SUCCESS (0.000s)
[118.144573] Starting dynamic subtest: vecs1
[118.145370] Dynamic subtest vecs1: SUCCESS (0.000s)
[118.155282] Starting dynamic subtest: ccs0
[118.156070] Dynamic subtest ccs0: SUCCESS (0.000s)
[118.162830] Starting dynamic subtest: ccs1
[118.163634] Dynamic subtest ccs1: SUCCESS (0.000s)
[118.170682] Starting dynamic subtest: ccs2
[118.171710] Dynamic subtest ccs2: SUCCESS (0.000s)
[118.178649] Starting dynamic subtest: ccs3
[118.179672] Dynamic subtest ccs3: SUCCESS (0.000s)
[118.180780] Subtest init-wait: SUCCESS (0.006s)
[118.193433] [025/142] (897s left) gem_exec_whisper (basic-fds)
[118.244655] Starting subtest: basic-fds
[129.449922] Subtest basic-fds: SUCCESS (11.194s)
[129.618069] [026/142] (886s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[129.706148] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[129.809912] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[129.898259] [027/142] (886s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[130.049882] Starting subtest: psr-rgb101010-draw-mmap-wc
[130.051556] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[130.117902] [028/142] (885s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_mc_ccs)
[130.344475] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs
[130.346574] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs: SUCCESS (0.002s)
[130.555025] [029/142] (885s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[130.704045] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[131.933306] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.220s)
[132.050483] [030/142] (884s left) perf_pmu (busy-accuracy-2)
[132.099870] Starting subtest: busy-accuracy-2
[132.100820] Starting dynamic subtest: rcs0
[135.162876] Dynamic subtest rcs0: SUCCESS (3.062s)
[135.171039] Starting dynamic subtest: bcs0
[138.222136] Dynamic subtest bcs0: SUCCESS (3.059s)
[138.230286] Starting dynamic subtest: vcs0
[141.278893] Dynamic subtest vcs0: SUCCESS (3.056s)
[141.286778] Starting dynamic subtest: vcs1
[144.339666] Dynamic subtest vcs1: SUCCESS (3.060s)
[144.347641] Starting dynamic subtest: vecs0
[147.394019] Dynamic subtest vecs0: SUCCESS (3.054s)
[147.402057] Starting dynamic subtest: vecs1
[150.454620] Dynamic subtest vecs1: SUCCESS (3.061s)
[150.462566] Starting dynamic subtest: ccs0
[153.510770] Dynamic subtest ccs0: SUCCESS (3.054s)
[153.518897] Starting dynamic subtest: ccs1
[156.568664] Dynamic subtest ccs1: SUCCESS (3.059s)
[156.576747] Starting dynamic subtest: ccs2
[159.625329] Dynamic subtest ccs2: SUCCESS (3.054s)
[159.633541] Starting dynamic subtest: ccs3
[162.681131] Dynamic subtest ccs3: SUCCESS (3.057s)
[162.682270] Subtest busy-accuracy-2: SUCCESS (30.580s)
[162.779282] [031/142] (853s left) gem_ctx_sseu (invalid-args)
[162.830258] Subtest invalid-args: SKIP (0.000s)
[162.850480] [032/142] (853s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[162.925690] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[162.985604] [033/142] (853s left) kms_rotation_crc (multiplane-rotation)
[163.126526] Starting subtest: multiplane-rotation
[174.329771] Subtest multiplane-rotation: SUCCESS (11.203s)
[174.487911] [034/142] (841s left) kms_prime (d3hot)
[175.273829] Subtest D3hot: SKIP (0.000s)
[175.362314] [035/142] (840s left) kms_big_joiner (2x-modeset)
[175.480883] Subtest 2x-modeset: SKIP (0.000s)
[175.501351] [036/142] (840s left) kms_writeback (writeback-check-output)
[175.690899] Subtest writeback-check-output: SKIP (0.000s)
[175.718612] [037/142] (840s left) kms_setmode (invalid-clone-single-crtc)
[175.764868] Starting subtest: invalid-clone-single-crtc
[175.767450] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[175.834685] [038/142] (840s left) kms_color (ctm-blue-to-red)
[175.975802] Starting subtest: ctm-blue-to-red
[175.976731] Starting dynamic subtest: pipe-A
[176.605949] Dynamic subtest pipe-A: SUCCESS (0.629s)
[176.627378] Starting dynamic subtest: pipe-B
[177.197008] Dynamic subtest pipe-B: SUCCESS (0.589s)
[177.211002] Starting dynamic subtest: pipe-C
[177.769196] Dynamic subtest pipe-C: SUCCESS (0.571s)
[177.781974] Starting dynamic subtest: pipe-D
[178.338488] Dynamic subtest pipe-D: SUCCESS (0.570s)
[178.339585] Subtest ctm-blue-to-red: SUCCESS (2.363s)
[178.553207] [039/142] (837s left) gen3_render_linear_blits
[178.641194] [040/142] (837s left) gem_exec_balancer (semaphore)
[178.696814] Starting subtest: semaphore
[179.627483] Subtest semaphore: SUCCESS (0.931s)
[179.937314] [041/142] (836s left) gem_tiling_max_stride
[180.058345] [042/142] (836s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[180.180520] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[180.182239] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[180.251290] [043/142] (836s left) gem_userptr_blits (create-destroy-unsync)
[180.306130] Subtest create-destroy-unsync: SKIP (0.000s)
[180.462699] [044/142] (835s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[180.601701] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[181.182979] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.581s)
[181.338150] [045/142] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[181.468065] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[181.469624] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[181.558012] [046/142] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[181.698906] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[181.700710] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[181.792019] [047/142] (834s left) fbdev (write)
[181.883089] Starting subtest: write
[183.334421] Subtest write: SUCCESS (1.443s)
[183.384597] [048/142] (833s left) gem_exec_balancer (noheartbeat)
[183.645773] Starting subtest: noheartbeat
[183.647558] Subtest noheartbeat: SKIP (0.000s)
[183.701816] [049/142] (832s left) kms_cursor_legacy (torture-move)
[183.825045] Starting subtest: torture-move
[183.825891] Starting dynamic subtest: pipe-A
[189.442946] Dynamic subtest pipe-A: SUCCESS (5.585s)
[190.790268] Starting dynamic subtest: pipe-B
[194.888651] Dynamic subtest pipe-B: SUCCESS (5.445s)
[194.900315] Starting dynamic subtest: pipe-C
[200.312222] Dynamic subtest pipe-C: SUCCESS (5.454s)
[200.320354] Starting dynamic subtest: pipe-D
[205.780487] Dynamic subtest pipe-D: SUCCESS (5.442s)
[205.796241] Starting dynamic subtest: all-pipes
[211.203878] Dynamic subtest all-pipes: SUCCESS (5.450s)
[211.204729] Subtest torture-move: SUCCESS (27.379s)
[211.273666] [050/142] (805s left) i915_pm_rps (thresholds-idle-park)
[211.404481] Starting subtest: thresholds-idle-park
[211.405479] Starting dynamic subtest: gt0
[211.427900] Dynamic subtest gt0: SKIP (0.022s)
[211.429770] Subtest thresholds-idle-park: SKIP (0.023s)
[211.527930] [051/142] (805s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[211.685975] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[211.687641] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[211.775552] [052/142] (804s left) kms_frontbuffer_tracking (fbc-badstride)
[211.926129] Starting subtest: fbc-badstride
[220.066127] Subtest fbc-badstride: SUCCESS (8.142s)
[220.153510] [053/142] (796s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[221.803892] Starting subtest: gem-execbuf-stress-pc8
[221.915455] Subtest gem-execbuf-stress-pc8: SKIP (0.112s)
[222.164524] [054/142] (794s left) gem_ctx_param (set-priority-not-supported)
[222.239828] Starting subtest: set-priority-not-supported
[222.242142] Subtest set-priority-not-supported: SKIP (0.000s)
[222.329956] [055/142] (794s left) syncobj_wait (invalid-reset-zero-handles)
[222.403569] Starting subtest: invalid-reset-zero-handles
[222.404626] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[222.474429] [056/142] (794s left) gem_create (hog-create)
[222.525552] Starting subtest: hog-create
[222.526392] Starting dynamic subtest: lmem0
[254.795292] Dynamic subtest lmem0: SUCCESS (32.269s)
[254.804048] Starting dynamic subtest: smem0
[287.076970] Dynamic subtest smem0: SUCCESS (32.280s)
[287.078666] Subtest hog-create: SUCCESS (64.552s)
[287.292826] [057/142] (729s left) i915_pm_freq_api (freq-basic-api)
[287.343139] Starting subtest: freq-basic-api
[287.344011] Starting dynamic subtest: gt0
[287.346030] Dynamic subtest gt0: SUCCESS (0.003s)
[287.347103] Subtest freq-basic-api: SUCCESS (0.003s)
[287.417990] [058/142] (729s left) kms_content_protection (type1)
[287.609279] Starting subtest: type1
[288.202945] Subtest type1: SKIP (0.591s)
[288.530714] [059/142] (728s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_mc_ccs)
[288.768614] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs
[288.770446] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[289.002750] [060/142] (727s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[289.223504] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[289.656252] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SUCCESS (0.432s)
[290.050927] [061/142] (726s left) vgem_basic (bad-pad)
[290.117665] Starting subtest: bad-pad
[290.118488] Subtest bad-pad: SUCCESS (0.000s)
[290.171326] [062/142] (726s left) kms_universal_plane (universal-plane-pipe-a-sanity)
[290.301337] Starting subtest: universal-plane-pipe-A-sanity
[290.859933] Subtest universal-plane-pipe-A-sanity: SUCCESS (0.558s)
[291.090619] [063/142] (725s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[291.243905] Starting subtest: x-tiled-8bpp-rotate-180
[292.703624] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.451s)
[292.829056] [064/142] (724s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[293.125022] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[293.128053] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.002s)
[293.288363] [065/142] (723s left) kms_ccs (pipe-c-bad-pixel-format-yf_tiled_ccs)
[293.551139] Starting subtest: pipe-C-bad-pixel-format-yf_tiled_ccs
[293.552771] Subtest pipe-C-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[293.773784] [066/142] (723s left) kms_getfb (getfb2-accept-ccs)
[293.837091] Starting subtest: getfb2-accept-ccs
[293.838047] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[293.925478] [067/142] (723s left) syncobj_wait (single-wait-for-submit-signaled)
[293.999297] Starting subtest: single-wait-for-submit-signaled
[294.000131] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[294.062731] [068/142] (723s left) gem_ctx_persistence (legacy-engines-mixed)
[294.116305] Starting subtest: legacy-engines-mixed
[294.117268] Starting dynamic subtest: render
[294.183299] Dynamic subtest render: SUCCESS (0.066s)
[294.192139] Starting dynamic subtest: bsd1
[294.220508] Dynamic subtest bsd1: SUCCESS (0.036s)
[294.233864] Starting dynamic subtest: bsd2
[294.265525] Dynamic subtest bsd2: SUCCESS (0.044s)
[294.276759] Starting dynamic subtest: blt
[294.288487] Dynamic subtest blt: SUCCESS (0.021s)
[294.297051] Starting dynamic subtest: vebox
[294.347787] Dynamic subtest vebox: SUCCESS (0.058s)
[294.348985] Subtest legacy-engines-mixed: SUCCESS (0.232s)
[294.492271] [069/142] (722s left) gem_mmap_wc (bad-object)
[294.552020] Subtest bad-object: SKIP (0.000s)
[294.587029] [070/142] (722s left) prime_vgem (basic-write)
[294.648986] Starting subtest: basic-write
[294.656161] Subtest basic-write: SKIP (0.006s)
[294.773984] [071/142] (722s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[295.040086] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[296.365837] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SUCCESS (1.325s)
[296.736765] [072/142] (720s left) device_reset (cold-reset-bound)
[296.811161] Subtest cold-reset-bound: SKIP (0.000s)
[296.875717] [073/142] (720s left) gem_spin_batch (spin-each)
[296.934492] Starting subtest: spin-each
[300.353732] Subtest spin-each: SUCCESS (3.419s)
[300.638384] [074/142] (716s left) kms_flip (2x-flip-vs-modeset)
[300.762542] Starting subtest: 2x-flip-vs-modeset
[300.778386] Subtest 2x-flip-vs-modeset: SKIP (0.015s)
[300.841463] [075/142] (716s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[300.946557] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[300.964819] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.018s)
[301.045470] [076/142] (716s left) dmabuf_sync_file (import-multiple-read-only)
[301.122105] Starting subtest: import-multiple-read-only
[301.124351] Subtest import-multiple-read-only: SUCCESS (0.003s)
[301.176251] [077/142] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[301.314240] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[301.315954] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[301.396584] [078/142] (716s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[301.687879] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[301.689786] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[301.863225] [079/142] (715s left) gem_exec_fence (syncobj-timeline-unused-fence)
[302.798053] Starting subtest: syncobj-timeline-unused-fence
[302.809245] Subtest syncobj-timeline-unused-fence: SUCCESS (0.020s)
[303.092297] [080/142] (714s left) kms_chamelium_edid (dp-edid-resolution-list)
[303.291110] Subtest dp-edid-resolution-list: SKIP (0.000s)
[303.435131] [081/142] (714s left) kms_flip (2x-flip-vs-panning-interruptible)
[303.555356] Starting subtest: 2x-flip-vs-panning-interruptible
[303.571664] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.015s)
[303.649311] [082/142] (713s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[303.786928] Starting subtest: y-tiled-32bpp-rotate-90
[303.788629] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[303.866537] [083/142] (713s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[304.005088] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[304.005907] Starting dynamic subtest: pipe-A-DP-4
[304.020054] Dynamic subtest pipe-A-DP-4: SKIP (0.013s)
[304.028972] Starting dynamic subtest: pipe-B-DP-4
[304.046333] Dynamic subtest pipe-B-DP-4: SKIP (0.025s)
[304.055008] Starting dynamic subtest: pipe-C-DP-4
[304.073866] Dynamic subtest pipe-C-DP-4: SKIP (0.026s)
[304.082511] Starting dynamic subtest: pipe-D-DP-4
[304.098845] Dynamic subtest pipe-D-DP-4: SKIP (0.024s)
[304.100438] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.094s)
[304.175800] [084/142] (713s left) gem_exec_flush (basic-batch-kernel-default-uc)
[304.226226] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[304.268208] [085/142] (713s left) kms_addfb_basic (bad-pitch-1024)
[304.313903] Starting subtest: bad-pitch-1024
[304.314833] Subtest bad-pitch-1024: SUCCESS (0.000s)
[304.465576] [086/142] (713s left) gem_exec_schedule (preempt-queue-chain)
[304.551337] Subtest preempt-queue-chain: SKIP (0.000s)
[304.868412] [087/142] (712s left) gem_tiled_pread_basic
[304.935394] [088/142] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[305.063184] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[305.065151] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[305.150917] [089/142] (712s left) gem_exec_create (forked)
[305.223595] Starting subtest: forked
[305.224506] Starting dynamic subtest: smem
[325.350112] Dynamic subtest smem: SUCCESS (20.126s)
[325.361441] Starting dynamic subtest: lmem0
[345.494157] Dynamic subtest lmem0: SUCCESS (20.143s)
[345.495185] Subtest forked: SUCCESS (40.271s)
[345.719231] [090/142] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[345.864241] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[345.865828] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[345.953686] [091/142] (671s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[346.117073] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[346.119022] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[346.446379] [092/142] (671s left) gem_ringfill (engines-basic)
[346.897426] Starting subtest: engines-basic
[346.899275] Starting dynamic subtest: rcs0
[346.978748] Dynamic subtest rcs0: SUCCESS (0.081s)
[346.988327] Starting dynamic subtest: bcs0
[347.018775] Dynamic subtest bcs0: SUCCESS (0.039s)
[347.034054] Starting dynamic subtest: vcs0
[347.061155] Dynamic subtest vcs0: SUCCESS (0.041s)
[347.088197] Starting dynamic subtest: vcs1
[347.107968] Dynamic subtest vcs1: SUCCESS (0.045s)
[347.127389] Starting dynamic subtest: vecs0
[347.151252] Dynamic subtest vecs0: SUCCESS (0.042s)
[347.170652] Starting dynamic subtest: vecs1
[347.194225] Dynamic subtest vecs1: SUCCESS (0.042s)
[347.213937] Starting dynamic subtest: ccs0
[347.237234] Dynamic subtest ccs0: SUCCESS (0.042s)
[347.258816] Starting dynamic subtest: ccs1
[347.280153] Dynamic subtest ccs1: SUCCESS (0.041s)
[347.299825] Starting dynamic subtest: ccs2
[347.324114] Dynamic subtest ccs2: SUCCESS (0.043s)
[347.343936] Starting dynamic subtest: ccs3
[347.367059] Dynamic subtest ccs3: SUCCESS (0.042s)
[347.368472] Subtest engines-basic: SUCCESS (0.471s)
[347.487871] [093/142] (670s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[347.611248] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[347.612863] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[347.690512] [094/142] (670s left) kms_legacy_colorkey (invalid-plane)
[347.813993] Starting subtest: invalid-plane
[347.814923] Starting dynamic subtest: zero-id
[347.815833] Dynamic subtest zero-id: SUCCESS (0.000s)
[347.824368] Starting dynamic subtest: outrange-id
[347.825132] Dynamic subtest outrange-id: SUCCESS (0.000s)
[347.825923] Subtest invalid-plane: SUCCESS (0.001s)
[347.884929] [095/142] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[348.011171] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[348.012860] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[348.089476] [096/142] (669s left) kms_vblank (pipe-b-wait-busy-hang)
[348.225136] Starting subtest: pipe-B-wait-busy-hang
[362.262044] Subtest pipe-B-wait-busy-hang: SUCCESS (14.038s)
[362.506639] [097/142] (655s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[362.648934] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[365.300304] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.653s)
[365.478265] [098/142] (652s left) kms_flip (flip-vs-rmfb-interruptible)
[365.593350] Starting subtest: flip-vs-rmfb-interruptible
[365.600324] Starting dynamic subtest: A-DP4
[373.413464] Dynamic subtest A-DP4: SUCCESS (7.812s)
[373.451060] Starting dynamic subtest: B-DP4
[381.162726] Dynamic subtest B-DP4: SUCCESS (7.745s)
[381.199912] Starting dynamic subtest: C-DP4
[388.913841] Dynamic subtest C-DP4: SUCCESS (7.747s)
[388.954017] Starting dynamic subtest: D-DP4
[396.666816] Dynamic subtest D-DP4: SUCCESS (7.749s)
[396.670987] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.076s)
[396.988287] [099/142] (621s left) kms_plane_scaling (plane-scaler-with-pixel-format-unity-scaling)
[397.131293] Starting subtest: plane-scaler-with-pixel-format-unity-scaling
[397.132381] Starting dynamic subtest: pipe-A-DP-4
[434.156240] Dynamic subtest pipe-A-DP-4: SUCCESS (37.024s)
[434.166701] Starting dynamic subtest: pipe-B-DP-4
[470.430926] Dynamic subtest pipe-B-DP-4: SUCCESS (36.273s)
[470.441304] Starting dynamic subtest: pipe-C-DP-4
[470.786311] Dynamic subtest pipe-C-DP-4: SUCCESS (0.354s)
[470.799416] Starting dynamic subtest: pipe-D-DP-4
[471.160512] Dynamic subtest pipe-D-DP-4: SUCCESS (0.372s)
[471.161649] Subtest plane-scaler-with-pixel-format-unity-scaling: SUCCESS (74.031s)
[471.496873] [100/142] (546s left) syncobj_basic (bad-fd-to-handle)
[471.565324] Starting subtest: bad-fd-to-handle
[471.566211] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[471.637344] [101/142] (546s left) kms_vblank (pipe-a-wait-busy)
[471.767019] Starting subtest: pipe-A-wait-busy
[474.225454] Subtest pipe-A-wait-busy: SUCCESS (2.460s)
[474.456622] [102/142] (543s left) kms_lease (implicit-plane-lease)
[474.597376] Starting subtest: implicit-plane-lease
[474.598402] Subtest implicit-plane-lease: SUCCESS (0.002s)
[474.657119] [103/142] (543s left) v3d/v3d_mmap (mmap-bad-flags)
[474.722766] Subtest mmap-bad-flags: SKIP (0.000s)
[474.778467] [104/142] (543s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[474.908184] Starting subtest: 2x-long-flip-vs-cursor-legacy
[474.910065] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[474.975736] [105/142] (543s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[475.102245] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[475.103848] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[475.179174] [106/142] (543s left) sysfs_timeslice_duration (invalid)
[475.245653] Starting subtest: invalid
[475.246641] Starting dynamic subtest: ccs2
[475.247661] Dynamic subtest ccs2: SUCCESS (0.000s)
[475.258602] Starting dynamic subtest: vecs0
[475.259549] Dynamic subtest vecs0: SUCCESS (0.000s)
[475.268705] Starting dynamic subtest: ccs0
[475.269876] Dynamic subtest ccs0: SUCCESS (0.000s)
[475.278623] Starting dynamic subtest: vcs0
[475.279423] Dynamic subtest vcs0: SUCCESS (0.000s)
[475.288278] Starting dynamic subtest: bcs0
[475.289088] Dynamic subtest bcs0: SUCCESS (0.000s)
[475.297705] Starting dynamic subtest: ccs3
[475.298503] Dynamic subtest ccs3: SUCCESS (0.000s)
[475.310048] Starting dynamic subtest: vecs1
[475.310867] Dynamic subtest vecs1: SUCCESS (0.000s)
[475.319546] Starting dynamic subtest: ccs1
[475.320351] Dynamic subtest ccs1: SUCCESS (0.000s)
[475.329068] Starting dynamic subtest: rcs0
[475.329888] Dynamic subtest rcs0: SUCCESS (0.000s)
[475.338436] Starting dynamic subtest: vcs1
[475.339237] Dynamic subtest vcs1: SUCCESS (0.000s)
[475.340039] Subtest invalid: SUCCESS (0.011s)
[475.352725] [107/142] (542s left) api_intel_allocator (two-level-inception-interruptible)
[475.397053] Starting subtest: two-level-inception-interruptible
[480.817725] Subtest two-level-inception-interruptible: SUCCESS (5.421s)
[480.921211] [108/142] (537s left) gem_mmap_gtt (big-copy-xy)
[481.036199] Subtest big-copy-XY: SKIP (0.000s)
[481.066718] [109/142] (537s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[481.181810] Starting subtest: short-flip-after-cursor-toggle
[482.198245] Subtest short-flip-after-cursor-toggle: SUCCESS (1.015s)
[482.426439] [110/142] (535s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[482.564242] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[482.565180] Starting dynamic subtest: pipe-A-valid-mode
[485.235845] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.671s)
[485.237770] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.673s)
[485.497753] [111/142] (532s left) gem_ctx_persistence (engines-hostile-preempt)
[485.561736] Starting subtest: engines-hostile-preempt
[485.562562] Starting dynamic subtest: rcs0
[485.627360] Dynamic subtest rcs0: SUCCESS (0.065s)
[485.640711] Starting dynamic subtest: bcs0
[485.663837] Dynamic subtest bcs0: SUCCESS (0.035s)
[485.698862] Starting dynamic subtest: vcs0
[485.718660] Dynamic subtest vcs0: SUCCESS (0.053s)
[485.740868] Starting dynamic subtest: vcs1
[485.760505] Dynamic subtest vcs1: SUCCESS (0.040s)
[485.776872] Starting dynamic subtest: vecs0
[485.805381] Dynamic subtest vecs0: SUCCESS (0.044s)
[485.829332] Starting dynamic subtest: vecs1
[485.848600] Dynamic subtest vecs1: SUCCESS (0.042s)
[485.874509] Starting dynamic subtest: ccs0
[485.894392] Dynamic subtest ccs0: SUCCESS (0.044s)
[485.909231] Starting dynamic subtest: ccs1
[485.942606] Dynamic subtest ccs1: SUCCESS (0.047s)
[485.968479] Starting dynamic subtest: ccs2
[485.991599] Dynamic subtest ccs2: SUCCESS (0.047s)
[486.016489] Starting dynamic subtest: ccs3
[486.037589] Dynamic subtest ccs3: SUCCESS (0.044s)
[486.038620] Subtest engines-hostile-preempt: SUCCESS (0.476s)
[486.188874] [112/142] (532s left) syncobj_timeline (invalid-transfer-bad-pad)
[486.238981] Starting subtest: invalid-transfer-bad-pad
[486.239810] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[486.331049] [113/142] (532s left) api_intel_allocator (gem-pool)
[486.384561] Starting subtest: gem-pool
[486.411708] Subtest gem-pool: SUCCESS (0.028s)
[486.547119] [114/142] (532s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[486.830566] Starting subtest: cursor-rapid-movement-256x85
[486.834957] Starting dynamic subtest: pipe-A-DP-4
[487.267726] Dynamic subtest pipe-A-DP-4: SUCCESS (0.433s)
[487.314200] Starting dynamic subtest: pipe-D-DP-4
[487.680178] Dynamic subtest pipe-D-DP-4: SUCCESS (0.374s)
[487.681344] Subtest cursor-rapid-movement-256x85: SUCCESS (0.849s)
[488.028612] [115/142] (530s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[488.295426] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[488.297280] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[488.470989] [116/142] (530s left) kms_psr (psr2_cursor_mmap_gtt)
[488.547802] Subtest psr2_cursor_mmap_gtt: SKIP (0.000s)
[488.574523] [117/142] (530s left) kms_psr (cursor_mmap_gtt)
[488.621559] Subtest cursor_mmap_gtt: SKIP (0.000s)
[488.641812] [118/142] (530s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_ccs)
[488.866451] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_ccs
[488.868317] Subtest pipe-B-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[489.087812] [119/142] (529s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[489.231690] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[491.754870] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.525s)
[491.896689] [120/142] (526s left) kms_plane_multiple (tiling-y)
[492.015006] Starting subtest: tiling-y
[492.016594] Subtest tiling-y: SKIP (0.000s)
[492.071776] [121/142] (526s left) i915_query (query-garbage)
[492.116124] Starting subtest: query-garbage
[492.116929] Subtest query-garbage: SUCCESS (0.000s)
[492.175669] [122/142] (526s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[492.308213] Starting subtest: cursorA-vs-flipB-atomic
[492.309815] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[492.373271] [123/142] (526s left) gem_exec_params (invalid-bsd1-flag-on-render)
[492.425449] Starting subtest: invalid-bsd1-flag-on-render
[492.426475] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[492.525600] [124/142] (526s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[492.672271] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[492.674014] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[492.741076] [125/142] (526s left) vgem_basic (create)
[492.804632] Starting subtest: create
[492.805848] Subtest create: SUCCESS (0.000s)
[492.875253] [126/142] (526s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[492.952296] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[493.059277] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[493.141272] [127/142] (525s left) gen7_exec_parse (basic-allowed)
[493.224617] Subtest basic-allowed: SKIP (0.000s)
[493.247790] [128/142] (525s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[493.516873] Starting subtest: pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[493.518663] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[493.676180] [129/142] (525s left) gem_exec_reloc (basic-concurrent0)
[493.751583] Subtest basic-concurrent0: SKIP (0.000s)
[493.792939] [130/142] (525s left) gem_mmap_wc (coherency)
[493.841132] Subtest coherency: SKIP (0.000s)
[493.875444] [131/142] (525s left) gem_exec_fair (basic-none-solo)
[493.931698] Subtest basic-none-solo: SKIP (0.000s)
[493.975006] [132/142] (525s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[494.091191] Starting subtest: cursorB-vs-flipB-varying-size
[494.092922] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[494.149844] [133/142] (524s left) kms_chamelium_audio (dp-audio)
[494.340323] Subtest dp-audio: SKIP (0.000s)
[494.456341] [134/142] (524s left) gem_mmap_gtt (basic-short)
[494.526799] Subtest basic-short: SKIP (0.000s)
[494.572276] [135/142] (524s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[494.652994] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[494.708461] [136/142] (524s left) gem_mmap_gtt (zero-extend)
[494.771711] Subtest zero-extend: SKIP (0.000s)
[494.800957] [137/142] (524s left) gem_mmap_gtt (basic-copy)
[494.863390] Subtest basic-copy: SKIP (0.000s)
[494.902364] [138/142] (524s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[495.051314] Starting subtest: 4-tiled-16bpp-rotate-0
[496.635792] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.584s)
[496.769770] [139/142] (522s left) gem_flink_basic (double-flink)
[496.815236] Starting subtest: double-flink
[496.816179] Subtest double-flink: SUCCESS (0.000s)
[496.953833] [140/142] (522s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[497.161186] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[497.278260] [141/142] (521s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[497.352660] Starting subtest: yf-tiled-ccs-to-yf-tiled
[497.354496] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[497.551873] [142/142] (521s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[497.795787] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[497.797438] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[498.008520] Closing watchdogs
Done.