[39.553190] Initializing watchdogs
[39.553272]   /dev/watchdog0
[39.559104] [001/141] (960s left) gem_softpin (noreloc-s3)
[39.706570] Starting subtest: noreloc-S3
[65.715242] Subtest noreloc-S3: SUCCESS (9.248s)
[70.809410] [002/141] (951s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[72.763297] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[74.477642] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.715s)
[74.584534] [003/141] (947s left) kms_fb_coherency (memset-crc)
[76.540159] Starting subtest: memset-crc
[76.541021] Starting dynamic subtest: mmap-offset-fixed
[77.103002] Dynamic subtest mmap-offset-fixed: SUCCESS (0.562s)
[77.156163] Subtest memset-crc: SUCCESS (0.617s)
[77.274893] [004/141] (944s left) v3d/v3d_wait_bo (used-bo-0ns)
[77.360251] Subtest used-bo-0ns: SKIP (0.000s)
[77.412053] [005/141] (944s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-mtl-rc-ccs)
[79.474164] Starting subtest: pipe-C-crc-primary-basic-4-tiled-mtl-rc-ccs
[79.475947] Subtest pipe-C-crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[79.622942] [006/141] (942s left) kms_big_fb (linear-64bpp-rotate-0)
[81.587838] Starting subtest: linear-64bpp-rotate-0
[83.730089] Subtest linear-64bpp-rotate-0: SUCCESS (2.137s)
[83.849144] [007/141] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[85.811930] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[85.813922] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[85.896021] [008/141] (936s left) gem_exec_reloc (basic-write-gtt-active)
[86.057928] Subtest basic-write-gtt-active: SKIP (0.000s)
[86.098504] [009/141] (935s left) kms_addfb_basic (basic-y-tiled-legacy)
[86.147617] Starting subtest: basic-y-tiled-legacy
[86.149395] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[88.124969] [010/141] (933s left) gem_mmap_gtt (medium-copy-xy)
[88.219275] Subtest medium-copy-XY: SKIP (0.000s)
[88.258395] [011/141] (933s left) i915_pm_rpm (gem-pread)
[93.199838] Starting subtest: gem-pread
[94.648087] Subtest gem-pread: SUCCESS (1.448s)
[95.706752] [012/141] (926s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[95.850860] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[95.903233] [013/141] (926s left) gem_mmap_gtt (basic-small-bo-tiledy)
[95.956291] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[95.991732] [014/141] (926s left) v3d/v3d_perfmon (destroy-valid-perfmon)
[96.096854] Subtest destroy-valid-perfmon: SKIP (0.000s)
[96.168342] [015/141] (925s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf-tiled-ccs)
[98.268839] Starting subtest: pipe-C-crc-sprite-planes-basic-yf-tiled-ccs
[98.273003] Subtest pipe-C-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.003s)
[98.397435] [016/141] (923s left) gem_pwrite_snooped
[98.492561] [017/141] (923s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[100.472891] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[100.474522] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[100.552396] [018/141] (921s left) kms_prime (d3hot)
[103.532494] Subtest D3hot: SKIP (0.000s)
[103.637398] [019/141] (918s left) kms_cursor_edge_walk (256x256-top-bottom)
[105.592101] Starting subtest: 256x256-top-bottom
[105.594468] Starting dynamic subtest: pipe-A-HDMI-A-3
[108.876715] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.283s)
[108.883887] Starting dynamic subtest: pipe-D-HDMI-A-3
[112.064699] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.186s)
[112.065641] Subtest 256x256-top-bottom: SUCCESS (6.473s)
[112.189566] [020/141] (910s left) gen7_exec_parse (basic-allowed)
[112.243861] Subtest basic-allowed: SKIP (0.000s)
[112.264031] [021/141] (909s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[114.306755] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[114.308578] Subtest pipe-B-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[114.487622] [022/141] (907s left) gem_flink_basic (basic)
[114.540639] Starting subtest: basic
[114.541639] Subtest basic: SUCCESS (0.000s)
[114.633398] [023/141] (907s left) core_getclient
[114.778241] [024/141] (907s left) gem_spin_batch (legacy-resubmit)
[114.855014] Starting subtest: legacy-resubmit
[114.855934] Starting dynamic subtest: default
[114.870389] Dynamic subtest default: SUCCESS (0.015s)
[114.877165] Starting dynamic subtest: render
[114.878188] Dynamic subtest render: SUCCESS (0.001s)
[114.884921] Starting dynamic subtest: bsd
[114.886156] Dynamic subtest bsd: SUCCESS (0.002s)
[114.892590] Starting dynamic subtest: bsd1
[114.893635] Dynamic subtest bsd1: SUCCESS (0.001s)
[114.900046] Starting dynamic subtest: bsd2
[114.901261] Dynamic subtest bsd2: SUCCESS (0.002s)
[114.907535] Starting dynamic subtest: blt
[114.908793] Dynamic subtest blt: SUCCESS (0.002s)
[114.915142] Starting dynamic subtest: vebox
[114.916352] Dynamic subtest vebox: SUCCESS (0.002s)
[114.917574] Subtest legacy-resubmit: SUCCESS (0.028s)
[115.134728] [025/141] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[117.084232] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[117.085130] Starting dynamic subtest: pipe-A-valid-mode
[117.770601] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.685s)
[117.771577] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.686s)
[117.892262] [026/141] (904s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[117.944979] Starting subtest: legacy-engines-hostile-preempt
[117.946023] Starting dynamic subtest: render
[117.989034] Dynamic subtest render: SUCCESS (0.044s)
[117.995291] Starting dynamic subtest: bsd1
[118.052230] Dynamic subtest bsd1: SUCCESS (0.062s)
[118.060474] Starting dynamic subtest: bsd2
[118.072997] Dynamic subtest bsd2: SUCCESS (0.020s)
[118.080764] Starting dynamic subtest: blt
[118.129385] Dynamic subtest blt: SUCCESS (0.055s)
[118.163908] Starting dynamic subtest: vebox
[118.196503] Dynamic subtest vebox: SUCCESS (0.065s)
[118.198052] Subtest legacy-engines-hostile-preempt: SUCCESS (0.252s)
[118.323660] [027/141] (904s left) kms_pm_rpm (modeset-lpsp)
[123.271045] Starting subtest: modeset-lpsp
[124.497344] Subtest modeset-lpsp: SKIP (1.224s)
[125.607852] [028/141] (896s left) gem_exec_schedule (semaphore-noskip)
[125.680203] Starting subtest: semaphore-noskip
[126.059394] Subtest semaphore-noskip: SUCCESS (0.375s)
[126.403793] [029/141] (895s left) kms_pipe_crc_basic (read-crc)
[128.350098] Starting subtest: read-crc
[128.351180] Starting dynamic subtest: pipe-A-HDMI-A-3
[128.983307] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.632s)
[128.993295] Starting dynamic subtest: pipe-B-HDMI-A-3
[129.472008] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.486s)
[129.481244] Starting dynamic subtest: pipe-C-HDMI-A-3
[129.938132] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.463s)
[129.947291] Starting dynamic subtest: pipe-D-HDMI-A-3
[130.409950] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.468s)
[130.411038] Subtest read-crc: SUCCESS (2.060s)
[130.519364] [030/141] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[132.485755] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[132.487755] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[132.576295] [031/141] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[134.625390] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[134.627739] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[134.688573] [032/141] (887s left) gem_exec_whisper (basic-fds-forked-all)
[134.802286] Starting subtest: basic-fds-forked-all
[160.307761] Subtest basic-fds-forked-all: SUCCESS (25.500s)
[160.504915] [033/141] (861s left) perf (unprivileged-single-ctx-counters)
[160.614222] Starting subtest: unprivileged-single-ctx-counters
[160.616097] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[160.632301] [034/141] (861s left) gem_exec_fence (concurrent)
[160.851572] Starting subtest: concurrent
[160.854788] Subtest concurrent: SKIP (0.000s)
[161.406081] [035/141] (861s left) kms_psr (psr_sprite_mmap_cpu)
[163.370839] Subtest psr_sprite_mmap_cpu: SKIP (0.000s)
[163.392055] [036/141] (859s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[165.461814] Starting subtest: pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[165.463754] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[165.616631] [037/141] (856s left) syncobj_wait (multi-wait-for-submit-submitted)
[165.671153] Starting subtest: multi-wait-for-submit-submitted
[165.781791] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[165.897100] [038/141] (856s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[167.859538] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[167.863794] Starting dynamic subtest: pipe-A-HDMI-A-3
[167.905107] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.041s)
[167.915964] Starting dynamic subtest: pipe-B-HDMI-A-3
[167.944561] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.035s)
[167.955206] Starting dynamic subtest: pipe-C-HDMI-A-3
[167.985147] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.035s)
[167.995054] Starting dynamic subtest: pipe-D-HDMI-A-3
[168.024586] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.035s)
[168.026471] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.165s)
[168.116366] [039/141] (854s left) gem_ctx_create (basic-files)
[168.170561] Starting subtest: basic-files
[170.185835] Subtest basic-files: SUCCESS (2.015s)
[170.666960] [040/141] (851s left) gem_exec_capture (pi)
[170.727058] Starting subtest: pi
[170.727954] Starting dynamic subtest: rcs0
[177.416435] Dynamic subtest rcs0: SUCCESS (6.685s)
[177.423906] Starting dynamic subtest: bcs0
[183.471807] Dynamic subtest bcs0: SUCCESS (6.055s)
[183.479158] Starting dynamic subtest: vcs0
[189.722035] Dynamic subtest vcs0: SUCCESS (6.250s)
[189.729379] Starting dynamic subtest: vcs1
[195.979142] Dynamic subtest vcs1: SUCCESS (6.256s)
[195.986993] Starting dynamic subtest: vecs0
[202.114513] Dynamic subtest vecs0: SUCCESS (6.135s)
[202.115464] Subtest pi: SUCCESS (31.384s)
[202.256971] [041/141] (820s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[202.365385] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[202.366328] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[202.432939] [042/141] (820s left) sw_sync (alloc_timeline)
[202.488634] Starting subtest: alloc_timeline
[202.489608] Subtest alloc_timeline: SUCCESS (0.000s)
[202.533196] [043/141] (820s left) gem_exec_reloc (basic-wc-gtt-active)
[202.599812] Subtest basic-wc-gtt-active: SKIP (0.000s)
[202.657921] [044/141] (820s left) gem_exec_reloc (basic-concurrent0)
[202.721273] Subtest basic-concurrent0: SKIP (0.000s)
[202.755665] [045/141] (819s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[204.721673] Starting subtest: yf-tiled-32bpp-rotate-270
[204.723621] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[204.800076] [046/141] (817s left) kms_atomic_interruptible (universal-setplane-cursor)
[206.828844] Starting subtest: universal-setplane-cursor
[206.831097] Starting dynamic subtest: pipe-A-HDMI-A-3
[213.007767] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.177s)
[213.008664] Subtest universal-setplane-cursor: SUCCESS (6.180s)
[213.114781] [047/141] (809s left) gem_partial_pwrite_pread (reads-uncached)
[213.165995] Subtest reads-uncached: SKIP (0.000s)
[213.206554] [048/141] (809s left) kms_frontbuffer_tracking (fbc-2p-rte)
[215.162272] Starting subtest: fbc-2p-rte
[215.164371] Subtest fbc-2p-rte: SKIP (0.000s)
[215.236131] [049/141] (807s left) kms_ccs (pipe-d-random-ccs-data-yf-tiled-ccs)
[217.423781] Starting subtest: pipe-D-random-ccs-data-yf-tiled-ccs
[217.426878] Subtest pipe-D-random-ccs-data-yf-tiled-ccs: SKIP (0.000s)
[217.530678] [050/141] (805s left) kms_atomic_transition (modeset-transition)
[219.481293] Starting subtest: modeset-transition
[219.482368] Starting dynamic subtest: 1x-outputs
[222.046479] Dynamic subtest 1x-outputs: SUCCESS (2.565s)
[222.086185] Subtest modeset-transition: SUCCESS (2.605s)
[222.199397] [051/141] (800s left) i915_pm_sseu (full-enable)
[222.250344] Subtest full-enable: SKIP (0.000s)
[222.324274] [052/141] (800s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[224.277219] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[224.278916] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[224.354804] [053/141] (798s left) kms_ccs (pipe-b-random-ccs-data-yf-tiled-ccs)
[226.472109] Starting subtest: pipe-B-random-ccs-data-yf-tiled-ccs
[226.475443] Subtest pipe-B-random-ccs-data-yf-tiled-ccs: SKIP (0.000s)
[226.651240] [054/141] (796s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[228.612824] Starting subtest: psr-rgb565-draw-pwrite
[228.614480] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[228.712306] [055/141] (794s left) syncobj_timeline (invalid-signal-zero-handles)
[228.849072] Starting subtest: invalid-signal-zero-handles
[228.849990] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[228.920053] [056/141] (794s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[230.900322] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[231.484607] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.583s)
[231.624381] [057/141] (791s left) gem_partial_pwrite_pread (write-display)
[231.697200] Subtest write-display: SKIP (0.000s)
[231.743797] [058/141] (791s left) gem_exec_flush (basic-uc-set-default)
[231.793941] Subtest basic-uc-set-default: SKIP (0.000s)
[231.845468] [059/141] (791s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[233.810368] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[236.467652] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.658s)
[236.666184] [060/141] (786s left) gem_ctx_persistence (engines-mixed)
[236.725188] Starting subtest: engines-mixed
[236.726314] Starting dynamic subtest: rcs0
[236.784300] Dynamic subtest rcs0: SUCCESS (0.058s)
[236.794856] Starting dynamic subtest: bcs0
[236.830543] Dynamic subtest bcs0: SUCCESS (0.045s)
[236.854826] Starting dynamic subtest: vcs0
[236.881797] Dynamic subtest vcs0: SUCCESS (0.049s)
[236.905242] Starting dynamic subtest: vcs1
[236.937580] Dynamic subtest vcs1: SUCCESS (0.053s)
[236.963058] Starting dynamic subtest: vecs0
[236.988806] Dynamic subtest vecs0: SUCCESS (0.049s)
[236.990550] Subtest engines-mixed: SUCCESS (0.264s)
[237.136133] [061/141] (785s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[237.214734] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[237.321381] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[237.394830] [062/141] (785s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[239.346307] Starting subtest: multiplane-rotation-cropping-top
[259.566813] Subtest multiplane-rotation-cropping-top: SUCCESS (20.221s)
[259.702514] [063/141] (763s left) kms_feature_discovery (display-4x)
[261.668977] Starting subtest: display-4x
[261.671032] Subtest display-4x: SKIP (0.000s)
[261.734284] [064/141] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[263.756118] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[263.758166] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[263.860912] [065/141] (759s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-rc-ccs)
[265.965080] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs
[265.967961] Subtest pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[266.179136] [066/141] (757s left) fbdev (unaligned-write)
[266.229488] Starting subtest: unaligned-write
[266.416470] Subtest unaligned-write: SUCCESS (0.183s)
[266.463246] [067/141] (756s left) kms_cursor_crc (cursor-onscreen-64x21)
[268.517965] Starting subtest: cursor-onscreen-64x21
[268.525482] Starting dynamic subtest: pipe-A-HDMI-A-3
[271.317805] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.792s)
[271.343767] Starting dynamic subtest: pipe-D-HDMI-A-3
[273.893410] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.556s)
[273.894302] Subtest cursor-onscreen-64x21: SUCCESS (5.376s)
[274.239733] [068/141] (749s left) prime_self_import (export-vs-gem_close-race)
[274.286703] Starting subtest: export-vs-gem_close-race
[279.314911] Subtest export-vs-gem_close-race: SUCCESS (5.027s)
[279.375665] [069/141] (743s left) gem_exec_balancer (bonded-semaphore)
[279.490779] Starting subtest: bonded-semaphore
[279.492865] Subtest bonded-semaphore: SKIP (0.000s)
[279.856538] [070/141] (743s left) gen9_exec_parse (bb-chained)
[279.907870] Subtest bb-chained: SKIP (0.000s)
[279.930842] [071/141] (743s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[281.889781] Starting subtest: psr-farfromfence-mmap-gtt
[281.891807] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[281.960049] [072/141] (741s left) api_intel_bb (misplaced-blitter)
[282.052298] Starting subtest: misplaced-blitter
[282.077318] Subtest misplaced-blitter: SUCCESS (0.027s)
[282.197703] [073/141] (741s left) kms_flip (bo-too-big-interruptible)
[284.180646] Starting subtest: bo-too-big-interruptible
[284.190845] Starting dynamic subtest: A-HDMI-A3
[284.374963] Dynamic subtest A-HDMI-A3: SUCCESS (0.184s)
[284.384633] Starting dynamic subtest: B-HDMI-A3
[284.480154] Dynamic subtest B-HDMI-A3: SUCCESS (0.104s)
[284.489499] Starting dynamic subtest: C-HDMI-A3
[284.585478] Dynamic subtest C-HDMI-A3: SUCCESS (0.104s)
[284.594992] Starting dynamic subtest: D-HDMI-A3
[284.690162] Dynamic subtest D-HDMI-A3: SUCCESS (0.103s)
[284.692677] Subtest bo-too-big-interruptible: SUCCESS (0.512s)
[284.847510] [074/141] (738s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[286.800699] Starting subtest: fbc-rgb565-draw-render
[289.513251] Subtest fbc-rgb565-draw-render: SUCCESS (2.713s)
[289.670584] [075/141] (733s left) kms_psr2_su (page_flip-p010)
[289.730505] Subtest page_flip-P010: SKIP (0.000s)
[289.755952] [076/141] (733s left) gem_pread (self)
[289.803007] Subtest self: SKIP (0.000s)
[289.840333] [077/141] (733s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-ccs)
[291.964577] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-ccs
[291.966654] Subtest pipe-D-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[292.065578] [078/141] (731s left) perf_pmu (render-node-busy-idle)
[292.120959] Starting subtest: render-node-busy-idle
[292.121908] Starting dynamic subtest: rcs0
[292.801684] Dynamic subtest rcs0: SUCCESS (0.681s)
[292.814091] Starting dynamic subtest: bcs0
[293.456680] Dynamic subtest bcs0: SUCCESS (0.653s)
[293.469127] Starting dynamic subtest: vcs0
[294.114650] Dynamic subtest vcs0: SUCCESS (0.656s)
[294.127177] Starting dynamic subtest: vcs1
[294.769773] Dynamic subtest vcs1: SUCCESS (0.653s)
[294.782375] Starting dynamic subtest: vecs0
[295.430765] Dynamic subtest vecs0: SUCCESS (0.659s)
[295.431840] Subtest render-node-busy-idle: SUCCESS (3.312s)
[295.523740] [079/141] (727s left) gem_ctx_bad_destroy (invalid-default-ctx)
[295.569694] Starting subtest: invalid-default-ctx
[295.570714] Subtest invalid-default-ctx: SUCCESS (0.000s)
[295.636472] [080/141] (727s left) api_intel_allocator (two-level-inception-interruptible)
[295.682693] Starting subtest: two-level-inception-interruptible
[301.135528] Subtest two-level-inception-interruptible: SUCCESS (5.449s)
[301.228167] [081/141] (722s left) gem_exec_reloc (basic-cpu-active)
[301.350121] Subtest basic-cpu-active: SKIP (0.000s)
[301.390211] [082/141] (722s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-ccs)
[303.441991] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-ccs
[303.444256] Subtest pipe-B-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[303.615421] [083/141] (719s left) kms_chamelium_edid (dp-edid-resolution-list)
[305.605291] Subtest dp-edid-resolution-list: SKIP (0.000s)
[305.660359] [084/141] (717s left) gem_exec_schedule (manyslice)
[305.719021] Starting subtest: manyslice
[305.720023] Starting dynamic subtest: rcs0
[310.776212] Dynamic subtest rcs0: SUCCESS (5.052s)
[310.784985] Starting dynamic subtest: bcs0
[315.693447] Dynamic subtest bcs0: SUCCESS (4.915s)
[315.708283] Starting dynamic subtest: vcs0
[320.724936] Dynamic subtest vcs0: SUCCESS (5.029s)
[320.733529] Starting dynamic subtest: vcs1
[325.738980] Dynamic subtest vcs1: SUCCESS (5.013s)
[325.747376] Starting dynamic subtest: vecs0
[330.746165] Dynamic subtest vecs0: SUCCESS (5.004s)
[330.747118] Subtest manyslice: SUCCESS (25.025s)
[331.049336] [085/141] (692s left) kms_vblank (query-forked-hang)
[333.005859] Starting subtest: query-forked-hang
[333.007134] Starting dynamic subtest: pipe-A-HDMI-A-3
[346.664329] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (13.656s)
[346.676509] Starting dynamic subtest: pipe-D-HDMI-A-3
[371.607504] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.937s)
[371.608406] Subtest query-forked-hang: SUCCESS (38.602s)
[371.707431] [086/141] (651s left) gem_ctx_isolation (clean)
[371.761426] Starting subtest: clean
[371.762287] Starting dynamic subtest: rcs0
[371.850566] Dynamic subtest rcs0: SUCCESS (0.088s)
[371.859253] Starting dynamic subtest: bcs0
[371.983614] Dynamic subtest bcs0: SUCCESS (0.129s)
[371.991898] Starting dynamic subtest: vcs0
[372.109323] Dynamic subtest vcs0: SUCCESS (0.127s)
[372.117897] Starting dynamic subtest: vcs1
[372.224661] Dynamic subtest vcs1: SUCCESS (0.114s)
[372.233220] Starting dynamic subtest: vecs0
[372.342062] Dynamic subtest vecs0: SUCCESS (0.116s)
[372.342912] Subtest clean: SUCCESS (0.581s)
[372.584757] [087/141] (651s left) gem_wait (invalid-buf)
[372.642479] Starting subtest: invalid-buf
[372.643441] Subtest invalid-buf: SUCCESS (0.000s)
[372.895903] [088/141] (650s left) kms_vblank (wait-forked)
[374.847640] Starting subtest: wait-forked
[374.848763] Starting dynamic subtest: pipe-A-HDMI-A-3
[377.210835] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.362s)
[377.224457] Starting dynamic subtest: pipe-D-HDMI-A-3
[379.424127] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.208s)
[379.425070] Subtest wait-forked: SUCCESS (4.579s)
[379.526388] [089/141] (644s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[381.482548] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[381.484595] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[381.756695] [090/141] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[383.715976] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[383.717845] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[383.796657] [091/141] (639s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[385.849737] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[385.878686] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.028s)
[385.942616] [092/141] (637s left) i915_pm_freq_api (freq-reset)
[386.038269] Starting subtest: freq-reset
[386.039213] Starting dynamic subtest: gt0
[386.290625] Dynamic subtest gt0: SUCCESS (0.250s)
[386.291676] Subtest freq-reset: SUCCESS (0.252s)
[386.361038] [093/141] (637s left) kms_hdmi_inject (inject-4k)
[386.443253] Starting subtest: inject-4k
[386.576217] Subtest inject-4k: SUCCESS (0.132s)
[388.632935] [094/141] (635s left) syncobj_eventfd (timeline-wait-before-signal)
[388.697972] Starting subtest: timeline-wait-before-signal
[388.728701] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[388.860745] [095/141] (635s left) gem_exec_balancer (invalid-balancer)
[388.926803] Starting subtest: invalid-balancer
[390.096833] Subtest invalid-balancer: SUCCESS (1.166s)
[390.382391] [096/141] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[392.341506] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[392.343503] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[392.419608] [097/141] (631s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[392.524334] Subtest writes-after-reads-snoop: SKIP (0.000s)
[392.576945] [098/141] (631s left) gem_exec_reloc (basic-cpu-wc-active)
[392.636297] Subtest basic-cpu-wc-active: SKIP (0.000s)
[392.673517] [099/141] (631s left) kms_addfb_basic (bad-pitch-128)
[392.720895] Starting subtest: bad-pitch-128
[392.721752] Subtest bad-pitch-128: SUCCESS (0.000s)
[394.722439] [100/141] (629s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[394.862920] Starting subtest: yf-tiled-to-vebox-x-tiled
[394.863876] Starting dynamic subtest: smem
[394.944997] Dynamic subtest smem: SUCCESS (0.082s)
[394.956070] Starting dynamic subtest: lmem0
[395.695835] Dynamic subtest lmem0: SUCCESS (0.745s)
[395.697086] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.829s)
[395.946229] [101/141] (628s left) sysfs_timeslice_duration (duration)
[395.997005] Starting subtest: duration
[395.999414] Starting dynamic subtest: vecs0
[409.141077] Dynamic subtest vecs0: SUCCESS (13.143s)
[409.153188] Starting dynamic subtest: vcs0
[422.267072] Dynamic subtest vcs0: SUCCESS (13.124s)
[422.279010] Starting dynamic subtest: bcs0
[435.403144] Dynamic subtest bcs0: SUCCESS (13.134s)
[435.415422] Starting dynamic subtest: rcs0
[448.528049] Dynamic subtest rcs0: SUCCESS (13.123s)
[448.539683] Starting dynamic subtest: vcs1
[461.664988] Dynamic subtest vcs1: SUCCESS (13.136s)
[461.665911] Subtest duration: SUCCESS (65.669s)
[461.758518] [102/141] (562s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[463.744414] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[463.799333] [103/141] (560s left) kms_chamelium_hpd (hdmi-hpd-storm)
[465.793029] Subtest hdmi-hpd-storm: SKIP (0.000s)
[465.849870] [104/141] (558s left) kms_flip (2x-blocking-absolute-wf_vblank)
[467.805660] Starting subtest: 2x-blocking-absolute-wf_vblank
[467.834363] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.028s)
[467.906895] [105/141] (556s left) drm_fdinfo (virtual-busy-hang-all)
[467.999225] Starting subtest: virtual-busy-hang-all
[468.001770] Subtest virtual-busy-hang-all: SKIP (0.000s)
[468.078764] [106/141] (556s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[470.209316] Starting subtest: pipe-D-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[470.536372] Subtest pipe-D-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.326s)
[470.753522] [107/141] (553s left) kms_content_protection (mei-interface)
[472.754147] Starting subtest: mei-interface
[472.756008] Subtest mei-interface: SKIP (0.001s)
[472.910805] [108/141] (551s left) perf_pmu (busy-accuracy-2)
[473.026696] Starting subtest: busy-accuracy-2
[473.027624] Starting dynamic subtest: rcs0
[476.081953] Dynamic subtest rcs0: SUCCESS (3.054s)
[476.091131] Starting dynamic subtest: bcs0
[479.134907] Dynamic subtest bcs0: SUCCESS (3.052s)
[479.144259] Starting dynamic subtest: vcs0
[482.188105] Dynamic subtest vcs0: SUCCESS (3.052s)
[482.197580] Starting dynamic subtest: vcs1
[485.243090] Dynamic subtest vcs1: SUCCESS (3.054s)
[485.252611] Starting dynamic subtest: vecs0
[488.295893] Dynamic subtest vecs0: SUCCESS (3.052s)
[488.296819] Subtest busy-accuracy-2: SUCCESS (15.269s)
[488.403523] [109/141] (535s left) gem_pxp (protected-raw-src-copy-not-readible)
[490.972375] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[491.045330] [110/141] (533s left) kms_properties (connector-properties-legacy)
[492.998874] Starting subtest: connector-properties-legacy
[493.666354] Subtest connector-properties-legacy: SUCCESS (0.669s)
[493.793392] [111/141] (530s left) vc4/vc4_wait_bo (used-bo-0ns)
[493.891492] Subtest used-bo-0ns: SKIP (0.000s)
[493.945326] [112/141] (530s left) gem_lmem_swapping (heavy-random)
[497.675762] Starting subtest: heavy-random
[497.676609] Starting dynamic subtest: lmem0
[503.959889] Dynamic subtest lmem0: SUCCESS (6.279s)
[503.960737] Subtest heavy-random: SUCCESS (6.281s)
[506.109446] [113/141] (518s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[510.407962] Starting subtest: 4-tiled-8bpp-rotate-270
[510.409689] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[511.450247] [114/141] (512s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[513.451012] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[513.451965] Starting dynamic subtest: pipe-A-valid-mode
[514.193447] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.741s)
[514.194549] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.743s)
[514.319835] [115/141] (510s left) vgem_basic (bad-pad)
[514.385844] Starting subtest: bad-pad
[514.386858] Subtest bad-pad: SUCCESS (0.000s)
[514.439119] [116/141] (509s left) syncobj_timeline (multi-wait-submitted-signaled)
[514.490842] Starting subtest: multi-wait-submitted-signaled
[514.491899] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[514.554175] [117/141] (509s left) kms_lease (implicit-plane-lease)
[516.508925] Starting subtest: implicit-plane-lease
[516.512018] Subtest implicit-plane-lease: SUCCESS (0.002s)
[516.572242] [118/141] (507s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[518.644016] Starting subtest: pipe-B-bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[518.646154] Subtest pipe-B-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[518.836487] [119/141] (505s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[520.792548] Starting subtest: plane-upscale-factor-0-25-with-rotation
[520.797069] Starting dynamic subtest: pipe-A-HDMI-A-3
[520.886374] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.088s)
[520.902441] Starting dynamic subtest: pipe-B-HDMI-A-3
[521.011052] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.118s)
[521.023002] Starting dynamic subtest: pipe-C-HDMI-A-3
[521.115236] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.098s)
[521.126892] Starting dynamic subtest: pipe-D-HDMI-A-3
[521.220181] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.100s)
[521.221910] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (0.429s)
[521.362858] [120/141] (503s left) vc4/vc4_purgeable_bo (free-purged-bo)
[521.443944] Subtest free-purged-bo: SKIP (0.000s)
[521.499920] [121/141] (502s left) gem_mmap_offset (oob-read)
[521.548981] Starting subtest: oob-read
[521.549879] Subtest oob-read: SUCCESS (0.000s)
[521.663817] [122/141] (502s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[523.852892] Starting subtest: cursor-rapid-movement-512x170
[523.856426] Subtest cursor-rapid-movement-512x170: SKIP (0.002s)
[524.012491] [123/141] (500s left) drm_fdinfo (busy-hang)
[524.093682] Starting subtest: busy-hang
[524.094785] Starting dynamic subtest: rcs0
[524.096902] Dynamic subtest rcs0: SKIP (0.001s)
[524.104971] Starting dynamic subtest: bcs0
[524.107175] Dynamic subtest bcs0: SKIP (0.000s)
[524.114979] Starting dynamic subtest: vcs0
[524.117222] Dynamic subtest vcs0: SKIP (0.000s)
[524.124925] Starting dynamic subtest: vcs1
[524.126983] Dynamic subtest vcs1: SKIP (0.000s)
[524.135047] Starting dynamic subtest: vecs0
[524.137747] Dynamic subtest vecs0: SKIP (0.000s)
[524.140566] Subtest busy-hang: SKIP (0.007s)
[524.160483] [124/141] (500s left) prime_udl
[524.236826] [125/141] (500s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-ccs)
[526.240728] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-ccs
[526.242813] Subtest pipe-A-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[526.462460] [126/141] (498s left) v3d/v3d_submit_cl (multi-and-single-sync)
[526.562393] Subtest multi-and-single-sync: SKIP (0.000s)
[526.628571] [127/141] (498s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[528.595726] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[529.127811] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.531s)
[529.257796] [128/141] (495s left) gem_ctx_param (invalid-param-get)
[529.344943] Starting subtest: invalid-param-get
[529.345951] Subtest invalid-param-get: SUCCESS (0.001s)
[529.436445] [129/141] (495s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[529.484029] Starting subtest: multi-wait-all-for-submit-available-signaled
[529.484884] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[529.546097] [130/141] (495s left) gem_lmem_swapping (parallel-multi)
[533.073332] Starting subtest: parallel-multi
[533.074264] Starting dynamic subtest: lmem0
[589.275652] Dynamic subtest lmem0: SUCCESS (56.197s)
[589.276868] Subtest parallel-multi: SUCCESS (56.199s)
[590.371352] [131/141] (434s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[595.629166] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[595.631382] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[595.709334] [132/141] (429s left) kms_psr (pr_primary_mmap_gtt)
[597.732756] Subtest pr_primary_mmap_gtt: SKIP (0.000s)
[597.763514] [133/141] (427s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[599.730684] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[599.732897] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[599.810983] [134/141] (425s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[601.811382] Starting subtest: 2x-flip-vs-cursor-legacy
[601.814752] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.004s)
[601.872723] [135/141] (422s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[603.907280] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[603.909108] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[603.993974] [136/141] (420s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-dg2-rc-ccs)
[606.093270] Starting subtest: pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs
[606.095452] Subtest pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[606.323948] [137/141] (418s left) gem_mmap_gtt (basic-write-read-distinct)
[606.374643] Subtest basic-write-read-distinct: SKIP (0.000s)
[606.398095] [138/141] (418s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-rc-ccs)
[608.499196] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs
[608.501298] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[608.623172] [139/141] (416s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[610.585310] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[610.587258] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[610.661109] [140/141] (414s left) syncobj_wait (invalid-single-wait-unsubmitted)
[610.770451] Starting subtest: invalid-single-wait-unsubmitted
[610.771649] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[610.850721] [141/141] (414s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[612.823127] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[612.827245] Starting dynamic subtest: pipe-A-HDMI-A-3
[612.938519] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.111s)
[612.952979] Starting dynamic subtest: pipe-B-HDMI-A-3
[613.079951] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.135s)
[613.092247] Starting dynamic subtest: pipe-C-HDMI-A-3
[613.219376] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.134s)
[613.231451] Starting dynamic subtest: pipe-D-HDMI-A-3
[613.358520] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.134s)
[613.359531] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.537s)
[613.480010] Closing watchdogs
Done.