[37.722720] Initializing watchdogs
[37.722771]   /dev/watchdog0
[37.728362] [001/138] (960s left) prime_mmap (test_aperture_limit)
[37.778154] Starting subtest: test_aperture_limit
[37.779015] Starting dynamic subtest: test_aperture_limit-smem
[50.139432] [002/138] (948s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[50.268689] Starting subtest: y-tiled-to-vebox-yf-tiled
[50.270245] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[50.431221] [003/138] (947s left) template (a)
[50.471306] Starting subtest: A
[50.472177] Subtest A: SUCCESS (0.000s)
[50.525135] [004/138] (947s left) vc4/vc4_wait_bo (bad-bo)
[50.594949] Subtest bad-bo: SKIP (0.000s)
[50.641287] [005/138] (947s left) kms_psr (psr2_no_drrs)
[50.709706] Subtest psr2_no_drrs: SKIP (0.000s)
[50.734044] [006/138] (947s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[50.784603] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[50.850351] [007/138] (947s left) kms_flip (2x-flip-vs-rmfb)
[50.972774] Starting subtest: 2x-flip-vs-rmfb
[50.987327] Subtest 2x-flip-vs-rmfb: SKIP (0.015s)
[51.058152] [008/138] (947s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[51.180816] Starting subtest: x-tiled-8bpp-rotate-90
[51.247771] Subtest x-tiled-8bpp-rotate-90: SKIP (0.066s)
[51.391773] [009/138] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[51.511482] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[51.513045] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[51.608079] [010/138] (946s left) kms_pm_rpm (modeset-non-lpsp)
[53.587065] Starting subtest: modeset-non-lpsp
[53.953908] Subtest modeset-non-lpsp: SUCCESS (0.366s)
[54.099868] [011/138] (944s left) kms_vblank (ts-continuation-dpms-rpm)
[54.213750] Starting subtest: ts-continuation-dpms-rpm
[54.215703] Starting dynamic subtest: pipe-A-DP-4
[55.905220] Dynamic subtest pipe-A-DP-4: SUCCESS (1.689s)
[55.915226] Starting dynamic subtest: pipe-D-DP-4
[56.896721] Dynamic subtest pipe-D-DP-4: SUCCESS (0.988s)
[56.897693] Subtest ts-continuation-dpms-rpm: SUCCESS (2.682s)
[57.131990] [012/138] (941s left) v3d/v3d_submit_cl (bad-multisync-extension)
[57.236683] Subtest bad-multisync-extension: SKIP (0.000s)
[57.286555] [013/138] (941s left) i915_pm_rpm (debugfs-forcewake-user)
[59.523186] Starting subtest: debugfs-forcewake-user
[70.483693] Subtest debugfs-forcewake-user: SUCCESS (10.961s)
[70.810562] [014/138] (927s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[70.979251] Starting subtest: compare-crc-sanitycheck-nv12
[70.980039] Starting dynamic subtest: pipe-A-DP-4
[71.669765] Dynamic subtest pipe-A-DP-4: SUCCESS (0.689s)
[71.676335] Starting dynamic subtest: pipe-B-DP-4
[72.312628] Dynamic subtest pipe-B-DP-4: SUCCESS (0.642s)
[72.319212] Starting dynamic subtest: pipe-C-DP-4
[72.909796] Dynamic subtest pipe-C-DP-4: SUCCESS (0.596s)
[72.916254] Starting dynamic subtest: pipe-D-DP-4
[73.512895] Dynamic subtest pipe-D-DP-4: SUCCESS (0.602s)
[73.513707] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.533s)
[73.730487] [015/138] (924s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-dg2-mc-ccs)
[73.995914] Starting subtest: pipe-C-random-ccs-data-4-tiled-dg2-mc-ccs
[74.590081] Subtest pipe-C-random-ccs-data-4-tiled-dg2-mc-ccs: SUCCESS (0.594s)
[74.868953] [016/138] (923s left) prime_mmap_coherency (ioctl-errors)
[74.940921] Starting subtest: ioctl-errors
[80.501519] Subtest ioctl-errors: SUCCESS (5.560s)
[80.600106] [017/138] (917s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[80.760463] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[80.762153] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[80.838323] [018/138] (917s left) gem_mmap_wc (bad-size)
[80.894965] Subtest bad-size: SKIP (0.000s)
[80.925054] [019/138] (917s left) gem_exec_schedule (timeslicing)
[80.983296] Starting subtest: timeslicing
[80.984202] Starting dynamic subtest: rcs0
[81.001963] Dynamic subtest rcs0: SUCCESS (0.018s)
[81.008512] Starting dynamic subtest: bcs0
[81.019942] Dynamic subtest bcs0: SUCCESS (0.018s)
[81.028383] Starting dynamic subtest: vcs0
[81.040535] Dynamic subtest vcs0: SUCCESS (0.020s)
[81.051520] Starting dynamic subtest: vcs1
[81.063513] Dynamic subtest vcs1: SUCCESS (0.023s)
[81.074646] Starting dynamic subtest: vecs0
[81.086220] Dynamic subtest vecs0: SUCCESS (0.023s)
[81.097344] Starting dynamic subtest: vecs1
[81.108054] Dynamic subtest vecs1: SUCCESS (0.022s)
[81.119103] Starting dynamic subtest: ccs0
[81.129603] Dynamic subtest ccs0: SUCCESS (0.021s)
[81.142251] Starting dynamic subtest: ccs1
[81.152287] Dynamic subtest ccs1: SUCCESS (0.022s)
[81.165041] Starting dynamic subtest: ccs2
[81.176366] Dynamic subtest ccs2: SUCCESS (0.024s)
[81.188959] Starting dynamic subtest: ccs3
[81.197761] Dynamic subtest ccs3: SUCCESS (0.021s)
[81.199122] Subtest timeslicing: SUCCESS (0.214s)
[81.550570] [020/138] (917s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-ccs)
[81.769460] Starting subtest: pipe-B-random-ccs-data-y-tiled-ccs
[81.771974] Subtest pipe-B-random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[81.978023] [021/138] (916s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[82.136654] Starting subtest: fbc-indfb-scaledprimary
[85.623421] Subtest fbc-indfb-scaledprimary: SUCCESS (3.489s)
[85.796725] [022/138] (912s left) gen9_exec_parse (bb-start-param)
[85.855559] Subtest bb-start-param: SKIP (0.000s)
[85.881504] [023/138] (912s left) gem_mmap_gtt (cpuset-basic-small-copy)
[85.930346] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[85.948326] [024/138] (912s left) kms_psr2_sf (plane-move-sf-dmg-area)
[85.996953] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[86.015417] [025/138] (912s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[86.066819] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[86.170545] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[86.279404] [026/138] (912s left) gem_exec_store (pages)
[86.340689] Starting subtest: pages
[86.341521] Starting dynamic subtest: rcs0
[86.458426] Dynamic subtest rcs0: SUCCESS (0.117s)
[86.465181] Starting dynamic subtest: bcs0
[86.540659] Dynamic subtest bcs0: SUCCESS (0.082s)
[86.547717] Starting dynamic subtest: vcs0
[86.634526] Dynamic subtest vcs0: SUCCESS (0.094s)
[86.641304] Starting dynamic subtest: vcs1
[86.723926] Dynamic subtest vcs1: SUCCESS (0.089s)
[86.730596] Starting dynamic subtest: vecs0
[86.805709] Dynamic subtest vecs0: SUCCESS (0.082s)
[86.813032] Starting dynamic subtest: vecs1
[86.895748] Dynamic subtest vecs1: SUCCESS (0.090s)
[86.902557] Starting dynamic subtest: ccs0
[86.992663] Dynamic subtest ccs0: SUCCESS (0.097s)
[86.999497] Starting dynamic subtest: ccs1
[87.082505] Dynamic subtest ccs1: SUCCESS (0.090s)
[87.089340] Starting dynamic subtest: ccs2
[87.172728] Dynamic subtest ccs2: SUCCESS (0.090s)
[87.179551] Starting dynamic subtest: ccs3
[87.270057] Dynamic subtest ccs3: SUCCESS (0.097s)
[87.271186] Subtest pages: SUCCESS (0.929s)
[87.492779] [027/138] (911s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[87.614319] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[87.615894] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[87.695816] [028/138] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[87.845659] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[87.847387] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[87.905517] [029/138] (910s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[88.016373] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[88.022442] Starting dynamic subtest: A-DP4
[96.177950] Dynamic subtest A-DP4: SUCCESS (8.155s)
[96.186444] Starting dynamic subtest: B-DP4
[104.196328] Dynamic subtest B-DP4: SUCCESS (8.017s)
[104.207252] Starting dynamic subtest: C-DP4
[112.210118] Dynamic subtest C-DP4: SUCCESS (8.012s)
[112.219082] Starting dynamic subtest: D-DP4
[120.225217] Dynamic subtest D-DP4: SUCCESS (8.015s)
[120.226046] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.210s)
[120.525285] [030/138] (878s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-mc-ccs)
[120.728633] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-mc-ccs
[120.731304] Subtest pipe-A-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[120.967500] [031/138] (877s left) gem_flink_basic (flink-lifetime)
[121.044419] Starting subtest: flink-lifetime
[121.045557] Subtest flink-lifetime: SUCCESS (0.001s)
[121.147069] [032/138] (877s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[121.298235] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[121.299793] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[121.395305] [033/138] (877s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[121.477478] Starting subtest: invalid-multi-wait-all-unsubmitted
[121.478357] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[121.541790] [034/138] (877s left) kms_chamelium_hpd (dp-hpd-fast)
[121.759815] Subtest dp-hpd-fast: SKIP (0.000s)
[121.870407] [035/138] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[122.018156] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[122.019706] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[122.092599] [036/138] (876s left) perf (invalid-oa-metric-set-id)
[122.426451] Starting subtest: invalid-oa-metric-set-id
[122.442107] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s)
[122.469029] [037/138] (876s left) gem_eio (in-flight-internal-immediate)
[122.732977] Starting subtest: in-flight-internal-immediate
[124.399361] Subtest in-flight-internal-immediate: SUCCESS (1.667s)
[124.542101] [038/138] (874s left) kms_cursor_crc (cursor-onscreen-64x21)
[124.761530] Starting subtest: cursor-onscreen-64x21
[124.766106] Starting dynamic subtest: pipe-A-DP-4
[127.287064] Dynamic subtest pipe-A-DP-4: SUCCESS (2.520s)
[127.319871] Starting dynamic subtest: pipe-D-DP-4
[130.034565] Dynamic subtest pipe-D-DP-4: SUCCESS (2.721s)
[130.035425] Subtest cursor-onscreen-64x21: SUCCESS (5.273s)
[130.427292] [039/138] (868s left) i915_pm_rpm (gem-pread)
[132.586868] Starting subtest: gem-pread
[133.673125] Subtest gem-pread: SUCCESS (1.086s)
[133.879692] [040/138] (865s left) kms_feature_discovery (display)
[134.016093] Starting subtest: display
[134.016980] Subtest display: SUCCESS (0.000s)
[134.086365] [041/138] (865s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[134.221821] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[134.223504] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[134.286641] [042/138] (864s left) gem_exec_schedule (preempt-contexts)
[134.348186] Starting subtest: preempt-contexts
[134.349009] Starting dynamic subtest: rcs0
[134.410898] Dynamic subtest rcs0: SUCCESS (0.062s)
[134.418221] Starting dynamic subtest: bcs0
[134.463296] Dynamic subtest bcs0: SUCCESS (0.052s)
[134.470531] Starting dynamic subtest: vcs0
[134.509357] Dynamic subtest vcs0: SUCCESS (0.046s)
[134.516499] Starting dynamic subtest: vcs1
[134.555509] Dynamic subtest vcs1: SUCCESS (0.046s)
[134.562480] Starting dynamic subtest: vecs0
[134.600918] Dynamic subtest vecs0: SUCCESS (0.045s)
[134.607969] Starting dynamic subtest: vecs1
[134.646537] Dynamic subtest vecs1: SUCCESS (0.045s)
[134.653788] Starting dynamic subtest: ccs0
[134.692164] Dynamic subtest ccs0: SUCCESS (0.045s)
[134.699461] Starting dynamic subtest: ccs1
[134.737439] Dynamic subtest ccs1: SUCCESS (0.045s)
[134.744731] Starting dynamic subtest: ccs2
[134.783460] Dynamic subtest ccs2: SUCCESS (0.046s)
[134.790828] Starting dynamic subtest: ccs3
[134.828874] Dynamic subtest ccs3: SUCCESS (0.045s)
[134.829620] Subtest preempt-contexts: SUCCESS (0.481s)
[135.329046] [043/138] (863s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[135.467359] Starting subtest: primary-x-tiled-reflect-x-0
[145.645654] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.178s)
[145.943831] [044/138] (853s left) gem_render_tiled_blits (basic)
[146.020092] Subtest basic: SKIP (0.000s)
[146.046868] [045/138] (853s left) gem_ctx_persistence (legacy-engines-hang)
[146.107245] Starting subtest: legacy-engines-hang
[146.108184] Starting dynamic subtest: render
[146.225590] Dynamic subtest render: SUCCESS (0.118s)
[146.244489] Starting dynamic subtest: bsd1
[146.309228] Dynamic subtest bsd1: SUCCESS (0.082s)
[146.319964] Starting dynamic subtest: bsd2
[146.399408] Dynamic subtest bsd2: SUCCESS (0.088s)
[146.433236] Starting dynamic subtest: blt
[146.434801] Dynamic subtest blt: SUCCESS (0.025s)
[146.449048] Starting dynamic subtest: vebox
[146.529255] Dynamic subtest vebox: SUCCESS (0.100s)
[146.530992] Subtest legacy-engines-hang: SUCCESS (0.422s)
[146.660741] [046/138] (852s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[146.933152] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[146.935992] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.002s)
[147.105467] [047/138] (852s left) kms_chamelium_color (ctm-max)
[147.249702] Subtest ctm-max: SKIP (0.000s)
[147.273032] [048/138] (852s left) kms_writeback (writeback-invalid-parameters)
[147.457679] Subtest writeback-invalid-parameters: SKIP (0.000s)
[147.489696] [049/138] (851s left) gem_vm_create (invalid-create)
[147.535252] Starting subtest: invalid-create
[147.536970] Subtest invalid-create: SUCCESS (0.001s)
[147.649766] [050/138] (851s left) gem_mmap_gtt (basic-write-read)
[147.724194] Subtest basic-write-read: SKIP (0.000s)
[147.756800] [051/138] (851s left) gem_cs_tlb (engines)
[147.805383] Starting subtest: engines
[147.806242] Starting dynamic subtest: rcs0
[149.960587] Dynamic subtest rcs0: SUCCESS (2.152s)
[149.968187] Starting dynamic subtest: bcs0
[152.119692] Dynamic subtest bcs0: SUCCESS (2.152s)
[152.126941] Starting dynamic subtest: vcs0
[154.270787] Dynamic subtest vcs0: SUCCESS (2.151s)
[154.278131] Starting dynamic subtest: vcs1
[156.423340] Dynamic subtest vcs1: SUCCESS (2.152s)
[156.430685] Starting dynamic subtest: vecs0
[158.575640] Dynamic subtest vecs0: SUCCESS (2.152s)
[158.582938] Starting dynamic subtest: vecs1
[160.727766] Dynamic subtest vecs1: SUCCESS (2.152s)
[160.734954] Starting dynamic subtest: ccs0
[162.879271] Dynamic subtest ccs0: SUCCESS (2.151s)
[162.886413] Starting dynamic subtest: ccs1
[165.032699] Dynamic subtest ccs1: SUCCESS (2.153s)
[165.039803] Starting dynamic subtest: ccs2
[167.184423] Dynamic subtest ccs2: SUCCESS (2.151s)
[167.191482] Starting dynamic subtest: ccs3
[169.337403] Dynamic subtest ccs3: SUCCESS (2.152s)
[169.338658] Subtest engines: SUCCESS (21.522s)
[169.415418] [052/138] (829s left) gem_eio (wait-1us)
[169.731146] Starting subtest: wait-1us
[170.422113] Subtest wait-1us: SUCCESS (0.693s)
[170.570101] [053/138] (828s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[170.705264] Starting subtest: yf-tiled-32bpp-rotate-270
[170.707058] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[170.788578] [054/138] (828s left) api_intel_bb (lot-of-buffers)