[41.962193] Initializing watchdogs
[41.962505]   /dev/watchdog0
[41.978236] [001/138] (960s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-mc-ccs)
[42.660966] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs
[42.663734] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[43.038575] [002/138] (959s left) kms_cursor_crc (cursor-onscreen-128x42)
[43.293849] Starting subtest: cursor-onscreen-128x42
[43.306284] Starting dynamic subtest: pipe-A-DP-1
[45.883238] Dynamic subtest pipe-A-DP-1: SUCCESS (2.576s)
[45.963865] Starting dynamic subtest: pipe-C-DP-1
[48.396224] Dynamic subtest pipe-C-DP-1: SUCCESS (2.442s)
[48.397804] Subtest cursor-onscreen-128x42: SUCCESS (5.101s)
[48.741331] [003/138] (953s left) syncobj_wait (single-wait-all-submitted)
[48.887619] Starting subtest: single-wait-all-submitted
[48.993112] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[49.069202] [004/138] (953s left) api_intel_allocator (two-level-inception-interruptible)
[49.209067] Starting subtest: two-level-inception-interruptible
[54.765974] Subtest two-level-inception-interruptible: SUCCESS (5.555s)
[54.837679] [005/138] (947s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[54.980568] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[54.982881] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[55.054744] [006/138] (947s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation)
[55.293690] Starting subtest: plane-downscale-factor-0-25-with-rotation
[55.299994] Starting dynamic subtest: pipe-A-DP-1
[55.351325] Dynamic subtest pipe-A-DP-1: SKIP (0.047s)
[55.370641] Starting dynamic subtest: pipe-B-DP-1
[55.466478] Dynamic subtest pipe-B-DP-1: SKIP (0.107s)
[55.484476] Starting dynamic subtest: pipe-C-DP-1
[55.571604] Dynamic subtest pipe-C-DP-1: SKIP (0.099s)
[55.577387] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.279s)
[55.670166] [007/138] (947s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[55.819471] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[55.820812] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[55.904183] [008/138] (946s left) gem_exec_whisper (basic-fds-forked)
[56.080364] Starting subtest: basic-fds-forked
[74.492404] Subtest basic-fds-forked: SUCCESS (18.411s)
[74.704156] [009/138] (928s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[75.033669] Starting subtest: cursor-vs-flip-atomic
[113.569268] Subtest cursor-vs-flip-atomic: SUCCESS (38.539s)
[113.906501] [010/138] (888s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[114.144746] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[114.146175] Starting dynamic subtest: pipe-A-valid-mode
[114.281626] Dynamic subtest pipe-A-valid-mode: SKIP (0.134s)
[114.285436] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.136s)
[114.614765] [011/138] (888s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[114.849170] Starting subtest: plane-upscale-factor-0-25-with-rotation
[114.857430] Starting dynamic subtest: pipe-A-DP-1
[114.921183] Dynamic subtest pipe-A-DP-1: SKIP (0.062s)
[114.942864] Starting dynamic subtest: pipe-B-DP-1
[115.280999] Dynamic subtest pipe-B-DP-1: SKIP (0.352s)
[115.306303] Starting dynamic subtest: pipe-C-DP-1
[115.630479] Dynamic subtest pipe-C-DP-1: SKIP (0.339s)
[115.633033] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (0.780s)
[116.028960] [012/138] (886s left) prime_self_import (basic-with_one_bo)
[116.165615] Starting subtest: basic-with_one_bo
[116.173104] Subtest basic-with_one_bo: SUCCESS (0.008s)
[116.263124] [013/138] (886s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-mc-ccs)
[116.707809] Starting subtest: pipe-C-bad-rotation-90-4-tiled-dg2-mc-ccs
[116.710344] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[117.055509] [014/138] (885s left) gem_exec_balancer (full-late-pulse)
[117.223213] Starting subtest: full-late-pulse
[121.269997] Subtest full-late-pulse: SUCCESS (4.049s)
[125.222687] [015/138] (877s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[125.701144] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[126.008988] [016/138] (877s left) gem_eio (wait-immediate)
[126.181288] Starting subtest: wait-immediate
[126.245386] Subtest wait-immediate: SUCCESS (0.067s)
[126.458587] [017/138] (876s left) i915_pm_rc6_residency (rc6-idle)
[126.597805] Starting subtest: rc6-idle
[126.606602] Starting dynamic subtest: rcs0
[138.888407] Dynamic subtest rcs0: SUCCESS (12.282s)
[138.904440] Starting dynamic subtest: bcs0
[151.161484] Dynamic subtest bcs0: SUCCESS (12.273s)
[151.177874] Starting dynamic subtest: vcs0
[163.445538] Dynamic subtest vcs0: SUCCESS (12.283s)
[163.461662] Starting dynamic subtest: vecs0
[175.728793] Dynamic subtest vecs0: SUCCESS (12.280s)
[175.730303] Subtest rc6-idle: SUCCESS (49.129s)
[176.011224] [018/138] (827s left) kms_feature_discovery (display)
[176.248488] Starting subtest: display
[176.249939] Subtest display: SUCCESS (0.000s)
[176.326551] [019/138] (826s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[176.592157] Starting subtest: y-tiled-16bpp-rotate-270
[176.684375] Subtest y-tiled-16bpp-rotate-270: SKIP (0.090s)
[176.792114] [020/138] (826s left) gem_userptr_blits (readonly-unsync)
[176.945471] Subtest readonly-unsync: SKIP (0.000s)
[177.111120] [021/138] (826s left) perf_pmu (rc6-suspend)
[177.253816] Starting subtest: rc6-suspend
[200.273759] Subtest rc6-suspend: SUCCESS (7.921s)
[201.697676] [022/138] (817s left) gem_mmap_gtt (hang-user)
[201.838205] Starting subtest: hang-user
[217.313828] Subtest hang-user: SUCCESS (15.474s)
[217.419325] [023/138] (801s left) kms_addfb_basic (too-high)
[217.661049] Starting subtest: too-high
[217.662464] Subtest too-high: SUCCESS (0.002s)
[217.751775] [024/138] (801s left) i915_query (hwconfig_table)
[217.891090] Starting subtest: hwconfig_table
[217.893863] Subtest hwconfig_table: SKIP (0.000s)
[217.972397] [025/138] (801s left) gem_wait (busy)
[218.152231] Starting subtest: busy
[218.153802] Starting dynamic subtest: all-engines
[218.685836] Dynamic subtest all-engines: SUCCESS (0.529s)
[218.708988] Starting dynamic subtest: rcs0
[219.207764] Dynamic subtest rcs0: SUCCESS (0.522s)
[219.227927] Starting dynamic subtest: bcs0
[219.727722] Dynamic subtest bcs0: SUCCESS (0.521s)
[219.748077] Starting dynamic subtest: vcs0
[220.248348] Dynamic subtest vcs0: SUCCESS (0.519s)
[220.268638] Starting dynamic subtest: vecs0
[220.764254] Dynamic subtest vecs0: SUCCESS (0.516s)
[220.765648] Subtest busy: SUCCESS (2.612s)
[221.024801] [026/138] (798s left) gem_exec_schedule (semaphore-user)
[221.197228] Starting subtest: semaphore-user
[221.213811] Subtest semaphore-user: SUCCESS (0.016s)
[221.570280] [027/138] (797s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-ccs)
[222.038835] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-ccs
[222.043599] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.004s)
[222.369401] [028/138] (797s left) gem_exec_flush (basic-wb-rw-default)
[222.538698] Starting subtest: basic-wb-rw-default
[228.010818] Subtest basic-wb-rw-default: SUCCESS (5.471s)
[228.217933] [029/138] (791s left) kms_cursor_crc (cursor-sliding-32x10)
[228.460700] Starting subtest: cursor-sliding-32x10
[228.578300] Subtest cursor-sliding-32x10: SKIP (0.115s)
[228.707422] [030/138] (790s left) gem_ctx_persistence (legacy-engines-mixed-process)
[228.855055] Starting subtest: legacy-engines-mixed-process
[228.856639] Starting dynamic subtest: render
[229.237704] Dynamic subtest render: SUCCESS (0.381s)
[229.258722] Starting dynamic subtest: bsd
[229.586116] Dynamic subtest bsd: SUCCESS (0.347s)
[229.607797] Starting dynamic subtest: blt
[229.947428] Dynamic subtest blt: SUCCESS (0.360s)
[229.968483] Starting dynamic subtest: vebox
[230.300061] Dynamic subtest vebox: SUCCESS (0.351s)
[230.301534] Subtest legacy-engines-mixed-process: SUCCESS (1.445s)
[230.385757] [031/138] (789s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[230.548527] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[230.551112] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[230.751383] [032/138] (788s left) gem_userptr_blits (dmabuf-sync)
[230.932218] Starting subtest: dmabuf-sync
[230.940699] Subtest dmabuf-sync: SKIP (0.007s)
[231.089158] [033/138] (788s left) gem_close_race (basic-process)
[231.255921] Starting subtest: basic-process
[231.354396] Subtest basic-process: SUCCESS (0.099s)
[231.552428] [034/138] (788s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[231.904188] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[231.906887] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.001s)
[232.365409] [035/138] (787s left) gen9_exec_parse (cmd-crossing-page)
[232.532862] Starting subtest: cmd-crossing-page
[232.539957] Subtest cmd-crossing-page: SUCCESS (0.007s)
[232.762536] [036/138] (787s left) gem_set_tiling_vs_pwrite
[233.032316] [037/138] (786s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[233.512478] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[233.847788] [038/138] (786s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[234.107793] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[234.141445] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.032s)
[234.250852] [039/138] (785s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[234.513755] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[234.516374] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[234.611404] [040/138] (785s left) syncobj_timeline (32bits-limit)
[234.754314] Starting subtest: 32bits-limit
[234.755788] Subtest 32bits-limit: SUCCESS (0.003s)
[234.846887] [041/138] (785s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[235.089016] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[235.091473] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[235.179825] [042/138] (784s left) kms_cursor_legacy (torture-move)
[235.414627] Starting subtest: torture-move
[235.415954] Starting dynamic subtest: pipe-A
[241.015798] Dynamic subtest pipe-A: SUCCESS (5.600s)
[241.040841] Starting dynamic subtest: pipe-B
[246.617222] Dynamic subtest pipe-B: SUCCESS (5.601s)
[246.639027] Starting dynamic subtest: pipe-C
[252.187194] Dynamic subtest pipe-C: SUCCESS (5.566s)
[252.208384] Starting dynamic subtest: all-pipes
[257.769119] Dynamic subtest all-pipes: SUCCESS (5.582s)
[257.770873] Subtest torture-move: SUCCESS (22.353s)
[257.862868] [043/138] (762s left) gem_unref_active_buffers
[258.262741] [044/138] (761s left) gem_exec_balancer (parallel-keep-submit-fence)
[262.352505] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[262.446915] [045/138] (757s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[262.691614] Starting subtest: psr-rgb101010-draw-mmap-wc
[262.694225] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[262.797012] [046/138] (757s left) syncobj_timeline (host-signal-points)
[262.937277] Starting subtest: host-signal-points
[262.955735] Subtest host-signal-points: SUCCESS (0.019s)
[263.049201] [047/138] (757s left) gem_exec_fence (syncobj-timeline-chain-engines)
[263.875950] Starting subtest: syncobj-timeline-chain-engines
[264.007658] Subtest syncobj-timeline-chain-engines: SUCCESS (0.132s)
[264.246679] [048/138] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[264.491761] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[264.494376] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[264.596395] [049/138] (755s left) kms_prop_blob (basic)
[264.737743] Starting subtest: basic
[264.739266] Subtest basic: SUCCESS (0.000s)
[264.829132] [050/138] (755s left) api_intel_bb (object-noreloc-purge-cache-simple)
[264.971906] Starting subtest: object-noreloc-purge-cache-simple
[264.979436] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.008s)
[265.096459] [051/138] (755s left) gem_softpin (zero)
[265.248184] Starting subtest: zero
[265.255327] Subtest zero: SUCCESS (0.007s)
[265.362304] [052/138] (755s left) gem_ctx_param (vm)
[265.505186] Starting subtest: vm
[265.573875] Subtest vm: SUCCESS (0.065s)
[265.680229] [053/138] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[265.932820] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[268.357319] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.428s)
[268.498029] [054/138] (752s left) syncobj_timeline (signal)
[268.638064] Starting subtest: signal
[268.639467] Subtest signal: SUCCESS (0.000s)
[268.731116] [055/138] (751s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[268.972336] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[268.975155] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[269.062886] [056/138] (751s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[269.325214] Starting subtest: x-tiled-8bpp-rotate-180
[272.240561] Subtest x-tiled-8bpp-rotate-180: SUCCESS (2.914s)
[272.482699] [057/138] (748s left) perf_pmu (busy)
[272.631352] Starting subtest: busy
[272.632989] Starting dynamic subtest: rcs0
[273.171282] Dynamic subtest rcs0: SUCCESS (0.542s)
[273.194235] Starting dynamic subtest: bcs0
[273.709233] Dynamic subtest bcs0: SUCCESS (0.537s)
[273.732576] Starting dynamic subtest: vcs0
[274.254748] Dynamic subtest vcs0: SUCCESS (0.542s)
[274.276682] Starting dynamic subtest: vecs0
[274.793061] Dynamic subtest vecs0: SUCCESS (0.540s)
[274.794530] Subtest busy: SUCCESS (2.164s)
[274.881597] [058/138] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[275.127661] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[277.706994] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.581s)
[277.863149] [059/138] (742s left) kms_pm_rpm (i2c)
[279.578518] Starting subtest: i2c
[281.409938] Subtest i2c: SUCCESS (1.828s)
[281.592176] [060/138] (739s left) gem_softpin (noreloc-interruptible)
[281.745850] Starting subtest: noreloc-interruptible
[287.287348] Subtest noreloc-interruptible: SUCCESS (5.538s)
[287.408712] [061/138] (733s left) prime_mmap_kms (buffer-sharing)
[287.640146] Starting subtest: buffer-sharing
[287.914011] Subtest buffer-sharing: SUCCESS (0.275s)
[288.256262] [062/138] (732s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[288.517029] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[288.519921] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[288.622594] [063/138] (732s left) prime_udl
[288.823748] [064/138] (732s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[289.065390] Starting subtest: cursor-rapid-movement-32x32
[289.197035] Subtest cursor-rapid-movement-32x32: SKIP (0.128s)
[289.322935] [065/138] (731s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[289.515468] Subtest mark-purgeable-twice: SKIP (0.000s)
[289.588869] [066/138] (731s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-rc-ccs)
[289.994459] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs
[289.996955] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[290.373506] [067/138] (730s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[290.614867] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[290.617437] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[290.724156] [068/138] (730s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[291.063982] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[291.355992] [069/138] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[291.605501] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[291.608357] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.717888] [070/138] (729s left) gem_exec_reloc (basic-cpu-wc)
[291.870299] Starting subtest: basic-cpu-wc
[291.891178] Subtest basic-cpu-wc: SUCCESS (0.021s)
[292.082413] [071/138] (729s left) sysfs_heartbeat_interval (precise)
[292.233123] Starting subtest: precise
[292.235169] Starting dynamic subtest: vecs0
[293.741098] Dynamic subtest vecs0: SUCCESS (1.507s)
[293.765967] Starting dynamic subtest: vcs0
[295.248306] Dynamic subtest vcs0: SUCCESS (1.504s)
[295.270505] Starting dynamic subtest: bcs0
[296.734195] Dynamic subtest bcs0: SUCCESS (1.484s)
[296.757864] Starting dynamic subtest: rcs0
[298.222449] Dynamic subtest rcs0: SUCCESS (1.486s)
[298.223940] Subtest precise: SUCCESS (5.989s)
[298.317475] [072/138] (723s left) gem_exec_schedule (promotion)
[298.488503] Starting subtest: promotion
[298.490106] Starting dynamic subtest: rcs0
[298.634825] Dynamic subtest rcs0: SUCCESS (0.145s)
[298.662474] Starting dynamic subtest: bcs0
[298.796650] Dynamic subtest bcs0: SUCCESS (0.158s)
[298.821197] Starting dynamic subtest: vcs0
[298.936819] Dynamic subtest vcs0: SUCCESS (0.138s)
[298.961165] Starting dynamic subtest: vecs0
[299.071240] Dynamic subtest vecs0: SUCCESS (0.136s)
[299.072893] Subtest promotion: SUCCESS (0.583s)
[299.419442] [073/138] (722s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[299.657565] Starting subtest: basic-flip-after-cursor-varying-size
[300.740435] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.083s)
[301.079858] [074/138] (720s left) tools_test (sysfs_l3_parity)
[301.223688] Starting subtest: sysfs_l3_parity
[301.403834] Subtest sysfs_l3_parity: SKIP (0.186s)
[301.475719] [075/138] (720s left) kms_invalid_mode (bad-vtotal)
[301.709310] Starting subtest: bad-vtotal
[301.711951] Starting dynamic subtest: pipe-A-DP-1
[301.798787] Dynamic subtest pipe-A-DP-1: SUCCESS (0.089s)
[301.825413] Starting dynamic subtest: pipe-B-DP-1
[301.827400] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[301.863307] Starting dynamic subtest: pipe-C-DP-1
[301.865232] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s)
[301.867167] Subtest bad-vtotal: SUCCESS (0.102s)
[302.137328] [076/138] (719s left) kms_flip (nonblocking-read)
[302.368737] Starting subtest: nonblocking-read
[302.370190] Subtest nonblocking-read: SUCCESS (0.000s)
[302.487624] [077/138] (719s left) kms_getfb (getfb2-into-addfb2)
[302.629452] Starting subtest: getfb2-into-addfb2
[302.631155] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[302.738074] [078/138] (718s left) drm_fdinfo (most-busy-idle-check-all)
[302.885684] Starting subtest: most-busy-idle-check-all
[302.887015] Starting dynamic subtest: rcs0
[303.514431] Dynamic subtest rcs0: SUCCESS (0.629s)
[303.540979] Starting dynamic subtest: bcs0
[304.142334] Dynamic subtest bcs0: SUCCESS (0.627s)
[304.169220] Starting dynamic subtest: vcs0
[304.766313] Dynamic subtest vcs0: SUCCESS (0.623s)
[304.793148] Starting dynamic subtest: vecs0
[305.389460] Dynamic subtest vecs0: SUCCESS (0.622s)
[305.391040] Subtest most-busy-idle-check-all: SUCCESS (2.505s)
[305.472722] [079/138] (716s left) kms_addfb_basic (unused-handle)
[305.619602] Starting subtest: unused-handle
[305.620922] Subtest unused-handle: SUCCESS (0.000s)
[305.820681] [080/138] (715s left) kms_chamelium_frames (dp-crc-multiple)
[306.161457] Subtest dp-crc-multiple: SKIP (0.000s)
[306.459465] [081/138] (715s left) i915_query (query-topology-garbage-items)
[306.596386] Starting subtest: query-topology-garbage-items
[306.598207] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[306.678694] [082/138] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[306.927385] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[306.930184] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[307.028957] [083/138] (714s left) gem_exec_nop (basic-parallel)
[307.195222] Starting subtest: basic-parallel
[310.351276] Subtest basic-parallel: SUCCESS (3.155s)
[310.579684] [084/138] (711s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[310.723674] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[310.778752] [085/138] (711s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[311.027732] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[311.030430] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[311.129200] [086/138] (710s left) kms_content_protection (content-type-change)
[311.405015] Starting subtest: content-type-change
[312.102868] Subtest content-type-change: SKIP (0.697s)
[312.528598] [087/138] (709s left) gem_exec_whisper (basic-sync-all)
[312.696670] Starting subtest: basic-sync-all
[321.478389] Subtest basic-sync-all: SUCCESS (8.780s)
[321.700933] [088/138] (700s left) gem_shrink (reclaim)
[321.848471] Starting subtest: reclaim
[324.147957] Subtest reclaim: SUCCESS (2.299s)
[324.228853] [089/138] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[324.474139] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[324.476809] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[324.580074] [090/138] (697s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-mc-ccs)
[324.956681] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs
[324.959439] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s)
[325.378039] [091/138] (696s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[325.637751] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[325.655847] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.020s)
[325.764263] [092/138] (696s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[326.000167] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[326.007958] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.004s)
[326.112464] [093/138] (696s left) gem_render_copy_redux (flink)
[326.267961] Starting subtest: flink
[331.028097] Subtest flink: SUCCESS (4.760s)
[331.148692] [094/138] (691s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[331.394883] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[331.398236] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[331.500817] [095/138] (690s left) perf (unprivileged-single-ctx-counters)
[331.753558] Starting subtest: unprivileged-single-ctx-counters
[331.756169] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[331.811686] [096/138] (690s left) gem_mmap_wc (bad-size)
[331.952235] Starting subtest: bad-size
[331.954043] Subtest bad-size: SUCCESS (0.001s)
[332.044478] [097/138] (690s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[332.183063] Starting subtest: invalid-multi-wait-all-unsubmitted
[332.184915] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[332.278133] [098/138] (690s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[332.508645] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[332.509917] Starting dynamic subtest: pipe-A-valid-mode
[333.188900] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.677s)
[333.190241] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.680s)
[333.541055] [099/138] (689s left) gem_busy (semaphore)
[333.852027] Starting subtest: semaphore
[333.853602] Starting dynamic subtest: rcs0
[333.892613] Dynamic subtest rcs0: SUCCESS (0.040s)
[333.918142] Starting dynamic subtest: bcs0
[333.927879] Dynamic subtest bcs0: SUCCESS (0.033s)
[333.953165] Starting dynamic subtest: vcs0
[333.954525] Dynamic subtest vcs0: SUCCESS (0.025s)
[333.978846] Starting dynamic subtest: vecs0
[333.983406] Dynamic subtest vecs0: SUCCESS (0.028s)
[333.985668] Subtest semaphore: SUCCESS (0.133s)
[334.224809] [100/138] (688s left) perf (invalid-remove-userspace-config)
[334.466242] Starting subtest: invalid-remove-userspace-config
[334.507389] Subtest invalid-remove-userspace-config: SUCCESS (0.039s)
[334.560745] [101/138] (688s left) vc4/vc4_perfmon (create-perfmon-invalid-events)
[334.749750] Subtest create-perfmon-invalid-events: SKIP (0.000s)
[334.822748] [102/138] (687s left) gem_exec_schedule (implicit-write-read)
[334.991440] Starting subtest: implicit-write-read
[334.992963] Starting dynamic subtest: rcs0
[335.130030] Dynamic subtest rcs0: SUCCESS (0.136s)
[335.158998] Starting dynamic subtest: bcs0
[335.270855] Dynamic subtest bcs0: SUCCESS (0.138s)
[335.296625] Starting dynamic subtest: vcs0
[335.401021] Dynamic subtest vcs0: SUCCESS (0.126s)
[335.426638] Starting dynamic subtest: vecs0
[335.531864] Dynamic subtest vecs0: SUCCESS (0.129s)
[335.533903] Subtest implicit-write-read: SUCCESS (0.539s)
[335.907886] [103/138] (686s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[336.046276] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[336.109048] [104/138] (686s left) kms_vblank (ts-continuation-idle-hang)
[336.348901] Starting subtest: ts-continuation-idle-hang
[336.352771] Starting dynamic subtest: pipe-A-DP-1
[343.077964] Dynamic subtest pipe-A-DP-1: SUCCESS (6.726s)
[343.104947] Starting dynamic subtest: pipe-C-DP-1
[350.057495] Dynamic subtest pipe-C-DP-1: SUCCESS (6.972s)
[350.059227] Subtest ts-continuation-idle-hang: SUCCESS (13.709s)
[350.406199] [105/138] (672s left) v3d/v3d_submit_cl (single-in-sync)
[350.611293] Subtest single-in-sync: SKIP (0.000s)
[350.685181] [106/138] (672s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[350.928176] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[350.930825] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[351.035803] [107/138] (671s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-mc-ccs)
[351.379759] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs
[351.382670] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[351.850877] [108/138] (671s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[352.230969] Starting subtest: pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[352.233766] Subtest pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[352.656026] [109/138] (670s left) gem_userptr_blits (sync-overlap)
[352.835962] Starting subtest: sync-overlap
[352.837398] Subtest sync-overlap: SUCCESS (0.000s)
[352.974102] [110/138] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[353.224816] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[353.227424] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[353.338679] [111/138] (669s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[353.498491] Starting subtest: yf-tiled-to-vebox-x-tiled
[353.501143] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[353.705240] [112/138] (669s left) syncobj_basic (test-valid-cycle)
[353.842587] Starting subtest: test-valid-cycle
[353.843952] Subtest test-valid-cycle: SUCCESS (0.000s)
[353.938953] [113/138] (669s left) kms_ccs (pipe-a-bad-pixel-format-yf-tiled-ccs)
[354.181480] Starting subtest: pipe-A-bad-pixel-format-yf-tiled-ccs
[354.183082] Subtest pipe-A-bad-pixel-format-yf-tiled-ccs: SUCCESS (0.001s)
[354.746921] [114/138] (668s left) kms_async_flips (invalid-async-flip)
[354.987799] Starting subtest: invalid-async-flip
[355.164900] Starting dynamic subtest: pipe-A-DP-1
[355.548690] Dynamic subtest pipe-A-DP-1: SUCCESS (0.381s)
[355.748980] Starting dynamic subtest: pipe-B-DP-1
[355.988103] Dynamic subtest pipe-B-DP-1: SUCCESS (0.272s)
[356.186259] Starting dynamic subtest: pipe-C-DP-1
[356.418836] Dynamic subtest pipe-C-DP-1: SUCCESS (0.270s)
[356.420898] Subtest invalid-async-flip: SUCCESS (1.434s)
[356.888685] [115/138] (666s left) gem_exec_await (wide-all)
[357.231280] Starting subtest: wide-all
[380.532459] Subtest wide-all: SUCCESS (23.302s)
[380.765251] [116/138] (642s left) v3d/v3d_perfmon (create-single-perfmon)
[381.081109] Subtest create-single-perfmon: SKIP (0.000s)
[381.155941] [117/138] (642s left) kms_psr (psr2_sprite_mmap_gtt)
[381.299929] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[381.356756] [118/138] (642s left) syncobj_wait (invalid-signal-illegal-handle)
[381.497230] Starting subtest: invalid-signal-illegal-handle
[381.499005] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[381.587894] [119/138] (641s left) v3d/v3d_submit_csd (valid-submission)
[381.797485] Subtest valid-submission: SKIP (0.000s)
[381.870829] [120/138] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[382.128120] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[382.130859] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[382.237739] [121/138] (641s left) fbdev (pan)
[382.377439] Starting subtest: pan
[382.428765] Subtest pan: SUCCESS (0.050s)
[382.521808] [122/138] (641s left) i915_query (query-garbage)
[382.663385] Starting subtest: query-garbage
[382.665279] Subtest query-garbage: SUCCESS (0.000s)
[382.755192] [123/138] (640s left) gem_pxp (create-regular-context-2)
[385.423314] Subtest create-regular-context-2: SKIP (0.000s)
[385.504161] [124/138] (638s left) kms_flip (2x-wf_vblank-ts-check)
[385.732139] Starting subtest: 2x-wf_vblank-ts-check
[385.734959] Subtest 2x-wf_vblank-ts-check: SKIP (0.003s)
[385.855442] [125/138] (637s left) kms_plane_alpha_blend (alpha-transparent-fb)
[386.098587] Starting subtest: alpha-transparent-fb
[386.424342] Starting dynamic subtest: pipe-A-DP-1
[387.218709] Dynamic subtest pipe-A-DP-1: FAIL (0.420s)
[387.243482] Starting dynamic subtest: pipe-C-DP-1
[387.874807] Dynamic subtest pipe-C-DP-1: FAIL (0.661s)
[387.876214] Subtest alpha-transparent-fb: FAIL (1.414s)
[387.959123] [126/138] (635s left) syncobj_timeline (host-signal-ordered)
[388.106574] Starting subtest: host-signal-ordered
[388.108433] Subtest host-signal-ordered: SUCCESS (0.001s)
[388.199991] [127/138] (635s left) kms_busy (extended-modeset-hang-oldfb)
[388.457093] Starting subtest: extended-modeset-hang-oldfb
[388.461411] Starting dynamic subtest: pipe-A
[396.442290] Dynamic subtest pipe-A: SUCCESS (7.981s)
[396.472201] Starting dynamic subtest: pipe-C
[404.452464] Dynamic subtest pipe-C: SUCCESS (8.004s)
[404.456804] Subtest extended-modeset-hang-oldfb: SUCCESS (15.998s)
[404.818694] [128/138] (619s left) kms_flip (2x-flip-vs-panning)
[405.049854] Starting subtest: 2x-flip-vs-panning
[405.056930] Subtest 2x-flip-vs-panning: SKIP (0.003s)
[405.184275] [129/138] (618s left) gem_exec_fence (nb-await)
[405.492411] Starting subtest: nb-await
[405.494371] Starting dynamic subtest: rcs0
[405.568057] Dynamic subtest rcs0: SUCCESS (0.074s)
[405.597650] Starting dynamic subtest: bcs0
[405.647264] Dynamic subtest bcs0: SUCCESS (0.075s)
[405.676791] Starting dynamic subtest: vcs0
[405.717984] Dynamic subtest vcs0: SUCCESS (0.069s)
[405.750263] Starting dynamic subtest: vecs0
[405.790972] Dynamic subtest vecs0: SUCCESS (0.069s)
[405.792538] Subtest nb-await: SUCCESS (0.299s)
[406.468808] [130/138] (617s left) kms_chamelium_color (ctm-0-50)
[406.703722] Subtest ctm-0-50: SKIP (0.000s)
[406.766387] [131/138] (617s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[407.005245] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[448.801284] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (41.794s)
[449.143646] [132/138] (574s left) kms_plane (pixel-format)
[449.392924] Starting subtest: pixel-format
[449.394248] Starting dynamic subtest: pipe-A
[456.193149] Dynamic subtest pipe-A: SUCCESS (6.797s)
[456.220284] Starting dynamic subtest: pipe-B
[463.125214] Dynamic subtest pipe-B: SUCCESS (6.926s)
[463.128081] Subtest pixel-format: SUCCESS (13.733s)
[463.487921] [133/138] (560s left) kms_ccs (pipe-d-bad-aux-stride-4-tiled-mtl-rc-ccs)
[463.965231] Subtest pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[464.291696] [134/138] (559s left) gem_ctx_shared (q-smoketest)
[464.463666] Starting subtest: Q-smoketest
[464.465364] Starting dynamic subtest: rcs0
[469.934812] Dynamic subtest rcs0: SUCCESS (5.463s)
[469.960491] Starting dynamic subtest: bcs0
[475.398274] Dynamic subtest bcs0: SUCCESS (5.461s)
[475.424097] Starting dynamic subtest: vcs0
[480.870424] Dynamic subtest vcs0: SUCCESS (5.467s)
[480.896827] Starting dynamic subtest: vecs0
[486.347699] Dynamic subtest vecs0: SUCCESS (5.478s)
[486.349343] Subtest Q-smoketest: SUCCESS (21.880s)
[486.557389] [135/138] (537s left) kms_ccs (pipe-b-missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[486.980984] Starting subtest: pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs
[486.983667] Subtest pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[487.368638] [136/138] (536s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[487.615866] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[487.618809] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[487.716386] [137/138] (536s left) kms_ccs (pipe-d-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[488.191150] Subtest pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[488.528456] [138/138] (535s left) kms_tiled_display (basic-test-pattern)
[488.851251] Subtest basic-test-pattern: SKIP (0.000s)
[488.906189] Closing watchdogs
Done.