[57.657791] Initializing watchdogs
[57.657915]   /dev/watchdog0
[57.673296] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.678144] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.680407] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.683816] [001/133] (960s left) prime_mmap (test_reprime)
[57.757656] Starting subtest: test_reprime
[57.759611] Starting dynamic subtest: test_reprime-smem
[57.788857] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[57.791322] Subtest test_reprime: SUCCESS (0.032s)
[57.917840] [002/133] (960s left) syncobj_wait (invalid-wait-bad-flags)
[57.976912] Starting subtest: invalid-wait-bad-flags
[57.979168] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[58.066362] [003/133] (960s left) syncobj_timeline (single-wait-signaled)
[58.125309] Starting subtest: single-wait-signaled
[58.127617] Subtest single-wait-signaled: SUCCESS (0.000s)
[58.216790] [004/133] (960s left) kms_chamelium_color (gamma)
[58.325988] Subtest gamma: SKIP (0.000s)
[58.367134] [005/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[58.466643] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[65.007950] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.544s)
[65.121208] [006/133] (953s left) kms_plane (planar-pixel-format-settings)
[65.214665] Starting subtest: planar-pixel-format-settings
[65.286422] Subtest planar-pixel-format-settings: SUCCESS (0.074s)
[65.407317] [007/133] (953s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[65.519921] Starting subtest: flip-vs-cursor-legacy
[73.354382] Subtest flip-vs-cursor-legacy: SUCCESS (7.835s)
[74.190200] [008/133] (944s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[74.293811] Starting subtest: yf-tiled-32bpp-rotate-180
[74.298345] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[74.388972] [009/133] (944s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[74.493101] Starting subtest: 2x-flip-vs-modeset-vs-hang
[74.502141] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[74.587934] [010/133] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[74.683988] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[74.688279] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[74.778334] [011/133] (943s left) drm_buddy (drm_buddy)
[74.819206] Starting subtest: drm_buddy
[74.823452] Subtest drm_buddy: SKIP (0.000s)
[74.877373] [012/133] (943s left) kms_cursor_crc (cursor-random-128x128)
[75.090575] Starting subtest: cursor-random-128x128
[75.095319] Starting dynamic subtest: pipe-A-eDP-1
[78.427209] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.332s)
[78.459284] Starting dynamic subtest: pipe-D-eDP-1
[82.417106] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.962s)
[82.419473] Subtest cursor-random-128x128: SUCCESS (7.324s)
[83.259573] [013/133] (935s left) gem_lmem_swapping (heavy-random)
[83.302562] Subtest heavy-random: SKIP (0.000s)
[83.344561] [014/133] (935s left) kms_vrr (seamless-rr-switch-drrs)
[83.435614] Starting subtest: seamless-rr-switch-drrs
[83.442057] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[83.507053] [015/133] (935s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[83.557046] Starting subtest: multi-wait-available-submitted-signaled
[83.559442] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[83.642889] [016/133] (935s left) sysfs_preempt_timeout (timeout)
[83.699939] Starting subtest: timeout
[83.702226] Starting dynamic subtest: vecs0
[92.885523] Dynamic subtest vecs0: SUCCESS (9.182s)
[92.896352] Starting dynamic subtest: ccs0
[94.168069] Dynamic subtest ccs0: SUCCESS (1.283s)
[94.176356] Starting dynamic subtest: vcs0
[103.890999] Dynamic subtest vcs0: SUCCESS (9.720s)
[103.901957] Starting dynamic subtest: bcs0
[105.118207] Dynamic subtest bcs0: SUCCESS (1.228s)
[105.128558] Starting dynamic subtest: rcs0
[106.343931] Dynamic subtest rcs0: SUCCESS (1.224s)
[106.354155] Starting dynamic subtest: vcs1
[115.921204] Dynamic subtest vcs1: SUCCESS (9.577s)
[115.923665] Subtest timeout: SUCCESS (32.220s)
[115.992751] [017/133] (902s left) gem_exec_whisper (basic-contexts-priority-all)
[116.064616] Starting subtest: basic-contexts-priority-all
[138.969497] Subtest basic-contexts-priority-all: SUCCESS (22.900s)
[139.157892] [018/133] (879s left) kms_lease (possible-crtcs-filtering)
[139.265940] Starting subtest: possible-crtcs-filtering
[139.273316] Subtest possible-crtcs-filtering: SUCCESS (0.008s)
[139.380407] [019/133] (879s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[139.469685] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[139.474562] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[139.545103] [020/133] (879s left) gem_pxp (reject-modify-context-protection-off-2)
[139.665963] Starting subtest: reject-modify-context-protection-off-2
[139.668728] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[139.768827] [021/133] (879s left) kms_prop_blob (blob-prop-core)
[139.823860] Starting subtest: blob-prop-core
[139.825824] Subtest blob-prop-core: SUCCESS (0.000s)
[139.908305] [022/133] (879s left) kms_pm_backlight (basic-brightness)
[139.995997] Starting subtest: basic-brightness
[140.049304] Starting dynamic subtest: eDP-1
[140.356621] Dynamic subtest eDP-1: SUCCESS (0.307s)
[140.359173] Subtest basic-brightness: SUCCESS (0.362s)
[141.176662] [023/133] (877s left) kms_addfb_basic (clobberred-modifier)
[141.229363] Starting subtest: clobberred-modifier
[141.233508] Subtest clobberred-modifier: SKIP (0.000s)
[141.363975] [024/133] (877s left) kms_vblank (ts-continuation-dpms-rpm)
[141.457251] Starting subtest: ts-continuation-dpms-rpm
[141.459459] Starting dynamic subtest: pipe-A-eDP-1
[143.966964] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.508s)
[143.981047] Starting dynamic subtest: pipe-D-eDP-1
[146.225198] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.254s)
[146.227214] Subtest ts-continuation-dpms-rpm: SUCCESS (4.766s)
[147.028575] [025/133] (872s left) gen7_exec_parse (batch-without-end)
[147.082448] Subtest batch-without-end: SKIP (0.000s)
[147.156162] [026/133] (872s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[147.252285] Starting subtest: x-tiled-8bpp-rotate-180
[148.486724] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.236s)
[148.606389] [027/133] (870s left) kms_hdr (invalid-hdr)
[148.701156] Starting subtest: invalid-hdr
[150.837313] Starting dynamic subtest: pipe-A-eDP-1
[153.729185] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.892s)
[153.731531] Subtest invalid-hdr: SUCCESS (5.029s)
[153.860216] [028/133] (865s left) kms_cursor_crc (cursor-size-change)
[153.949814] Starting subtest: cursor-size-change
[153.952136] Starting dynamic subtest: pipe-A-eDP-1
[155.842127] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s)
[155.852211] Starting dynamic subtest: pipe-D-eDP-1
[157.297216] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.457s)
[157.299564] Subtest cursor-size-change: SUCCESS (3.350s)
[158.174312] [029/133] (861s left) kms_busy (basic)
[158.281788] Starting subtest: basic
[158.283675] Starting dynamic subtest: flip
[158.883594] Dynamic subtest flip: SUCCESS (0.601s)
[158.893673] Starting dynamic subtest: modeset
[162.317767] Dynamic subtest modeset: SUCCESS (3.435s)
[162.320215] Subtest basic: SUCCESS (4.038s)
[163.118873] [030/133] (856s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[163.228058] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[163.230468] Starting dynamic subtest: pipe-A-eDP-1
[163.253354] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[163.264786] Starting dynamic subtest: pipe-B-eDP-1
[163.285155] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[163.293322] Starting dynamic subtest: pipe-C-eDP-1
[163.314584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[163.322916] Starting dynamic subtest: pipe-D-eDP-1
[163.345060] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[163.349381] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[165.482991] [031/133] (853s left) gem_pread (exhaustion)
[165.532277] Subtest exhaustion: SKIP (0.000s)
[165.586996] [032/133] (853s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[165.680851] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[165.683183] Starting dynamic subtest: pipe-A-eDP-1
[172.413747] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.737s)
[172.427650] Starting dynamic subtest: pipe-B-eDP-1
[179.357347] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.941s)
[179.359294] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.680s)
[180.212683] [033/133] (839s left) kms_properties (connector-properties-atomic)
[180.313097] Starting subtest: connector-properties-atomic
[180.315450] Starting dynamic subtest: pipe-A-eDP-1
[188.225839] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.913s)
[188.236857] Starting dynamic subtest: pipe-None-DP-1
[188.241351] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[188.249482] Starting dynamic subtest: pipe-None-HDMI-A-1
[188.253856] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[188.262389] Starting dynamic subtest: pipe-None-DP-2
[188.266841] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[188.279147] Starting dynamic subtest: pipe-None-HDMI-A-2
[188.283810] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[188.292452] Starting dynamic subtest: pipe-None-DP-3
[188.297132] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[188.305685] Starting dynamic subtest: pipe-None-DP-4
[188.310219] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[188.312161] Subtest connector-properties-atomic: SUCCESS (7.923s)
[189.087767] [034/133] (830s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[189.177241] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[189.179574] Starting dynamic subtest: pipe-A-eDP-1
[189.199744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[189.212709] Starting dynamic subtest: pipe-B-eDP-1
[189.231300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[189.239760] Starting dynamic subtest: pipe-C-eDP-1
[189.258237] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[189.266501] Starting dynamic subtest: pipe-D-eDP-1
[189.285608] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[189.287487] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[191.457402] [035/133] (828s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[191.548610] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[191.550850] Starting dynamic subtest: pipe-A-eDP-1
[191.573045] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[191.584510] Starting dynamic subtest: pipe-B-eDP-1
[191.605208] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[191.613226] Starting dynamic subtest: pipe-C-eDP-1
[191.635389] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[191.643473] Starting dynamic subtest: pipe-D-eDP-1
[191.664818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[191.669137] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[193.818787] [036/133] (825s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[193.911043] Starting subtest: plane-lut1d-ctm3x4-lut1d
[194.058410] Starting dynamic subtest: pipe-A-plane-0
[194.236687] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[194.246502] Starting dynamic subtest: pipe-A-plane-1
[194.424633] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[194.434322] Starting dynamic subtest: pipe-A-plane-2
[194.613452] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[195.865570] Starting dynamic subtest: pipe-B-plane-0
[196.056480] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[196.067372] Starting dynamic subtest: pipe-B-plane-1
[196.245106] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[196.254116] Starting dynamic subtest: pipe-B-plane-2
[196.411946] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[197.634359] Starting dynamic subtest: pipe-C-plane-0
[197.771541] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[197.780717] Starting dynamic subtest: pipe-C-plane-1
[197.915793] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[197.924565] Starting dynamic subtest: pipe-C-plane-2
[198.049095] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[199.270321] Starting dynamic subtest: pipe-D-plane-0
[199.410409] Dynamic subtest pipe-D-plane-0: SUCCESS (0.146s)
[199.419591] Starting dynamic subtest: pipe-D-plane-1
[199.552195] Dynamic subtest pipe-D-plane-1: SUCCESS (0.141s)
[199.561181] Starting dynamic subtest: pipe-D-plane-2
[199.707604] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[199.997366] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.085s)
[200.842123] [037/133] (818s left) gem_pwrite_snooped
[200.968913] [038/133] (818s left) gem_wait (await)
[201.040435] Starting subtest: await
[201.043027] Starting dynamic subtest: all-engines
[202.245568] Dynamic subtest all-engines: SUCCESS (1.195s)
[202.254806] Starting dynamic subtest: rcs0
[203.290106] Dynamic subtest rcs0: SUCCESS (1.051s)
[203.307787] Starting dynamic subtest: bcs0
[204.347264] Dynamic subtest bcs0: SUCCESS (1.055s)
[204.363807] Starting dynamic subtest: vcs0
[205.400722] Dynamic subtest vcs0: SUCCESS (1.051s)
[205.417923] Starting dynamic subtest: vcs1
[206.454287] Dynamic subtest vcs1: SUCCESS (1.052s)
[206.471630] Starting dynamic subtest: vecs0
[207.508823] Dynamic subtest vecs0: SUCCESS (1.052s)
[207.525786] Starting dynamic subtest: ccs0
[208.565688] Dynamic subtest ccs0: SUCCESS (1.055s)
[208.568310] Subtest await: SUCCESS (7.526s)
[208.759276] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[208.762463] [039/133] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[208.851706] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[215.664432] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.815s)
[215.777991] [040/133] (803s left) gem_render_copy_redux (flink-interruptible)
[215.832581] Starting subtest: flink-interruptible
[216.592279] Subtest flink-interruptible: SUCCESS (0.761s)
[216.725287] [041/133] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[216.840828] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[216.844414] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[216.990533] [042/133] (802s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[217.075236] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[217.077043] Starting dynamic subtest: pipe-A
[217.097179] Dynamic subtest pipe-A: SKIP (0.018s)
[217.106258] Starting dynamic subtest: pipe-B
[217.126774] Dynamic subtest pipe-B: SKIP (0.031s)
[217.135489] Starting dynamic subtest: pipe-C
[217.158682] Dynamic subtest pipe-C: SKIP (0.031s)
[217.166968] Starting dynamic subtest: pipe-D
[217.191053] Dynamic subtest pipe-D: SKIP (0.031s)
[217.194334] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.113s)
[217.299582] [043/133] (802s left) kms_async_flips (alternate-sync-async-flip-atomic)
[217.391156] Starting subtest: alternate-sync-async-flip-atomic
[217.763950] Starting dynamic subtest: pipe-A-eDP-1
[220.565548] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.803s)
[220.960179] Starting dynamic subtest: pipe-B-eDP-1
[223.704628] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[224.098405] Starting dynamic subtest: pipe-C-eDP-1
[226.834311] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.743s)
[227.203673] Starting dynamic subtest: pipe-D-eDP-1
[229.964061] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[229.966118] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.575s)
[231.131783] [044/133] (788s left) gem_create (hog-create)
[231.199629] Starting subtest: hog-create
[231.201887] Starting dynamic subtest: smem0
[264.928942] Dynamic subtest smem0: SUCCESS (33.727s)
[264.931633] Subtest hog-create: SUCCESS (33.729s)
[265.116034] [045/133] (754s left) perf_pmu (semaphore-busy)
[265.169849] Starting subtest: semaphore-busy
[265.172044] Starting dynamic subtest: rcs0
[266.825221] Dynamic subtest rcs0: SUCCESS (1.653s)
[266.837056] Starting dynamic subtest: bcs0
[268.460768] Dynamic subtest bcs0: SUCCESS (1.632s)
[268.472220] Starting dynamic subtest: vcs0
[272.399808] Dynamic subtest vcs0: SUCCESS (3.936s)
[272.411183] Starting dynamic subtest: vcs1
[278.417260] Dynamic subtest vcs1: SUCCESS (6.013s)
[278.428878] Starting dynamic subtest: vecs0
[284.432408] Dynamic subtest vecs0: SUCCESS (6.011s)
[284.443719] Starting dynamic subtest: ccs0
[287.506686] Dynamic subtest ccs0: SUCCESS (3.072s)
[287.509089] Subtest semaphore-busy: SUCCESS (22.336s)
[287.621154] [046/133] (732s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[287.680616] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[287.737133] [047/133] (732s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[287.795050] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[287.898587] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[287.986612] [048/133] (732s left) syncobj_wait (single-wait-all-signaled)
[288.044502] Starting subtest: single-wait-all-signaled
[288.046896] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[288.146296] [049/133] (731s left) kms_hdr (static-toggle-dpms)
[288.239151] Starting subtest: static-toggle-dpms
[288.245591] Subtest static-toggle-dpms: SKIP (0.000s)
[288.319102] [050/133] (731s left) kms_flip (bo-too-big-interruptible)
[288.420137] Starting subtest: bo-too-big-interruptible
[288.422368] Starting dynamic subtest: A-eDP1
[289.697072] Dynamic subtest A-eDP1: SUCCESS (1.275s)
[289.708031] Starting dynamic subtest: B-eDP1
[290.936176] Dynamic subtest B-eDP1: SUCCESS (1.238s)
[290.947270] Starting dynamic subtest: C-eDP1
[292.179540] Dynamic subtest C-eDP1: SUCCESS (1.242s)
[292.190981] Starting dynamic subtest: D-eDP1
[293.514652] Dynamic subtest D-eDP1: SUCCESS (1.334s)
[293.520485] Subtest bo-too-big-interruptible: SUCCESS (5.099s)
[294.711305] [051/133] (725s left) i915_drm_fdinfo (virtual-busy)
[294.749464] Starting subtest: virtual-busy
[294.753737] Subtest virtual-busy: SKIP (0.000s)
[294.837431] [052/133] (725s left) kms_pm_rpm (universal-planes-dpms)
[297.072060] Starting subtest: universal-planes-dpms
[297.074527] Starting dynamic subtest: plane-35
[305.387253] Dynamic subtest plane-35: SUCCESS (8.317s)
[305.397480] Starting dynamic subtest: plane-65
[313.807906] Dynamic subtest plane-65: SUCCESS (8.418s)
[313.818915] Starting dynamic subtest: plane-95
[322.437690] Dynamic subtest plane-95: SUCCESS (8.626s)
[322.449832] Starting dynamic subtest: plane-125
[331.140657] Dynamic subtest plane-125: SUCCESS (8.700s)
[331.156845] Starting dynamic subtest: plane-135
[339.792686] Dynamic subtest plane-135: SUCCESS (8.648s)
[339.803633] Starting dynamic subtest: plane-145
[348.102336] Dynamic subtest plane-145: SUCCESS (8.306s)
[348.105559] Subtest universal-planes-dpms: SUCCESS (51.033s)
[348.489432] [053/133] (671s left) api_intel_allocator (execbuf-with-allocator)
[348.561231] Starting subtest: execbuf-with-allocator
[348.566067] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[348.657230] [054/133] (671s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[348.763926] Starting subtest: y-tiled-64bpp-rotate-180
[348.768466] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[348.856046] [055/133] (671s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[348.960448] Starting subtest: fbc-psr2-cursor-plane-update-sf
[348.962763] Starting dynamic subtest: pipe-A-eDP-1
[349.037405] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[349.047123] Starting dynamic subtest: pipe-B-eDP-1
[350.156628] Dynamic subtest pipe-B-eDP-1: SKIP (1.117s)
[350.161155] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.198s)
[351.442147] [056/133] (668s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[351.535904] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[351.548062] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[351.644483] [057/133] (668s left) syncobj_wait (wait-for-submit-snapshot)
[351.692077] Starting subtest: wait-for-submit-snapshot
[351.772451] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[351.862856] [058/133] (668s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[351.949808] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[351.951956] Starting dynamic subtest: pipe-A-eDP-1
[351.976080] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[351.986049] Starting dynamic subtest: pipe-B-eDP-1
[352.008316] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.016463] Starting dynamic subtest: pipe-C-eDP-1
[352.039491] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.047756] Starting dynamic subtest: pipe-D-eDP-1
[352.071424] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.075415] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[354.215436] [059/133] (666s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[354.312484] Starting subtest: 4-tiled-8bpp-rotate-90
[354.333383] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[354.459838] [060/133] (666s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[354.593280] Starting subtest: cursorB-vs-flipA-legacy
[354.597691] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[354.764527] [061/133] (665s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[354.827718] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[354.831850] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[355.010775] [062/133] (665s left) kms_selftest (drm_dp_mst_helper)
[355.053088] Starting subtest: drm_dp_mst_helper
[355.096231] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[355.183658] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.089s)
[355.193728] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[355.283368] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.098s)
[355.292900] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[355.396564] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.114s)
[355.398803] Subtest drm_dp_mst_helper: SUCCESS (0.348s)
[355.544124] [063/133] (665s left) kms_psr (psr-dpms)
[355.633102] Starting subtest: psr-dpms
[355.635322] Starting dynamic subtest: eDP-1
[358.635280] Dynamic subtest eDP-1: SUCCESS (3.002s)
[358.637459] Subtest psr-dpms: SUCCESS (3.003s)
[359.521895] [064/133] (661s left) gem_exec_schedule (semaphore-power)
[359.706725] Subtest semaphore-power: SKIP (0.000s)
[359.884749] [065/133] (660s left) kms_plane_lowres (tiling-x)
[359.964782] Starting subtest: tiling-x
[359.967017] Starting dynamic subtest: pipe-A-eDP-1
[359.971258] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.257985] Starting dynamic subtest: pipe-B-eDP-1
[360.262231] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.270963] Starting dynamic subtest: pipe-C-eDP-1
[360.275274] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.287127] Starting dynamic subtest: pipe-D-eDP-1
[360.291154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.295065] Subtest tiling-x: SKIP (0.294s)
[361.145461] [066/133] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[361.250713] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[361.255319] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.332362] [067/133] (659s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[361.394323] Starting subtest: invalid-multi-wait-unsubmitted
[361.396600] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[361.511781] [068/133] (659s left) gem_tiled_partial_pwrite_pread (reads)
[361.570556] Subtest reads: SKIP (0.000s)
[361.650230] [069/133] (659s left) kms_flip (2x-flip-vs-suspend)
[361.757504] Starting subtest: 2x-flip-vs-suspend
[361.766827] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[361.860565] [070/133] (659s left) i915_drm_fdinfo (virtual-busy-hang-all)
[361.904585] Starting subtest: virtual-busy-hang-all
[361.908839] Subtest virtual-busy-hang-all: SKIP (0.000s)
[361.974857] [071/133] (659s left) gem_eio (context-create)
[362.182220] Starting subtest: context-create
[362.465169] Subtest context-create: SUCCESS (0.282s)
[362.578341] [072/133] (658s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[362.632999] Starting subtest: invalid-single-wait-unsubmitted
[362.634664] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[362.721705] [073/133] (658s left) gem_exec_balancer (full-pulse)
[362.783022] Starting subtest: full-pulse
[367.787219] Subtest full-pulse: SUCCESS (5.005s)
[368.125992] [074/133] (653s left) gem_exec_schedule (preempt-other)
[368.203454] Starting subtest: preempt-other
[368.206033] Starting dynamic subtest: rcs0
[368.342453] Dynamic subtest rcs0: SUCCESS (0.137s)
[368.356476] Starting dynamic subtest: bcs0
[368.462158] Dynamic subtest bcs0: SUCCESS (0.119s)
[368.476542] Starting dynamic subtest: vcs0
[368.599074] Dynamic subtest vcs0: SUCCESS (0.136s)
[368.609866] Starting dynamic subtest: vcs1
[368.725278] Dynamic subtest vcs1: SUCCESS (0.125s)
[368.737991] Starting dynamic subtest: vecs0
[368.845925] Dynamic subtest vecs0: SUCCESS (0.120s)
[368.858245] Starting dynamic subtest: ccs0
[368.969842] Dynamic subtest ccs0: SUCCESS (0.122s)
[368.972768] Subtest preempt-other: SUCCESS (0.765s)
[370.037903] [075/133] (651s left) sw_sync (alloc_timeline)
[370.075487] Starting subtest: alloc_timeline
[370.077739] Subtest alloc_timeline: SUCCESS (0.000s)
[370.140861] [076/133] (651s left) gem_exec_params (no-vebox)
[370.200847] Starting subtest: no-vebox
[370.206660] Subtest no-vebox: SUCCESS (0.003s)
[371.979337] [077/133] (649s left) perf_pmu (enable-race)
[372.019645] Starting subtest: enable-race
[372.022088] Starting dynamic subtest: rcs0
[384.796059] Dynamic subtest rcs0: SUCCESS (12.777s)
[384.807731] Starting dynamic subtest: bcs0
[397.539848] Dynamic subtest bcs0: SUCCESS (12.742s)
[397.549038] Starting dynamic subtest: vcs0
[412.885261] Dynamic subtest vcs0: SUCCESS (15.342s)
[412.896892] Starting dynamic subtest: vcs1
[428.885448] Dynamic subtest vcs1: SUCCESS (15.997s)
[428.897639] Starting dynamic subtest: vecs0
[444.886034] Dynamic subtest vecs0: SUCCESS (15.998s)
[444.895927] Starting dynamic subtest: ccs0
[457.635225] Dynamic subtest ccs0: SUCCESS (12.747s)
[457.637853] Subtest enable-race: SUCCESS (85.616s)
[457.753406] [078/133] (563s left) tools_test (tools_test)
[457.808921] Starting subtest: tools_test
[457.861246] Subtest tools_test: SUCCESS (0.068s)
[457.927460] [079/133] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[458.022945] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[462.021849] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.003s)
[463.170309] [080/133] (558s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[463.267738] Starting subtest: 4-tiled-16bpp-rotate-0
[464.647615] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.380s)
[464.759883] [081/133] (556s left) syncobj_wait (reset-unsignaled)
[464.812826] Starting subtest: reset-unsignaled
[464.814795] Subtest reset-unsignaled: SUCCESS (0.000s)
[464.903428] [082/133] (556s left) kms_addfb_basic (tile-pitch-mismatch)
[464.953809] Starting subtest: tile-pitch-mismatch
[464.957528] Subtest tile-pitch-mismatch: SKIP (0.000s)
[465.088041] [083/133] (556s left) i915_pm_rpm (gem-evict-pwrite)
[467.015456] Starting subtest: gem-evict-pwrite
[467.020301] Subtest gem-evict-pwrite: SKIP (0.000s)
[467.389532] [084/133] (554s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[467.481504] Starting subtest: psr-rgb565-draw-mmap-gtt
[467.485586] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[467.576070] [085/133] (554s left) syncobj_wait (multi-wait-all-submitted-signaled)
[467.624992] Starting subtest: multi-wait-all-submitted-signaled
[467.730389] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[467.820947] [086/133] (553s left) syncobj_eventfd (binary-wait)
[467.876172] Starting subtest: binary-wait
[467.884906] Subtest binary-wait: SUCCESS (0.011s)
[467.998383] [087/133] (553s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[468.090131] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[468.094058] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[468.203489] [088/133] (553s left) kms_psr (pr-primary-blt)
[468.291961] Starting subtest: pr-primary-blt
[468.295950] Subtest pr-primary-blt: SKIP (0.000s)
[468.370638] [089/133] (553s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[468.466234] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[469.502593] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.037s)
[469.660707] [090/133] (552s left) gem_exec_balancer (parallel-keep-submit-fence)
[469.927477] Starting subtest: parallel-keep-submit-fence
[471.192255] Subtest parallel-keep-submit-fence: SUCCESS (1.265s)
[471.309661] [091/133] (550s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[471.407134] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[475.662225] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.260s)
[476.797633] [092/133] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[476.902192] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[476.906277] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[477.006193] [093/133] (545s left) kms_dsc (dsc-basic)
[477.092650] Starting subtest: dsc-basic
[477.105583] Subtest dsc-basic: SKIP (0.000s)
[477.166289] [094/133] (544s left) gem_exec_flush (basic-wb-pro-default)
[477.228310] Starting subtest: basic-wb-pro-default
[482.704748] Subtest basic-wb-pro-default: SUCCESS (5.476s)
[482.898345] [095/133] (539s left) kms_psr (psr2-cursor-render)
[483.004789] Starting subtest: psr2-cursor-render
[483.006910] Starting dynamic subtest: eDP-1
[484.682955] Dynamic subtest eDP-1: SUCCESS (1.677s)
[484.685160] Subtest psr2-cursor-render: SUCCESS (1.678s)
[485.479062] [096/133] (536s left) kms_addfb_basic (bad-pitch-65536)
[485.536796] Starting subtest: bad-pitch-65536
[485.538893] Subtest bad-pitch-65536: SUCCESS (0.000s)
[485.666244] [097/133] (536s left) gem_eio (in-flight-1us)
[485.904507] Starting subtest: in-flight-1us
[494.884280] Subtest in-flight-1us: SUCCESS (8.979s)
[495.038121] [098/133] (527s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[495.153301] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[495.157304] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[495.230832] [099/133] (527s left) kms_flip (flip-vs-panning-interruptible)
[495.324209] Starting subtest: flip-vs-panning-interruptible
[495.326475] Starting dynamic subtest: A-eDP1
[503.994168] Dynamic subtest A-eDP1: SUCCESS (8.668s)
[504.007820] Starting dynamic subtest: B-eDP1
[512.731395] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[512.743342] Starting dynamic subtest: C-eDP1
[521.458061] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[521.469489] Starting dynamic subtest: D-eDP1
[530.196255] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[530.200691] Subtest flip-vs-panning-interruptible: SUCCESS (34.877s)
[531.365829] [100/133] (490s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[531.466400] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[535.704961] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.242s)
[536.869823] [101/133] (485s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[536.981072] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[536.985708] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[537.094673] [102/133] (485s left) gem_ctx_isolation (nonpriv-switch)
[537.164119] Starting subtest: nonpriv-switch
[537.166579] Starting dynamic subtest: rcs0
[537.442103] Dynamic subtest rcs0: SUCCESS (0.278s)
[537.453763] Starting dynamic subtest: bcs0
[537.742231] Dynamic subtest bcs0: SUCCESS (0.299s)
[537.753951] Starting dynamic subtest: vcs0
[538.038798] Dynamic subtest vcs0: SUCCESS (0.296s)
[538.048502] Starting dynamic subtest: vcs1
[539.172398] Dynamic subtest vcs1: SUCCESS (1.132s)
[539.183948] Starting dynamic subtest: vecs0
[541.172176] Dynamic subtest vecs0: SUCCESS (1.999s)
[541.184203] Starting dynamic subtest: ccs0
[543.250036] Dynamic subtest ccs0: SUCCESS (2.077s)
[543.252434] Subtest nonpriv-switch: SUCCESS (6.086s)
[543.482389] [103/133] (478s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[543.594435] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[547.546433] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.955s)
[548.762424] [104/133] (473s left) i915_query (query-topology-garbage-items)
[548.830653] Starting subtest: query-topology-garbage-items
[548.832628] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[548.928212] [105/133] (473s left) kms_plane_alpha_blend (constant-alpha-min)
[549.026026] Starting subtest: constant-alpha-min
[549.313287] Starting dynamic subtest: pipe-A-eDP-1
[550.021859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[550.031861] Starting dynamic subtest: pipe-D-eDP-1
[551.531789] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.510s)
[551.534120] Subtest constant-alpha-min: SUCCESS (2.507s)
[552.325687] [106/133] (470s left) kms_psr (fbc-pr-primary-render)
[552.420843] Starting subtest: fbc-pr-primary-render
[552.425237] Subtest fbc-pr-primary-render: SKIP (0.000s)
[552.497767] [107/133] (470s left) gem_exec_reloc (basic-write-cpu-noreloc)
[552.545651] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[552.623779] [108/133] (470s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[552.732476] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[552.736943] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[552.880391] [109/133] (469s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[552.983974] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[559.508315] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.527s)
[559.614170] [110/133] (463s left) gem_mmap_gtt (hang)
[559.684037] Subtest hang: SKIP (0.000s)
[559.743234] [111/133] (463s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[559.839156] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[559.851059] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[559.934100] [112/133] (462s left) gem_ctx_param (invalid-param-set)
[559.990837] Starting subtest: invalid-param-set
[559.993052] Subtest invalid-param-set: SUCCESS (0.000s)
[560.069186] [113/133] (462s left) api_intel_bb (purge-bb)
[560.124583] Starting subtest: purge-bb
[560.126994] Subtest purge-bb: SUCCESS (0.003s)
[560.242893] [114/133] (462s left) gem_exec_params (invalid-fence-in-submit)
[560.299882] Starting subtest: invalid-fence-in-submit
[560.305336] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[560.413659] [115/133] (462s left) gem_mmap_offset (isolation)
[560.475691] Starting subtest: isolation
[560.490103] Subtest isolation: SUCCESS (0.007s)
[560.599514] [116/133] (462s left) gem_ctx_persistence (processes)
[560.661292] Starting subtest: processes
[561.893679] Subtest processes: SUCCESS (1.234s)
[561.978339] [117/133] (461s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[562.102260] Starting subtest: flip-vs-cursor-busy-crc-legacy
[562.914726] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.813s)
[563.798493] [118/133] (459s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[563.886467] Starting subtest: fbcpsr-rgb565-draw-pwrite
[570.940873] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.057s)
[571.056542] [119/133] (452s left) gem_softpin (allocator-basic-reserve)
[571.113982] Starting subtest: allocator-basic-reserve
[571.185036] Subtest allocator-basic-reserve: SUCCESS (0.071s)
[571.305502] [120/133] (451s left) kms_content_protection (uevent-hdcp14)
[571.451258] Starting subtest: uevent-hdcp14
[571.455330] Subtest uevent-hdcp14: SKIP (0.000s)
[571.558606] [121/133] (451s left) kms_cursor_crc (cursor-sliding-256x256)
[571.836631] Starting subtest: cursor-sliding-256x256
[571.841457] Starting dynamic subtest: pipe-A-eDP-1
[575.063502] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.223s)
[575.095212] Starting dynamic subtest: pipe-D-eDP-1
[578.917122] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.831s)
[578.919501] Subtest cursor-sliding-256x256: SUCCESS (7.080s)
[579.793250] [122/133] (443s left) gem_exec_fence (long-history)
[580.255097] Starting subtest: long-history
[587.640370] Subtest long-history: SUCCESS (7.386s)
[589.035290] [123/133] (434s left) syncobj_basic (bad-flags-fd-to-handle)
[589.091239] Starting subtest: bad-flags-fd-to-handle
[589.093573] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[589.195103] [124/133] (434s left) kms_psr (fbc-psr-cursor-render)
[589.291130] Starting subtest: fbc-psr-cursor-render
[589.293431] Starting dynamic subtest: eDP-1
[589.297746] Dynamic subtest eDP-1: SKIP (0.000s)
[589.302147] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[589.376271] [125/133] (434s left) kms_chamelium_color (ctm-negative)
[589.471368] Subtest ctm-negative: SKIP (0.000s)
[589.523585] [126/133] (433s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[589.615406] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[589.619834] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[589.703134] [127/133] (433s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[589.794913] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[596.517601] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.724s)
[596.658573] [128/133] (426s left) fbdev (write)
[596.706899] Starting subtest: write
[597.066505] Subtest write: SUCCESS (0.358s)
[597.134960] [129/133] (426s left) kms_panel_fitting (atomic-fastset)
[597.227223] Starting subtest: atomic-fastset
[597.229158] Starting dynamic subtest: pipe-A-eDP-1
[597.367142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[597.379684] Starting dynamic subtest: pipe-B-eDP-1
[598.575129] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[598.588402] Starting dynamic subtest: pipe-C-eDP-1
[599.771648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s)
[599.781953] Starting dynamic subtest: pipe-D-eDP-1
[600.903865] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[600.906063] Subtest atomic-fastset: SUCCESS (3.679s)
[602.060762] [130/133] (421s left) kms_cursor_crc (cursor-onscreen-64x64)
[602.236244] Starting subtest: cursor-onscreen-64x64
[602.241093] Starting dynamic subtest: pipe-A-eDP-1
[604.375127] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.132s)
[604.402209] Starting dynamic subtest: pipe-D-eDP-1
[607.129034] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.732s)
[607.131195] Subtest cursor-onscreen-64x64: SUCCESS (4.891s)
[608.017064] [131/133] (415s left) kms_flip (plain-flip-interruptible)
[608.110654] Starting subtest: plain-flip-interruptible
[608.112924] Starting dynamic subtest: A-eDP1
[609.807352] Dynamic subtest A-eDP1: SUCCESS (1.695s)
[609.821229] Starting dynamic subtest: B-eDP1
[611.435932] Dynamic subtest B-eDP1: SUCCESS (1.626s)
[611.447174] Starting dynamic subtest: C-eDP1
[613.046097] Dynamic subtest C-eDP1: SUCCESS (1.609s)
[613.057138] Starting dynamic subtest: D-eDP1
[614.683882] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[614.686316] Subtest plain-flip-interruptible: SUCCESS (6.576s)
[615.866511] [132/133] (407s left) kms_chamelium_hpd (dp-hpd-fast)
[616.257172] Subtest dp-hpd-fast: SKIP (0.000s)
[617.069708] [133/133] (406s left) gem_userptr_blits (coherency-sync)
[617.140480] Starting subtest: coherency-sync
[617.587388] Subtest coherency-sync: SKIP (0.411s)
[617.690410] Closing watchdogs
results: parsing output: 0/ for test: prime_mmap
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: drm_buddy
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: gem_lmem_swapping
results: parsing output: 13/ for test: kms_vrr
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: sysfs_preempt_timeout
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: kms_prop_blob
results: parsing output: 21/ for test: kms_pm_backlight
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_vblank
results: parsing output: 24/ for test: gen7_exec_parse
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_hdr
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_busy
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_pread
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_color_pipeline
results: parsing output: 36/ for test: gem_pwrite_snooped
results: parsing output: 37/ for test: gem_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_render_copy_redux
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: gem_create
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_hdr
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: kms_selftest
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_plane_lowres
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: tools_test
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: i915_pm_rpm
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: syncobj_eventfd
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_dsc
results: parsing output: 93/ for test: gem_exec_flush
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_ctx_isolation
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_query
results: parsing output: 104/ for test: kms_plane_alpha_blend
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: api_intel_bb
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_softpin
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: syncobj_basic
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: fbdev
results: parsing output: 128/ for test: kms_panel_fitting
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_chamelium_hpd
results: parsing output: 132/ for test: gem_userptr_blits
Done.