[63.660765] Initializing watchdogs
[63.660945]   /dev/watchdog0
[63.676758] [001/138] (960s left) prime_mmap (test_aperture_limit)
[63.809177] Starting subtest: test_aperture_limit
[63.812213] Starting dynamic subtest: test_aperture_limit-smem
[63.823271] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.015s)
[63.826254] Subtest test_aperture_limit: SUCCESS (0.016s)
[63.905116] [002/138] (960s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[64.028252] Starting subtest: y-tiled-to-vebox-yf-tiled
[64.033941] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[64.222393] [003/138] (960s left) template (a)
[64.333316] Starting subtest: A
[64.337067] Subtest A: SUCCESS (0.000s)
[64.403673] [004/138] (959s left) vc4/vc4_wait_bo (bad-bo)
[64.571728] Subtest bad-bo: SKIP (0.000s)
[64.630580] [005/138] (959s left) kms_psr (psr2_no_drrs)
[64.743953] Subtest psr2_no_drrs: SKIP (0.000s)
[64.781270] [006/138] (959s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[64.909903] Starting subtest: basic-wc-gtt-noreloc
[64.920988] Subtest basic-wc-gtt-noreloc: SUCCESS (0.011s)
[65.083717] [007/138] (959s left) kms_flip (2x-flip-vs-rmfb)
[65.259193] Starting subtest: 2x-flip-vs-rmfb
[65.262894] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[76.308505] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.038s)
[76.320088] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[86.907054] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.597s)
[86.918825] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[97.511083] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.607s)
[97.514635] Subtest 2x-flip-vs-rmfb: SUCCESS (32.254s)
[98.246255] [008/138] (926s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[98.927290] Starting subtest: x-tiled-8bpp-rotate-90
[99.230229] Subtest x-tiled-8bpp-rotate-90: SKIP (0.280s)
[99.462916] [009/138] (925s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[100.171398] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[102.355991] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.358s)
[102.809767] [010/138] (922s left) kms_pm_rpm (modeset-non-lpsp)
[104.940494] Starting subtest: modeset-non-lpsp
[105.244183] Subtest modeset-non-lpsp: SUCCESS (0.301s)
[105.734120] [011/138] (919s left) kms_vblank (ts-continuation-dpms-rpm)
[105.928056] Starting subtest: ts-continuation-dpms-rpm
[105.931152] Starting dynamic subtest: pipe-A-HDMI-A-1
[108.037781] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.101s)
[108.063184] Starting dynamic subtest: pipe-A-HDMI-A-2
[108.973831] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.931s)
[108.990756] Starting dynamic subtest: pipe-C-HDMI-A-1
[109.661061] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.673s)
[109.675900] Starting dynamic subtest: pipe-C-HDMI-A-2
[110.582945] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.915s)
[110.586169] Subtest ts-continuation-dpms-rpm: SUCCESS (4.647s)
[110.897398] [012/138] (914s left) v3d/v3d_submit_cl (bad-multisync-extension)
[111.054593] Subtest bad-multisync-extension: SKIP (0.000s)
[111.115313] [013/138] (914s left) i915_pm_rpm (debugfs-forcewake-user)
[112.994324] Starting subtest: debugfs-forcewake-user
[123.430346] Subtest debugfs-forcewake-user: SUCCESS (10.434s)
[123.821706] [014/138] (901s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[124.013275] Starting subtest: compare-crc-sanitycheck-nv12
[124.016940] Starting dynamic subtest: pipe-A-HDMI-A-1
[124.867442] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.847s)
[124.883964] Starting dynamic subtest: pipe-B-HDMI-A-2
[125.494081] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.621s)
[125.517077] Starting dynamic subtest: pipe-C-HDMI-A-1
[126.043882] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.548s)
[126.048208] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.030s)
[126.223357] [015/138] (899s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-dg2-mc-ccs)
[126.907053] Starting subtest: pipe-C-random-ccs-data-4-tiled-dg2-mc-ccs
[126.916877] Subtest pipe-C-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[127.117886] [016/138] (898s left) prime_mmap_coherency (ioctl-errors)
[127.237412] Starting subtest: ioctl-errors
[135.427427] Subtest ioctl-errors: SUCCESS (8.189s)
[135.627807] [017/138] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[135.998347] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[136.004888] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[136.071390] [018/138] (889s left) gem_mmap_wc (bad-size)
[136.185155] Starting subtest: bad-size
[136.188498] Subtest bad-size: SUCCESS (0.001s)
[136.270723] [019/138] (889s left) gem_exec_schedule (timeslicing)
[136.429874] Starting subtest: timeslicing
[136.435510] Starting dynamic subtest: rcs0
[136.439401] Dynamic subtest rcs0: SUCCESS (0.009s)
[136.460919] Starting dynamic subtest: bcs0
[136.464164] Dynamic subtest bcs0: SUCCESS (0.007s)
[136.477375] Starting dynamic subtest: vcs0
[136.481095] Dynamic subtest vcs0: SUCCESS (0.005s)
[136.495491] Starting dynamic subtest: vecs0
[136.499410] Dynamic subtest vecs0: SUCCESS (0.005s)
[136.503615] Subtest timeslicing: SUCCESS (0.032s)
[136.789729] [020/138] (888s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-ccs)
[137.409948] Starting subtest: pipe-B-random-ccs-data-y-tiled-ccs
[137.621137] Subtest pipe-B-random-ccs-data-y-tiled-ccs: SUCCESS (0.210s)
[138.060253] [021/138] (887s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[138.273771] Starting subtest: fbc-indfb-scaledprimary
[141.712527] Subtest fbc-indfb-scaledprimary: SUCCESS (3.444s)
[142.037158] [022/138] (883s left) gen9_exec_parse (bb-start-param)
[142.172330] Starting subtest: bb-start-param
[142.175558] Subtest bb-start-param: SUCCESS (0.004s)
[142.391432] [023/138] (883s left) gem_mmap_gtt (cpuset-basic-small-copy)
[142.500675] Starting subtest: cpuset-basic-small-copy
[146.478071] Subtest cpuset-basic-small-copy: SUCCESS (3.979s)
[146.559646] [024/138] (878s left) kms_psr2_sf (plane-move-sf-dmg-area)
[146.771833] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[146.808730] [025/138] (878s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[146.937374] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[147.049089] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.109s)
[147.140242] [026/138] (878s left) gem_exec_store (pages)
[147.272137] Starting subtest: pages
[147.275890] Starting dynamic subtest: rcs0
[147.341461] Dynamic subtest rcs0: SUCCESS (0.067s)
[147.356910] Starting dynamic subtest: bcs0
[147.408808] Dynamic subtest bcs0: SUCCESS (0.065s)
[147.423290] Starting dynamic subtest: vcs0
[147.477471] Dynamic subtest vcs0: SUCCESS (0.065s)
[147.493151] Starting dynamic subtest: vecs0
[147.544232] Dynamic subtest vecs0: SUCCESS (0.067s)
[147.547593] Subtest pages: SUCCESS (0.273s)
[147.740263] [027/138] (877s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[147.966158] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[147.973146] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[148.039772] [028/138] (877s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[148.254147] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[148.260336] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[148.337433] [029/138] (877s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[148.522124] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[148.530016] Starting dynamic subtest: A-HDMI-A1
[154.542848] Dynamic subtest A-HDMI-A1: SUCCESS (6.010s)
[154.573315] Starting dynamic subtest: B-HDMI-A1
[160.270988] Dynamic subtest B-HDMI-A1: SUCCESS (5.726s)
[160.286614] Starting dynamic subtest: C-HDMI-A1
[165.829089] Dynamic subtest C-HDMI-A1: SUCCESS (5.555s)
[165.848415] Starting dynamic subtest: A-HDMI-A2
[171.616676] Dynamic subtest A-HDMI-A2: SUCCESS (5.783s)
[171.631290] Starting dynamic subtest: B-HDMI-A2
[177.259332] Dynamic subtest B-HDMI-A2: SUCCESS (5.641s)
[177.274668] Starting dynamic subtest: C-HDMI-A2
[182.923976] Dynamic subtest C-HDMI-A2: SUCCESS (5.656s)
[182.926948] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (34.396s)
[183.290920] [030/138] (842s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-mc-ccs)
[183.881465] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-mc-ccs
[183.890592] Subtest pipe-A-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[184.204519] [031/138] (841s left) gem_flink_basic (flink-lifetime)
[184.317991] Starting subtest: flink-lifetime
[184.321275] Subtest flink-lifetime: SUCCESS (0.002s)
[184.402504] [032/138] (841s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[184.616122] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[184.621947] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[184.702385] [033/138] (841s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[184.817245] Starting subtest: invalid-multi-wait-all-unsubmitted
[184.820500] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[184.904343] [034/138] (840s left) kms_chamelium_hpd (dp-hpd-fast)
[185.456286] Subtest dp-hpd-fast: SKIP (0.000s)
[185.609338] [035/138] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[185.827939] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[185.833379] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[185.912492] [036/138] (840s left) perf (invalid-oa-metric-set-id)
[186.156635] Starting subtest: invalid-oa-metric-set-id
[186.182098] Subtest invalid-oa-metric-set-id: SUCCESS (0.024s)
[186.229596] [037/138] (839s left) gem_eio (in-flight-internal-immediate)
[186.363784] Starting subtest: in-flight-internal-immediate
[186.466423] Subtest in-flight-internal-immediate: SUCCESS (0.099s)
[186.644301] [038/138] (839s left) kms_cursor_crc (cursor-onscreen-64x21)
[186.845555] Starting subtest: cursor-onscreen-64x21
[186.898634] Starting dynamic subtest: pipe-A-HDMI-A-1
[189.536987] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.631s)
[189.601364] Starting dynamic subtest: pipe-C-HDMI-A-1
[191.863768] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.288s)
[191.869170] Subtest cursor-onscreen-64x21: SUCCESS (5.016s)
[192.092301] [039/138] (833s left) i915_pm_rpm (gem-pread)
[194.008932] Starting subtest: gem-pread
[194.613246] Subtest gem-pread: SUCCESS (0.605s)
[195.011494] [040/138] (831s left) kms_feature_discovery (display)
[195.205504] Starting subtest: display
[195.210478] Subtest display: SUCCESS (0.000s)
[195.291484] [041/138] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[195.506357] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[198.083686] Subtest fbc-2p-scndscrn-spr-indfb-move: SUCCESS (2.588s)
[198.254629] [042/138] (827s left) gem_exec_schedule (preempt-contexts)
[198.414395] Starting subtest: preempt-contexts
[198.417809] Starting dynamic subtest: rcs0
[198.494843] Dynamic subtest rcs0: SUCCESS (0.085s)
[198.514849] Starting dynamic subtest: bcs0
[198.596630] Dynamic subtest bcs0: SUCCESS (0.102s)
[198.623631] Starting dynamic subtest: vcs0
[198.693607] Dynamic subtest vcs0: SUCCESS (0.089s)
[198.711602] Starting dynamic subtest: vecs0
[198.776909] Dynamic subtest vecs0: SUCCESS (0.080s)
[198.780780] Subtest preempt-contexts: SUCCESS (0.372s)
[199.103410] [043/138] (827s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[199.288969] Starting subtest: primary-x-tiled-reflect-x-0
[199.296914] Subtest primary-x-tiled-reflect-x-0: SKIP (0.004s)
[199.383744] [044/138] (826s left) gem_render_tiled_blits (basic)
[199.505135] Starting subtest: basic
[199.577319] Subtest basic: SUCCESS (0.072s)
[199.635910] [045/138] (826s left) gem_ctx_persistence (legacy-engines-hang)
[199.759153] Starting subtest: legacy-engines-hang
[199.762862] Starting dynamic subtest: render
[199.792539] Dynamic subtest render: SUCCESS (0.041s)
[199.816756] Starting dynamic subtest: bsd
[199.820754] Dynamic subtest bsd: SUCCESS (0.022s)
[199.837256] Starting dynamic subtest: blt
[199.846614] Dynamic subtest blt: SKIP (0.003s)
[199.863583] Starting dynamic subtest: vebox
[199.867056] Dynamic subtest vebox: SUCCESS (0.026s)
[199.870281] Subtest legacy-engines-hang: SUCCESS (0.106s)
[199.948369] [046/138] (826s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[200.665359] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[200.671670] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s)
[200.864505] [047/138] (825s left) kms_chamelium_color (ctm-max)
[201.060791] Subtest ctm-max: SKIP (0.000s)
[201.114824] [048/138] (825s left) kms_writeback (writeback-invalid-parameters)
[201.394682] Subtest writeback-invalid-parameters: SKIP (0.000s)
[201.451687] [049/138] (824s left) gem_vm_create (invalid-create)
[201.571319] Starting subtest: invalid-create
[201.575575] Subtest invalid-create: SUCCESS (0.001s)
[201.660996] [050/138] (824s left) gem_mmap_gtt (basic-write-read)
[201.770875] Starting subtest: basic-write-read
[201.780291] Subtest basic-write-read: SUCCESS (0.008s)
[201.864823] [051/138] (824s left) gem_cs_tlb (engines)
[201.986055] Starting subtest: engines
[201.989105] Starting dynamic subtest: rcs0
[204.151840] Dynamic subtest rcs0: SUCCESS (2.160s)
[204.168268] Starting dynamic subtest: bcs0
[206.318761] Dynamic subtest bcs0: SUCCESS (2.162s)
[206.337153] Starting dynamic subtest: vcs0
[208.478928] Dynamic subtest vcs0: SUCCESS (2.159s)
[208.497188] Starting dynamic subtest: vecs0
[210.640598] Dynamic subtest vecs0: SUCCESS (2.160s)
[210.643654] Subtest engines: SUCCESS (8.652s)
[210.732669] [052/138] (815s left) gem_eio (wait-1us)
[210.865810] Starting subtest: wait-1us
[210.954554] Subtest wait-1us: SUCCESS (0.090s)
[211.130658] [053/138] (815s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[211.339560] Starting subtest: yf-tiled-32bpp-rotate-270
[214.410703] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (3.073s)
[214.917604] [054/138] (811s left) api_intel_bb (lot-of-buffers)