[58.542058] Initializing watchdogs
[58.542105]   /dev/watchdog0
[58.556643] [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]
[58.560915] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.563418] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.566735] [001/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[58.697734] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[58.701721] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[58.780888] [002/133] (960s left) kms_vblank (ts-continuation-idle-hang)
[58.870389] Starting subtest: ts-continuation-idle-hang
[58.872854] Starting dynamic subtest: pipe-A-eDP-1
[85.658331] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.804s)
[85.670888] Starting dynamic subtest: pipe-D-eDP-1
[100.702593] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.043s)
[100.704813] Subtest ts-continuation-idle-hang: SUCCESS (41.851s)
[101.530068] [003/133] (917s left) gem_eio (wait-wedge-immediate)
[101.692042] Starting subtest: wait-wedge-immediate
[102.966865] Subtest wait-wedge-immediate: SUCCESS (1.274s)
[103.110148] [004/133] (916s left) kms_cursor_crc (cursor-random-128x42)
[103.353737] Starting subtest: cursor-random-128x42
[103.399518] Subtest cursor-random-128x42: SKIP (0.040s)
[103.622914] [005/133] (915s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[103.715081] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[103.717502] Starting dynamic subtest: pipe-A-eDP-1
[103.738082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[103.747082] Starting dynamic subtest: pipe-B-eDP-1
[103.766359] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[103.773887] Starting dynamic subtest: pipe-C-eDP-1
[103.792983] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[103.800171] Starting dynamic subtest: pipe-D-eDP-1
[103.819139] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[103.821031] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[106.005475] [006/133] (913s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[106.113262] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[106.117581] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[106.217729] [007/133] (913s left) kms_flip (flip-vs-panning)
[106.315146] Starting subtest: flip-vs-panning
[106.317604] Starting dynamic subtest: A-eDP1
[115.033783] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[115.043366] Starting dynamic subtest: B-eDP1
[123.768099] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[123.778988] Starting dynamic subtest: C-eDP1
[132.489320] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[132.498966] Starting dynamic subtest: D-eDP1
[141.224470] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[141.226604] Subtest flip-vs-panning: SUCCESS (34.914s)
[142.379905] [008/133] (876s left) kms_pipe_crc_basic (hang-read-crc)
[142.485576] Starting subtest: hang-read-crc
[142.487673] Starting dynamic subtest: pipe-A-eDP-1
[144.552037] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.065s)
[144.561402] Starting dynamic subtest: pipe-B-eDP-1
[147.242452] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.689s)
[147.251820] Starting dynamic subtest: pipe-C-eDP-1
[149.849047] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s)
[149.858161] Starting dynamic subtest: pipe-D-eDP-1
[152.501822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.653s)
[152.504224] Subtest hang-read-crc: SUCCESS (10.016s)
[153.351211] [009/133] (866s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[153.462288] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[153.466713] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[153.526649] [010/133] (865s left) kms_properties (connector-properties-legacy)
[153.609817] Starting subtest: connector-properties-legacy
[153.611783] Starting dynamic subtest: pipe-A-eDP-1
[161.445380] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.835s)
[161.454829] Starting dynamic subtest: pipe-None-DP-1
[161.459695] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[161.466687] Starting dynamic subtest: pipe-None-HDMI-A-1
[161.470691] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[161.477898] Starting dynamic subtest: pipe-None-DP-2
[161.482125] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[161.489241] Starting dynamic subtest: pipe-None-HDMI-A-2
[161.493530] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[161.506722] Starting dynamic subtest: pipe-None-DP-3
[161.511489] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[161.521801] Starting dynamic subtest: pipe-None-DP-4
[161.526289] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[161.528234] Subtest connector-properties-legacy: SUCCESS (7.847s)
[162.306421] [011/133] (857s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[164.062715] Starting subtest: dpms-mode-unset-non-lpsp
[165.216497] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s)
[165.610054] [012/133] (853s left) kms_psr (fbc-psr-primary-blt)
[165.714081] Starting subtest: fbc-psr-primary-blt
[165.716462] Starting dynamic subtest: eDP-1
[165.721067] Dynamic subtest eDP-1: SKIP (0.000s)
[165.725440] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[165.782504] [013/133] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[165.880073] Starting subtest: fbcpsr-2p-rte
[165.884627] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[165.977935] [014/133] (853s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[166.073428] Starting subtest: fbc-pr-cursor-mmap-gtt
[166.077640] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[166.155366] [015/133] (853s left) gem_exec_schedule (preempt-contexts)
[166.233114] Starting subtest: preempt-contexts
[166.235276] Starting dynamic subtest: rcs0
[166.286422] Dynamic subtest rcs0: SUCCESS (0.063s)
[166.295680] Starting dynamic subtest: bcs0
[166.345502] Dynamic subtest bcs0: SUCCESS (0.059s)
[166.353393] Starting dynamic subtest: vcs0
[166.400857] Dynamic subtest vcs0: SUCCESS (0.055s)
[166.409539] Starting dynamic subtest: vcs1
[166.445040] Dynamic subtest vcs1: SUCCESS (0.043s)
[166.453187] Starting dynamic subtest: vecs0
[166.506670] Dynamic subtest vecs0: SUCCESS (0.062s)
[166.514527] Starting dynamic subtest: ccs0
[166.563493] Dynamic subtest ccs0: SUCCESS (0.056s)
[166.565468] Subtest preempt-contexts: SUCCESS (0.340s)
[168.004058] [016/133] (851s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[168.119578] Starting subtest: yf-tiled-16bpp-rotate-0
[168.123720] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[168.217431] [017/133] (851s left) i915_query (hwconfig_table)
[168.273981] Starting subtest: hwconfig_table
[168.574222] Subtest hwconfig_table: SUCCESS (0.001s)
[168.609871] [018/133] (851s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[168.697115] Starting subtest: fbc-dirtyfb-ioctl
[168.699516] Starting dynamic subtest: A-eDP-1
[171.277818] Dynamic subtest A-eDP-1: SUCCESS (2.578s)
[171.280105] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.579s)
[172.065772] [019/133] (847s left) kms_psr (psr-sprite-render)
[172.170831] Starting subtest: psr-sprite-render
[172.173142] Starting dynamic subtest: eDP-1
[173.892846] Dynamic subtest eDP-1: SUCCESS (1.721s)
[173.895112] Subtest psr-sprite-render: SUCCESS (1.722s)
[174.731651] [020/133] (845s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[174.846173] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[174.872528] Starting dynamic subtest: pipe-A-plane-0
[175.160972] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[175.170616] Starting dynamic subtest: pipe-A-plane-3
[175.396070] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[176.515264] Starting dynamic subtest: pipe-B-plane-0
[176.808222] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[176.817428] Starting dynamic subtest: pipe-B-plane-3
[177.052555] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[177.374067] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.529s)
[178.184710] [021/133] (841s left) api_intel_allocator (simple-allocator)
[178.241701] Starting subtest: simple-allocator
[178.244067] Starting dynamic subtest: basic
[178.246233] Dynamic subtest basic: SUCCESS (0.003s)
[178.260418] Starting dynamic subtest: parallel-one
[178.419210] Dynamic subtest parallel-one: SUCCESS (0.175s)
[178.426707] Starting dynamic subtest: print
[178.428998] Dynamic subtest print: SUCCESS (0.000s)
[178.436694] Starting dynamic subtest: reuse
[178.438642] Dynamic subtest reuse: SUCCESS (0.000s)
[178.445693] Starting dynamic subtest: reserve
[178.447642] Dynamic subtest reserve: SUCCESS (0.000s)
[178.454652] Starting dynamic subtest: fork-reopen-allocator
[178.456569] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[178.458451] Subtest simple-allocator: SUCCESS (0.195s)
[178.544516] [022/133] (841s left) prime_busy (hang)
[178.607282] Starting subtest: hang
[178.609601] Starting dynamic subtest: rcs0
[204.409770] Dynamic subtest rcs0: SUCCESS (25.789s)
[204.417089] Starting dynamic subtest: bcs0
[211.557436] Dynamic subtest bcs0: SUCCESS (7.157s)
[211.565799] Starting dynamic subtest: vcs0
[218.594215] Dynamic subtest vcs0: SUCCESS (7.033s)
[218.601825] Starting dynamic subtest: vcs1
[225.565333] Dynamic subtest vcs1: SUCCESS (6.973s)
[225.573215] Starting dynamic subtest: vecs0
[232.543586] Dynamic subtest vecs0: SUCCESS (6.974s)
[232.550961] Starting dynamic subtest: ccs0
[246.444953] Dynamic subtest ccs0: SUCCESS (13.901s)
[246.447071] Subtest hang: SUCCESS (67.833s)
[246.554751] [023/133] (773s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[246.613953] Starting subtest: multi-wait-for-submit-submitted-signaled
[246.616194] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[246.713766] [024/133] (773s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[246.806813] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[246.811091] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[246.876180] [025/133] (773s left) gem_exec_nop (basic-parallel)
[246.948563] Starting subtest: basic-parallel
[262.871632] Subtest basic-parallel: SUCCESS (15.933s)
[263.102759] [026/133] (756s left) gem_ctx_engines (invalid-engines)
[263.161014] Starting subtest: invalid-engines
[263.173345] Subtest invalid-engines: SUCCESS (0.012s)
[263.395969] [027/133] (756s left) gem_mmap_gtt (close-race)
[263.458642] Subtest close-race: SKIP (0.000s)
[263.515689] [028/133] (756s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[263.631500] Starting subtest: cursorA-vs-flipB-legacy
[263.636101] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[263.774019] [029/133] (756s left) gem_softpin (allocator-basic)
[263.833442] Starting subtest: allocator-basic
[263.900412] Subtest allocator-basic: SUCCESS (0.066s)
[264.014565] [030/133] (756s left) gem_exec_balancer (invalid-balancer)
[264.068055] Starting subtest: invalid-balancer
[264.933550] Subtest invalid-balancer: SUCCESS (0.864s)
[265.214279] [031/133] (754s left) gem_ctx_sseu (invalid-args)
[265.273921] Subtest invalid-args: SKIP (0.000s)
[265.331242] [032/133] (754s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[265.414509] Starting subtest: fbc-rgb101010-draw-mmap-wc
[269.967913] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.554s)
[271.102826] [033/133] (749s left) gem_mmap_wc (read)
[271.159791] Subtest read: SKIP (0.000s)
[271.218093] [034/133] (749s left) sysfs_preempt_timeout (idempotent)
[271.270153] Starting subtest: idempotent
[271.272365] Starting dynamic subtest: vecs0
[271.274574] Dynamic subtest vecs0: SUCCESS (0.000s)
[271.282920] Starting dynamic subtest: ccs0
[271.285013] Dynamic subtest ccs0: SUCCESS (0.000s)
[271.292628] Starting dynamic subtest: vcs0
[271.294457] Dynamic subtest vcs0: SUCCESS (0.000s)
[271.302106] Starting dynamic subtest: bcs0
[271.304179] Dynamic subtest bcs0: SUCCESS (0.000s)
[271.312141] Starting dynamic subtest: rcs0
[271.314242] Dynamic subtest rcs0: SUCCESS (0.000s)
[271.321374] Starting dynamic subtest: vcs1
[271.323585] Dynamic subtest vcs1: SUCCESS (0.000s)
[271.325643] Subtest idempotent: SUCCESS (0.005s)
[271.360370] [035/133] (748s left) gem_exec_capture (capture-recoverable)
[271.435315] Starting subtest: capture-recoverable
[271.440065] Subtest capture-recoverable: SUCCESS (0.003s)
[271.548704] [036/133] (748s left) gem_readwrite (read-write)
[271.612716] Subtest read-write: SKIP (0.000s)
[271.669174] [037/133] (748s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[271.760656] Starting subtest: fbcpsr-stridechange
[278.032745] Subtest fbcpsr-stridechange: SUCCESS (6.275s)
[278.166291] [038/133] (742s left) gem_ctx_param (set-priority-range)
[278.223396] Starting subtest: set-priority-range
[278.239334] Subtest set-priority-range: SUCCESS (0.016s)
[278.358219] [039/133] (742s left) i915_pm_rps (fence-order)
[278.414567] Starting subtest: fence-order
[281.341636] Subtest fence-order: SUCCESS (2.924s)
[281.452131] [040/133] (739s left) gem_unref_active_buffers
[281.677728] [041/133] (738s left) gen9_exec_parse (allowed-single)
[281.746721] Subtest allowed-single: SKIP (0.000s)
[281.812684] [042/133] (738s left) kms_flip (2x-flip-vs-suspend)
[281.916207] Starting subtest: 2x-flip-vs-suspend
[281.927129] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[282.003487] [043/133] (738s left) kms_atomic (plane-primary-legacy)
[282.095306] Starting subtest: plane-primary-legacy
[282.097592] Starting dynamic subtest: pipe-A-eDP-1
[282.552164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s)
[282.554515] Subtest plane-primary-legacy: SUCCESS (0.457s)
[283.350321] [044/133] (737s left) kms_universal_plane (universal-plane-sanity)
[283.437749] Starting subtest: universal-plane-sanity
[283.439587] Starting dynamic subtest: pipe-A-eDP-1
[284.036720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[284.049118] Starting dynamic subtest: pipe-B-eDP-1
[285.290098] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[285.299379] Starting dynamic subtest: pipe-C-eDP-1
[286.508754] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s)
[286.518284] Starting dynamic subtest: pipe-D-eDP-1
[287.743322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[287.745507] Subtest universal-plane-sanity: SUCCESS (4.307s)
[288.606947] [045/133] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[288.709283] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[288.713522] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[288.786703] [046/133] (731s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[288.900946] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[288.905277] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[289.005928] [047/133] (731s left) gem_mmap_wc (write-prefaulted)
[289.070603] Subtest write-prefaulted: SKIP (0.000s)
[289.136084] [048/133] (731s left) gem_exec_schedule (semaphore-noskip)
[289.206640] Starting subtest: semaphore-noskip
[289.621414] Subtest semaphore-noskip: SUCCESS (0.422s)
[289.956733] [049/133] (730s left) gem_exec_reloc (basic-cpu-wc-active)
[290.008023] Subtest basic-cpu-wc-active: SKIP (0.000s)
[290.092063] [050/133] (730s left) gem_userptr_blits (process-exit-busy)
[290.171933] Starting subtest: process-exit-busy
[290.191070] Subtest process-exit-busy: SUCCESS (0.019s)
[290.307883] [051/133] (730s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[290.399064] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[290.401256] Starting dynamic subtest: pipe-A
[290.419069] Dynamic subtest pipe-A: SKIP (0.016s)
[290.430228] Starting dynamic subtest: pipe-B
[290.449534] Dynamic subtest pipe-B: SKIP (0.030s)
[290.458432] Starting dynamic subtest: pipe-C
[290.481103] Dynamic subtest pipe-C: SKIP (0.030s)
[290.489454] Starting dynamic subtest: pipe-D
[290.510595] Dynamic subtest pipe-D: SKIP (0.029s)
[290.514317] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.108s)
[290.626511] [052/133] (730s left) kms_lease (lease-invalid-plane)
[290.720181] Starting subtest: lease-invalid-plane
[290.722407] Starting dynamic subtest: pipe-A-eDP-1
[290.724729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[290.734047] Starting dynamic subtest: pipe-B-eDP-1
[290.736286] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[290.744242] Starting dynamic subtest: pipe-C-eDP-1
[290.746542] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[290.754698] Starting dynamic subtest: pipe-D-eDP-1
[290.756822] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[290.758968] Subtest lease-invalid-plane: SUCCESS (0.004s)
[290.793111] [053/133] (730s left) kms_psr (pr-sprite-render)
[290.896599] Starting subtest: pr-sprite-render
[290.900128] Subtest pr-sprite-render: SKIP (0.000s)
[290.965403] [054/133] (730s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[291.064100] Starting subtest: x-tiled-32bpp-rotate-270
[291.084413] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[291.204601] [055/133] (729s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[291.247262] Starting subtest: single-wait-all-for-submit-unsubmitted
[291.352811] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[291.429026] [056/133] (729s left) i915_module_load (reload-no-display)
[291.481533] Starting subtest: reload-no-display
[297.425599] Subtest reload-no-display: SUCCESS (5.943s)
[297.452524] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[297.455708] [057/133] (723s left) kms_psr (psr2-no-drrs)
[298.975364] Starting subtest: psr2-no-drrs
[298.977727] Starting dynamic subtest: eDP-1
[300.596235] Dynamic subtest eDP-1: SUCCESS (1.619s)
[300.598467] Subtest psr2-no-drrs: SUCCESS (1.621s)
[301.429918] [FACT kms_psr (psr2-no-drrs)] new: kernel.kmod_is_loaded.i915: true
[301.433468] [058/133] (719s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[301.534121] Starting subtest: random-ccs-data-yf-tiled-ccs
[301.536326] Starting dynamic subtest: pipe-A-eDP-1
[301.560838] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[301.570479] Starting dynamic subtest: pipe-B-eDP-1
[301.593174] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[301.600043] Starting dynamic subtest: pipe-C-eDP-1
[301.622693] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[301.629629] Starting dynamic subtest: pipe-D-eDP-1
[301.653583] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[301.658026] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[303.770712] [059/133] (717s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[303.867761] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[303.869674] Starting dynamic subtest: pipe-A-eDP-1
[304.023574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[304.031523] Starting dynamic subtest: pipe-B-eDP-1
[304.050557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[304.058222] Starting dynamic subtest: pipe-C-eDP-1
[304.078280] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[304.086158] Starting dynamic subtest: pipe-D-eDP-1
[304.105191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[304.107077] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.184s)
[306.325252] [060/133] (714s left) kms_joiner (basic-force-big-joiner)
[306.427268] Starting subtest: basic-force-big-joiner
[306.431108] Subtest basic-force-big-joiner: SKIP (0.000s)
[306.490283] [061/133] (714s left) gem_exec_suspend (basic-s3)
[306.556059] Starting subtest: basic-S3
[306.558387] Starting dynamic subtest: smem
[325.450726] Dynamic subtest smem: SUCCESS (6.370s)
[325.453675] Subtest basic-S3: SUCCESS (6.372s)
[325.644464] [062/133] (695s left) kms_rotation_crc (sprite-rotation-270)
[325.764067] Starting subtest: sprite-rotation-270
[325.768131] Subtest sprite-rotation-270: SKIP (0.001s)
[325.832669] [063/133] (695s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[325.927128] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[325.931112] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[326.021394] [064/133] (695s left) kms_psr (fbc-psr2-dpms)
[326.106118] Starting subtest: fbc-psr2-dpms
[326.108224] Starting dynamic subtest: eDP-1
[326.112137] Dynamic subtest eDP-1: SKIP (0.000s)
[326.116044] Subtest fbc-psr2-dpms: SKIP (0.001s)
[326.193243] [065/133] (695s left) gem_userptr_blits (vma-merge)
[326.266361] Starting subtest: vma-merge
[326.308393] Subtest vma-merge: SUCCESS (0.045s)
[326.422118] [066/133] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[326.520304] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[330.425725] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.944s)
[331.586632] [067/133] (689s left) gem_partial_pwrite_pread (write-snoop)
[331.633224] Subtest write-snoop: SKIP (0.000s)
[331.719898] [068/133] (689s left) drm_read (short-buffer-nonblock)
[331.857138] Starting subtest: short-buffer-nonblock
[331.859427] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[331.993649] [069/133] (689s left) gem_exec_whisper (basic-contexts)
[332.063607] Starting subtest: basic-contexts
[339.435290] Subtest basic-contexts: SUCCESS (7.395s)
[339.613825] [070/133] (682s left) syncobj_timeline (multi-wait-for-submit-signaled)
[339.669212] Starting subtest: multi-wait-for-submit-signaled
[339.671515] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[339.770692] [071/133] (681s left) gem_mmap_gtt (hang-busy)
[339.828803] Subtest hang-busy: SKIP (0.000s)
[339.887224] [072/133] (681s left) api_intel_bb (render)
[339.948691] Starting subtest: render
[339.950844] Starting dynamic subtest: render-none-512
[340.064659] Dynamic subtest render-none-512: SUCCESS (0.117s)
[340.076776] Starting dynamic subtest: render-none-1024
[340.444065] Dynamic subtest render-none-1024: SUCCESS (0.377s)
[340.453786] Starting dynamic subtest: render-x-512
[340.529583] Dynamic subtest render-x-512: SUCCESS (0.086s)
[340.541696] Starting dynamic subtest: render-x-1024
[341.072258] Dynamic subtest render-x-1024: SUCCESS (0.541s)
[341.082318] Starting dynamic subtest: render-y-512
[341.158671] Dynamic subtest render-y-512: SUCCESS (0.086s)
[341.169368] Starting dynamic subtest: render-y-1024
[341.496152] Dynamic subtest render-y-1024: SUCCESS (0.336s)
[341.498717] Subtest render: SUCCESS (1.553s)
[341.630942] [073/133] (680s left) gem_exec_fence (syncobj-invalid-wait)
[342.117166] Starting subtest: syncobj-invalid-wait
[342.119553] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[343.546968] [FACT gem_exec_fence (syncobj-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[343.550932] [074/133] (678s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[343.672207] Starting subtest: basic-busy-flip-before-cursor-atomic
[343.676605] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[343.818631] [075/133] (678s left) gem_exec_reloc (basic-write-gtt-noreloc)
[343.887778] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[343.963021] [076/133] (678s left) syncobj_wait (invalid-signal-one-illegal-handle)
[344.017293] Starting subtest: invalid-signal-one-illegal-handle
[344.019646] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[344.131548] [077/133] (677s left) gem_huc_copy (huc-copy)
[344.196527] Starting subtest: huc-copy
[344.201467] Subtest huc-copy: SUCCESS (0.004s)
[344.348627] [078/133] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[344.445271] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[351.295358] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.860s)
[351.477273] [079/133] (670s left) core_setmaster (master-drop-set-root)
[351.546696] Starting subtest: master-drop-set-root
[351.571473] Subtest master-drop-set-root: SUCCESS (0.025s)
[351.619376] [080/133] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[351.715362] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[351.719357] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[351.824465] [081/133] (670s left) gem_exec_params (no-bsd)
[351.892111] Starting subtest: no-bsd
[351.897107] Subtest no-bsd: SUCCESS (0.002s)
[353.546968] [082/133] (668s left) gem_ctx_persistence (engines-mixed)
[353.609856] Starting subtest: engines-mixed
[353.612288] Starting dynamic subtest: rcs0
[353.692953] Dynamic subtest rcs0: SUCCESS (0.082s)
[353.704784] Starting dynamic subtest: bcs0
[353.755940] Dynamic subtest bcs0: SUCCESS (0.061s)
[353.767818] Starting dynamic subtest: vcs0
[353.817944] Dynamic subtest vcs0: SUCCESS (0.060s)
[353.829448] Starting dynamic subtest: vcs1
[353.875700] Dynamic subtest vcs1: SUCCESS (0.055s)
[353.887320] Starting dynamic subtest: vecs0
[353.929956] Dynamic subtest vecs0: SUCCESS (0.052s)
[353.941256] Starting dynamic subtest: ccs0
[353.988930] Dynamic subtest ccs0: SUCCESS (0.057s)
[353.991684] Subtest engines-mixed: SUCCESS (0.380s)
[354.067352] [083/133] (668s left) kms_pm_rpm (modeset-lpsp)
[355.607235] Starting subtest: modeset-lpsp
[357.085195] Subtest modeset-lpsp: SUCCESS (1.479s)
[357.188172] [084/133] (665s left) kms_color (ctm-signed)
[357.283410] Starting subtest: ctm-signed
[357.285345] Starting dynamic subtest: pipe-A-eDP-1
[359.416068] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.136s)
[359.426833] Starting dynamic subtest: pipe-B-eDP-1
[362.187795] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[362.201615] Starting dynamic subtest: pipe-C-eDP-1
[364.910459] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.724s)
[364.923829] Starting dynamic subtest: pipe-D-eDP-1
[367.582389] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.672s)
[367.584852] Subtest ctm-signed: SUCCESS (10.308s)
[368.419863] [085/133] (653s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[368.538581] Starting subtest: 4-tiled-16bpp-rotate-270
[368.561153] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[368.659819] [086/133] (653s left) kms_flip (flip-vs-expired-vblank-interruptible)
[368.767464] Starting subtest: flip-vs-expired-vblank-interruptible
[368.769793] Starting dynamic subtest: A-eDP1
[377.443764] Dynamic subtest A-eDP1: SUCCESS (8.645s)
[377.455703] Starting dynamic subtest: B-eDP1
[386.060076] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[386.071627] Starting dynamic subtest: C-eDP1
[394.699964] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[394.711530] Starting dynamic subtest: D-eDP1
[403.276507] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[403.281375] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.533s)
[404.440347] [087/133] (617s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[404.833865] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[405.644181] [088/133] (616s left) kms_frontbuffer_tracking (fbc-2p-rte)
[405.746108] Starting subtest: fbc-2p-rte
[405.750053] Subtest fbc-2p-rte: SKIP (0.000s)
[405.872988] [089/133] (616s left) gem_exec_reloc (basic-range)
[405.943219] Subtest basic-range: SKIP (0.000s)
[406.069762] [090/133] (616s left) i915_drm_fdinfo (virtual-busy)
[406.114013] Starting subtest: virtual-busy
[406.118488] Subtest virtual-busy: SKIP (0.000s)
[406.212304] [091/133] (616s left) gem_ctx_persistence (legacy-engines-cleanup)
[406.283354] Starting subtest: legacy-engines-cleanup
[406.285609] Starting dynamic subtest: render
[406.352631] Dynamic subtest render: SUCCESS (0.070s)
[406.368111] Starting dynamic subtest: bsd1
[406.397499] Dynamic subtest bsd1: SUCCESS (0.041s)
[406.409873] Starting dynamic subtest: bsd2
[406.452549] Dynamic subtest bsd2: SUCCESS (0.052s)
[406.466290] Starting dynamic subtest: blt
[406.487407] Dynamic subtest blt: SUCCESS (0.032s)
[406.496066] Starting dynamic subtest: vebox
[406.525456] Dynamic subtest vebox: SUCCESS (0.036s)
[406.527704] Subtest legacy-engines-cleanup: SUCCESS (0.246s)
[406.645996] [092/133] (616s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[406.699713] Starting subtest: y-tiled-to-vebox-y-tiled
[406.703227] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[406.900462] [093/133] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[407.005171] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[407.008649] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[407.107342] [094/133] (615s left) kms_async_flips (alternate-sync-async-flip-atomic)
[407.205464] Starting subtest: alternate-sync-async-flip-atomic
[407.577463] Starting dynamic subtest: pipe-A-eDP-1
[410.347289] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.771s)
[410.727080] Starting dynamic subtest: pipe-B-eDP-1
[413.484280] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[413.866207] Starting dynamic subtest: pipe-C-eDP-1
[416.612929] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.756s)
[417.006992] Starting dynamic subtest: pipe-D-eDP-1
[419.757134] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[419.759268] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.560s)
[420.948881] [095/133] (601s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[421.010579] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[421.118107] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[421.242113] [096/133] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[421.359711] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[421.364165] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[421.493548] [097/133] (601s left) gem_ctx_param (basic)
[421.558020] Starting subtest: basic
[421.560409] Subtest basic: SUCCESS (0.001s)
[421.663045] [098/133] (601s left) kms_draw_crc (draw-method-render)
[421.764203] Starting subtest: draw-method-render
[421.766415] Starting dynamic subtest: xrgb8888-untiled
[422.006678] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[422.019082] Starting dynamic subtest: rgb565-untiled
[422.251546] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[422.260186] Starting dynamic subtest: xrgb2101010-untiled
[422.463354] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[422.472840] Starting dynamic subtest: xbgr16161616f-untiled
[422.697267] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[422.708880] Starting dynamic subtest: xrgb8888-xtiled
[422.831815] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[422.841105] Starting dynamic subtest: rgb565-xtiled
[422.944621] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[422.953182] Starting dynamic subtest: xrgb2101010-xtiled
[423.076331] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.130s)
[423.088317] Starting dynamic subtest: xbgr16161616f-xtiled
[423.198800] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[423.207967] Starting dynamic subtest: xrgb8888-4tiled
[423.322703] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[423.331695] Starting dynamic subtest: rgb565-4tiled
[423.443667] Dynamic subtest rgb565-4tiled: SUCCESS (0.119s)
[423.455141] Starting dynamic subtest: xrgb2101010-4tiled
[423.566655] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s)
[423.577756] Starting dynamic subtest: xbgr16161616f-4tiled
[423.711012] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.141s)
[423.712903] Subtest draw-method-render: SUCCESS (1.945s)
[423.838924] [099/133] (599s left) kms_chamelium_edid (dp-mode-timings)
[424.217358] Subtest dp-mode-timings: SKIP (0.000s)
[425.041986] [100/133] (598s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[425.152485] Starting subtest: fbc-farfromfence-mmap-gtt
[425.156909] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[425.231929] [101/133] (598s left) kms_cursor_edge_walk (128x128-right-edge)
[425.324218] Starting subtest: 128x128-right-edge
[425.326414] Starting dynamic subtest: pipe-A-eDP-1
[428.747186] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.415s)
[428.757255] Starting dynamic subtest: pipe-D-eDP-1
[431.891484] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.140s)
[431.893820] Subtest 128x128-right-edge: SUCCESS (6.558s)
[432.690471] [102/133] (590s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[432.785113] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[432.788964] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[432.881663] [103/133] (590s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[432.989253] Starting subtest: fbcpsr-rgb101010-draw-render
[439.738688] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.745s)
[439.868469] [104/133] (583s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[439.989553] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[449.426774] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.429s)
[450.259997] [105/133] (573s left) kms_frontbuffer_tracking (psr-suspend)
[450.361495] Starting subtest: psr-suspend
[488.820473] Subtest psr-suspend: SUCCESS (7.889s)
[488.935693] [106/133] (534s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[489.042661] Starting subtest: fbc-rgb101010-draw-pwrite
[494.354658] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.358s)
[495.479325] [107/133] (528s left) sw_sync (timeline_closed_signaled)
[495.523661] Starting subtest: timeline_closed_signaled
[495.525970] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[495.577299] [108/133] (527s left) gem_exec_reloc (basic-softpin)
[495.647111] Subtest basic-softpin: SKIP (0.000s)
[495.717078] [109/133] (527s left) gem_exec_flush (basic-batch-kernel-default-wb)
[495.790551] Starting subtest: basic-batch-kernel-default-wb
[503.097107] Subtest basic-batch-kernel-default-wb: SUCCESS (7.333s)
[503.288501] [110/133] (520s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[503.351530] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[503.451897] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[503.532752] [111/133] (520s left) gem_exec_parallel (userptr)
[503.594328] Starting subtest: userptr
[503.596717] Starting dynamic subtest: rcs0
[505.115062] Dynamic subtest rcs0: SUCCESS (1.521s)
[505.126385] Starting dynamic subtest: bcs0
[506.599496] Dynamic subtest bcs0: SUCCESS (1.487s)
[506.609265] Starting dynamic subtest: vcs0
[508.007022] Dynamic subtest vcs0: SUCCESS (1.408s)
[508.020127] Starting dynamic subtest: vcs1
[509.960341] Dynamic subtest vcs1: SUCCESS (1.951s)
[509.971484] Starting dynamic subtest: vecs0
[512.009956] Dynamic subtest vecs0: SUCCESS (2.049s)
[512.023074] Starting dynamic subtest: ccs0
[513.545748] Dynamic subtest ccs0: SUCCESS (1.536s)
[513.548145] Subtest userptr: SUCCESS (9.968s)
[513.739257] [112/133] (509s left) gem_exec_fence (basic-busy-all)
[513.798242] Starting subtest: basic-busy-all
[513.884659] Subtest basic-busy-all: SUCCESS (0.088s)
[516.093377] [113/133] (507s left) gem_pxp (protected-raw-src-copy-not-readible)
[516.229741] Starting subtest: protected-raw-src-copy-not-readible
[516.290612] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.063s)
[516.423380] [114/133] (507s left) kms_big_fb (linear-8bpp-rotate-180)
[516.536615] Starting subtest: linear-8bpp-rotate-180
[517.760099] Subtest linear-8bpp-rotate-180: SUCCESS (1.224s)
[517.890420] [115/133] (505s left) syncobj_timeline (single-wait-for-submit-signaled)
[517.949960] Starting subtest: single-wait-for-submit-signaled
[517.951819] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[518.055416] [116/133] (505s left) kms_plane (plane-panning-bottom-right-suspend)
[518.151034] Starting subtest: plane-panning-bottom-right-suspend
[518.153067] Starting dynamic subtest: pipe-A
[535.684117] Dynamic subtest pipe-A: SUCCESS (2.917s)
[535.695139] Starting dynamic subtest: pipe-B
[553.696227] Dynamic subtest pipe-B: SUCCESS (3.458s)
[553.698363] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.378s)
[554.486654] [117/133] (469s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[554.582633] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[554.584783] Starting dynamic subtest: pipe-A-eDP-1
[554.604289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[554.615715] Starting dynamic subtest: pipe-B-eDP-1
[554.634796] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[554.643820] Starting dynamic subtest: pipe-C-eDP-1
[554.662371] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[554.671287] Starting dynamic subtest: pipe-D-eDP-1
[554.689755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[554.691810] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[556.854458] [118/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[556.945094] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[556.949418] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[557.050234] [119/133] (466s left) prime_self_import (reimport-vs-gem_close-race)
[557.087086] Starting subtest: reimport-vs-gem_close-race
[562.183188] Subtest reimport-vs-gem_close-race: SUCCESS (5.117s)
[562.246641] [120/133] (461s left) kms_cursor_crc (cursor-onscreen-256x256)
[562.485171] Starting subtest: cursor-onscreen-256x256
[562.490023] Starting dynamic subtest: pipe-A-eDP-1
[564.600454] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[564.628474] Starting dynamic subtest: pipe-D-eDP-1
[567.368141] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s)
[567.370581] Subtest cursor-onscreen-256x256: SUCCESS (4.899s)
[568.167851] [121/133] (455s left) gem_busy (semaphore)
[568.342980] Subtest semaphore: SKIP (0.000s)
[568.578551] [122/133] (455s left) syncobj_timeline (invalid-wait-bad-flags)
[568.630140] Starting subtest: invalid-wait-bad-flags
[568.632340] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[568.733191] [123/133] (455s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[568.830975] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[568.834839] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[568.931522] [124/133] (455s left) syncobj_basic (test-valid-cycle)
[568.987965] Starting subtest: test-valid-cycle
[568.990332] Subtest test-valid-cycle: SUCCESS (0.000s)
[569.093940] [125/133] (455s left) kms_atomic_interruptible (legacy-cursor)
[569.180156] Starting subtest: legacy-cursor
[569.182396] Starting dynamic subtest: pipe-A-eDP-1
[576.568329] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.398s)
[576.570747] Subtest legacy-cursor: SUCCESS (7.400s)
[577.413505] [126/133] (446s left) kms_hdr (bpc-switch)
[577.502205] Starting subtest: bpc-switch
[578.586818] Starting dynamic subtest: pipe-A-eDP-1
[581.990476] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.406s)
[581.992912] Subtest bpc-switch: SUCCESS (4.495s)
[582.105057] [127/133] (442s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[582.199289] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[589.094738] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.899s)
[589.221582] [128/133] (435s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[589.318347] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[589.322479] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[589.401650] [129/133] (435s left) kms_content_protection (atomic-dpms)
[589.544956] Starting subtest: atomic-dpms
[589.549357] Subtest atomic-dpms: SKIP (0.000s)
[589.675492] [130/133] (434s left) perf_pmu (idle-no-semaphores)
[589.717327] Starting subtest: idle-no-semaphores
[589.719219] Starting dynamic subtest: rcs0
[590.268753] Dynamic subtest rcs0: SUCCESS (0.552s)
[590.280259] Starting dynamic subtest: bcs0
[590.791567] Dynamic subtest bcs0: SUCCESS (0.520s)
[590.802829] Starting dynamic subtest: vcs0
[591.308240] Dynamic subtest vcs0: SUCCESS (0.513s)
[591.318784] Starting dynamic subtest: vcs1
[591.827406] Dynamic subtest vcs1: SUCCESS (0.516s)
[591.838358] Starting dynamic subtest: vecs0
[592.345138] Dynamic subtest vecs0: SUCCESS (0.515s)
[592.355527] Starting dynamic subtest: ccs0
[592.860563] Dynamic subtest ccs0: SUCCESS (0.512s)
[592.863421] Subtest idle-no-semaphores: SUCCESS (3.146s)
[592.970610] [131/133] (431s left) perf_pmu (busy)
[593.011348] Starting subtest: busy
[593.013774] Starting dynamic subtest: rcs0
[593.630326] Dynamic subtest rcs0: SUCCESS (0.618s)
[593.640663] Starting dynamic subtest: bcs0
[594.194772] Dynamic subtest bcs0: SUCCESS (0.563s)
[594.206242] Starting dynamic subtest: vcs0
[596.252119] Dynamic subtest vcs0: SUCCESS (2.054s)
[596.264668] Starting dynamic subtest: vcs1
[598.237361] Dynamic subtest vcs1: SUCCESS (1.982s)
[598.249777] Starting dynamic subtest: vecs0
[600.220962] Dynamic subtest vecs0: SUCCESS (1.980s)
[600.233925] Starting dynamic subtest: ccs0
[600.783366] Dynamic subtest ccs0: SUCCESS (0.561s)
[600.786192] Subtest busy: SUCCESS (7.773s)
[600.913531] [132/133] (423s left) kms_addfb_basic (bo-too-small)
[601.023609] Starting subtest: bo-too-small
[601.025803] Subtest bo-too-small: SUCCESS (0.000s)
[601.139170] [133/133] (423s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[601.225142] Starting subtest: crc-primary-suspend-y-tiled-ccs
[601.227422] Starting dynamic subtest: pipe-A-eDP-1
[601.236397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[601.248742] Starting dynamic subtest: pipe-B-eDP-1
[601.258293] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[601.267613] Starting dynamic subtest: pipe-C-eDP-1
[601.276546] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[601.285515] Starting dynamic subtest: pipe-D-eDP-1
[601.293976] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[601.297975] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.006s)
[603.447403] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_pipe_crc_basic
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: i915_query
results: parsing output: 17/ for test: kms_dirtyfb
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: api_intel_allocator
results: parsing output: 21/ for test: prime_busy
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_exec_nop
results: parsing output: 25/ for test: gem_ctx_engines
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: gem_ctx_sseu
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: sysfs_preempt_timeout
results: parsing output: 34/ for test: gem_exec_capture
results: parsing output: 35/ for test: gem_readwrite
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_unref_active_buffers
results: parsing output: 40/ for test: gen9_exec_parse
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_atomic
results: parsing output: 43/ for test: kms_universal_plane
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: i915_module_load
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_joiner
results: parsing output: 60/ for test: gem_exec_suspend
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_partial_pwrite_pread
results: parsing output: 67/ for test: drm_read
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_huc_copy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: core_setmaster
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: kms_color
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: kms_draw_crc
results: parsing output: 98/ for test: kms_chamelium_edid
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_exec_parallel
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_busy
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: syncobj_basic
results: parsing output: 124/ for test: kms_atomic_interruptible
results: parsing output: 125/ for test: kms_hdr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: kms_ccs
Done.