[61.916586] Initializing watchdogs
[61.916633]   /dev/watchdog0
[61.930783] [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]
[61.935281] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.937449] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.940800] [001/132] (960s left) kms_dsc (dsc-with-formats)
[62.061818] Starting subtest: dsc-with-formats
[62.100112] Subtest dsc-with-formats: SKIP (0.001s)
[62.152383] [002/132] (960s left) vgem_basic (bad-handle)
[62.220619] Starting subtest: bad-handle
[62.222657] Subtest bad-handle: SUCCESS (0.000s)
[62.300528] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[62.303405] [003/132] (960s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[62.368449] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[62.431643] [004/132] (960s left) kms_pm_rpm (basic-rte)
[62.469052] Starting subtest: basic-rte
[65.550191] Subtest basic-rte: SUCCESS (3.082s)
[67.417074] [005/132] (955s left) i915_pm_rps (thresholds-park)
[67.613193] Starting subtest: thresholds-park
[67.618084] Subtest thresholds-park: SKIP (0.001s)
[67.848229] [006/132] (954s left) gem_ctx_persistence (engines-cleanup)
[67.982342] Starting subtest: engines-cleanup
[67.984705] Starting dynamic subtest: rcs0
[68.158050] Dynamic subtest rcs0: SUCCESS (0.175s)
[68.167720] Starting dynamic subtest: bcs0
[68.212270] Dynamic subtest bcs0: SUCCESS (0.053s)
[68.221975] Starting dynamic subtest: vcs0
[68.274321] Dynamic subtest vcs0: SUCCESS (0.061s)
[68.283450] Starting dynamic subtest: vcs1
[68.335304] Dynamic subtest vcs1: SUCCESS (0.060s)
[68.345654] Starting dynamic subtest: vecs0
[68.384715] Dynamic subtest vecs0: SUCCESS (0.049s)
[68.395147] Starting dynamic subtest: ccs0
[68.434885] Dynamic subtest ccs0: SUCCESS (0.049s)
[68.437737] Subtest engines-cleanup: SUCCESS (0.452s)
[68.540411] [007/132] (954s left) syncobj_eventfd (timeline-wait-signaled)
[68.598958] Starting subtest: timeline-wait-signaled
[68.601433] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[68.727316] [008/132] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[68.829756] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[68.834068] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[68.935670] [009/132] (953s left) kms_cursor_crc (cursor-sliding-64x64)
[69.103689] Starting subtest: cursor-sliding-64x64
[69.118663] Starting dynamic subtest: pipe-A-eDP-1
[72.361083] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.241s)
[72.391505] Starting dynamic subtest: pipe-D-eDP-1
[76.250203] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.863s)
[76.252507] Subtest cursor-sliding-64x64: SUCCESS (7.145s)
[77.147774] [010/132] (945s left) kms_flip (flip-vs-panning-interruptible)
[77.239831] Starting subtest: flip-vs-panning-interruptible
[77.242338] Starting dynamic subtest: A-eDP1
[85.942993] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[85.951054] Starting dynamic subtest: B-eDP1
[94.665913] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[94.673090] Starting dynamic subtest: C-eDP1
[103.383180] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[103.391461] Starting dynamic subtest: D-eDP1
[112.028563] Dynamic subtest D-eDP1: SUCCESS (8.644s)
[112.032572] Subtest flip-vs-panning-interruptible: SUCCESS (34.792s)
[113.213482] [011/132] (909s left) kms_psr (psr-dpms)
[113.322286] Starting subtest: psr-dpms
[113.324246] Starting dynamic subtest: eDP-1
[116.320090] Dynamic subtest eDP-1: SUCCESS (2.998s)
[116.322405] Subtest psr-dpms: SUCCESS (2.999s)
[117.210274] [012/132] (905s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[117.311473] Starting subtest: psr-farfromfence-mmap-gtt
[117.315698] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[117.424298] [013/132] (905s left) gem_ringfill (engines-basic)
[122.903859] Starting subtest: engines-basic
[122.906647] Starting dynamic subtest: rcs0
[122.954182] Dynamic subtest rcs0: SUCCESS (0.051s)
[122.964283] Starting dynamic subtest: bcs0
[122.997972] Dynamic subtest bcs0: SUCCESS (0.043s)
[123.007457] Starting dynamic subtest: vcs0
[123.041035] Dynamic subtest vcs0: SUCCESS (0.042s)
[123.050808] Starting dynamic subtest: vcs1
[123.084038] Dynamic subtest vcs1: SUCCESS (0.042s)
[123.093757] Starting dynamic subtest: vecs0
[123.127131] Dynamic subtest vecs0: SUCCESS (0.042s)
[123.136399] Starting dynamic subtest: ccs0
[123.171907] Dynamic subtest ccs0: SUCCESS (0.043s)
[123.174430] Subtest engines-basic: SUCCESS (0.270s)
[123.276083] [014/132] (899s left) i915_hangman (engine-engine-hang)
[123.346891] Starting subtest: engine-engine-hang
[123.348836] Starting dynamic subtest: rcs0
[124.852339] Dynamic subtest rcs0: SUCCESS (1.505s)
[124.863113] Starting dynamic subtest: bcs0
[126.898599] Dynamic subtest bcs0: SUCCESS (2.045s)
[126.909465] Starting dynamic subtest: vcs0
[128.882387] Dynamic subtest vcs0: SUCCESS (1.981s)
[128.892080] Starting dynamic subtest: vcs1
[130.867398] Dynamic subtest vcs1: SUCCESS (1.983s)
[130.878059] Starting dynamic subtest: vecs0
[132.850803] Dynamic subtest vecs0: SUCCESS (1.982s)
[132.861623] Starting dynamic subtest: ccs0
[134.898771] Dynamic subtest ccs0: SUCCESS (2.046s)
[134.901852] Subtest engine-engine-hang: SUCCESS (11.553s)
[135.003415] [015/132] (888s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[135.059336] Starting subtest: invalid-multi-wait-unsubmitted
[135.061359] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[135.196219] [016/132] (887s left) sysfs_heartbeat_interval (idempotent)
[135.261629] Starting subtest: idempotent
[135.263891] Starting dynamic subtest: vecs0
[135.266238] Dynamic subtest vecs0: SUCCESS (0.001s)
[135.275028] Starting dynamic subtest: ccs0
[135.276902] Dynamic subtest ccs0: SUCCESS (0.002s)
[135.283501] Starting dynamic subtest: vcs0
[135.285400] Dynamic subtest vcs0: SUCCESS (0.000s)
[135.291837] Starting dynamic subtest: bcs0
[135.293762] Dynamic subtest bcs0: SUCCESS (0.002s)
[135.300176] Starting dynamic subtest: rcs0
[135.302052] Dynamic subtest rcs0: SUCCESS (0.001s)
[135.308606] Starting dynamic subtest: vcs1
[135.310525] Dynamic subtest vcs1: SUCCESS (0.000s)
[135.312439] Subtest idempotent: SUCCESS (0.009s)
[135.411256] [017/132] (887s left) kms_pm_dc (dc5-dpms-negative)
[136.524097] Starting subtest: dc5-dpms-negative
[136.528616] Subtest dc5-dpms-negative: SKIP (0.000s)
[136.618596] [018/132] (886s left) gem_exec_schedule (preemptive-hang)
[136.797553] Starting subtest: preemptive-hang
[136.799501] Starting dynamic subtest: rcs0
[146.043787] Dynamic subtest rcs0: SUCCESS (9.247s)
[146.054072] Starting dynamic subtest: bcs0
[155.009442] Dynamic subtest bcs0: SUCCESS (8.963s)
[155.016882] Starting dynamic subtest: vcs0
[164.027918] Dynamic subtest vcs0: SUCCESS (9.017s)
[164.035574] Starting dynamic subtest: vcs1
[173.054611] Dynamic subtest vcs1: SUCCESS (9.023s)
[173.065271] Starting dynamic subtest: vecs0
[182.009540] Dynamic subtest vecs0: SUCCESS (8.955s)
[182.016832] Starting dynamic subtest: ccs0
[191.038853] Dynamic subtest ccs0: SUCCESS (9.026s)
[191.040947] Subtest preemptive-hang: SUCCESS (54.239s)
[191.309775] [019/132] (831s left) drm_read (short-buffer-wakeup)
[191.468201] Starting subtest: short-buffer-wakeup
[223.687946] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[223.876846] [020/132] (799s left) gem_ctx_engines (independent)
[223.946264] Starting subtest: independent
[223.948559] Starting dynamic subtest: rcs0
[224.086022] Dynamic subtest rcs0: SUCCESS (0.138s)
[224.096400] Starting dynamic subtest: bcs0
[224.201866] Dynamic subtest bcs0: SUCCESS (0.115s)
[224.212573] Starting dynamic subtest: vcs0
[224.335551] Dynamic subtest vcs0: SUCCESS (0.133s)
[224.345710] Starting dynamic subtest: vcs1
[224.453576] Dynamic subtest vcs1: SUCCESS (0.118s)
[224.460912] Starting dynamic subtest: vecs0
[224.570525] Dynamic subtest vecs0: SUCCESS (0.116s)
[224.580616] Starting dynamic subtest: ccs0
[224.695959] Dynamic subtest ccs0: SUCCESS (0.125s)
[224.706296] Starting dynamic subtest: all-engines
[225.124048] Dynamic subtest all-engines: SUCCESS (0.427s)
[225.126608] Subtest independent: SUCCESS (1.176s)
[226.117015] [021/132] (797s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[226.212964] Starting subtest: fbc-psr2-sprite-plane-onoff
[226.215191] Starting dynamic subtest: eDP-1
[226.219170] Dynamic subtest eDP-1: SKIP (0.000s)
[226.223113] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[226.308074] [022/132] (797s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[231.257620] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[231.262727] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[232.137114] [023/132] (791s left) gem_exec_reloc (basic-cpu)
[232.193518] Subtest basic-cpu: SKIP (0.000s)
[232.269140] [024/132] (791s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[232.372423] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[233.162787] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.792s)
[233.369694] [025/132] (790s left) i915_query (query-topology-kernel-writes)
[233.426417] Starting subtest: query-topology-kernel-writes
[233.428583] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[233.562535] [026/132] (789s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[238.577908] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[238.582282] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[239.461634] [027/132] (784s left) gem_exec_fence (syncobj-repeat)
[239.896045] Starting subtest: syncobj-repeat
[240.071928] Subtest syncobj-repeat: SUCCESS (0.174s)
[241.055385] [028/132] (782s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[241.157197] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[245.171508] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.017s)
[246.372375] [029/132] (777s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[246.487772] Starting subtest: fbcpsr-tiling-4
[253.566233] Subtest fbcpsr-tiling-4: SUCCESS (7.082s)
[253.746854] [030/132] (769s left) syncobj_wait (invalid-reset-one-illegal-handle)
[253.815781] Starting subtest: invalid-reset-one-illegal-handle
[253.818052] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[253.925944] [031/132] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[254.021900] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[254.026195] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[254.144961] [032/132] (769s left) gem_exec_balancer (bonded-true-hang)
[254.395747] Starting subtest: bonded-true-hang
[254.401072] Subtest bonded-true-hang: SKIP (0.000s)
[254.527446] [033/132] (769s left) i915_drm_fdinfo (virtual-busy-hang)
[254.567246] Starting subtest: virtual-busy-hang
[254.571444] Subtest virtual-busy-hang: SKIP (0.000s)
[254.659230] [034/132] (769s left) kms_flip (2x-flip-vs-panning-interruptible)
[254.755429] Starting subtest: 2x-flip-vs-panning-interruptible
[254.768049] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[254.914923] [035/132] (768s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[255.043472] Starting subtest: flip-vs-cursor-busy-crc-legacy
[255.869639] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.827s)
[256.716466] [036/132] (767s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[256.826680] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[257.816528] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.989s)
[257.992685] [037/132] (765s left) syncobj_wait (wait-delayed-signal)
[258.054055] Starting subtest: wait-delayed-signal
[258.156100] Subtest wait-delayed-signal: SUCCESS (0.103s)
[258.257148] [038/132] (765s left) kms_plane_scaling (planes-downscale-factor-0-5)
[258.354073] Starting subtest: planes-downscale-factor-0-5
[258.356365] Starting dynamic subtest: pipe-A
[258.375495] Dynamic subtest pipe-A: SKIP (0.018s)
[258.383636] Starting dynamic subtest: pipe-B
[258.405810] Dynamic subtest pipe-B: SKIP (0.030s)
[258.414501] Starting dynamic subtest: pipe-C
[258.437565] Dynamic subtest pipe-C: SKIP (0.031s)
[258.445211] Starting dynamic subtest: pipe-D
[258.468562] Dynamic subtest pipe-D: SKIP (0.031s)
[258.472952] Subtest planes-downscale-factor-0-5: SKIP (0.112s)
[258.613898] [039/132] (765s left) kms_flip_event_leak (basic)
[258.705043] Starting subtest: basic
[258.706913] Starting dynamic subtest: pipe-A-eDP-1
[259.124579] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[259.132729] Starting dynamic subtest: pipe-B-eDP-1
[260.218769] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.092s)
[260.226150] Starting dynamic subtest: pipe-C-eDP-1
[261.330785] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[261.339278] Starting dynamic subtest: pipe-D-eDP-1
[262.466238] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[262.468513] Subtest basic: SUCCESS (3.764s)
[263.344568] [040/132] (760s left) kms_psr (pr-primary-mmap-gtt)
[263.471194] Starting subtest: pr-primary-mmap-gtt
[263.475819] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[263.570666] [041/132] (760s left) perf_pmu (idle)
[263.616707] Starting subtest: idle
[263.618592] Starting dynamic subtest: rcs0
[264.174081] Dynamic subtest rcs0: SUCCESS (0.557s)
[264.185182] Starting dynamic subtest: bcs0
[264.703345] Dynamic subtest bcs0: SUCCESS (0.526s)
[264.713181] Starting dynamic subtest: vcs0
[265.230763] Dynamic subtest vcs0: SUCCESS (0.525s)
[265.242189] Starting dynamic subtest: vcs1
[265.761669] Dynamic subtest vcs1: SUCCESS (0.527s)
[265.770261] Starting dynamic subtest: vecs0
[266.288982] Dynamic subtest vecs0: SUCCESS (0.525s)
[266.300461] Starting dynamic subtest: ccs0
[266.812453] Dynamic subtest ccs0: SUCCESS (0.521s)
[266.815227] Subtest idle: SUCCESS (3.198s)
[266.944415] [042/132] (757s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[267.065310] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[268.145945] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.079s)
[268.313070] [043/132] (755s left) kms_chamelium_color (ctm-0-25)
[268.417864] Subtest ctm-0-25: SKIP (0.000s)
[268.487352] [044/132] (755s left) i915_pm_rc6_residency (rc6-idle)
[268.545052] Starting subtest: rc6-idle
[268.592072] Starting dynamic subtest: gt0-rcs0
[292.875988] Dynamic subtest gt0-rcs0: SUCCESS (24.282s)
[292.886185] Starting dynamic subtest: gt0-bcs0
[317.143071] Dynamic subtest gt0-bcs0: SUCCESS (24.264s)
[317.153069] Starting dynamic subtest: gt0-ccs0
[341.422443] Dynamic subtest gt0-ccs0: SUCCESS (24.276s)
[341.432492] Starting dynamic subtest: gt1-vcs0
[347.597777] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[347.609198] Starting dynamic subtest: gt1-vecs0
[353.769597] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[353.772535] Subtest rc6-idle: SUCCESS (85.222s)
[353.879726] [045/132] (670s left) api_intel_allocator (standalone)
[353.935185] Starting subtest: standalone
[353.953360] Subtest standalone: SUCCESS (0.021s)
[354.110337] [046/132] (670s left) kms_atomic (plane-cursor-legacy)
[354.217918] Starting subtest: plane-cursor-legacy
[354.220141] Starting dynamic subtest: pipe-A-eDP-1
[354.631164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s)
[354.633410] Subtest plane-cursor-legacy: SUCCESS (0.412s)
[355.479789] [047/132] (668s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[355.586477] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[355.588869] Starting dynamic subtest: pipe-A-eDP-1
[355.612337] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.621984] Starting dynamic subtest: pipe-B-eDP-1
[355.643857] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.651853] Starting dynamic subtest: pipe-C-eDP-1
[355.674088] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.681892] Starting dynamic subtest: pipe-D-eDP-1
[355.704446] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.709058] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[357.756829] [048/132] (666s left) kms_flip (plain-flip-fb-recreate)
[357.861072] Starting subtest: plain-flip-fb-recreate
[357.863289] Starting dynamic subtest: A-eDP1
[366.724536] Dynamic subtest A-eDP1: SUCCESS (8.863s)
[366.736168] Starting dynamic subtest: B-eDP1
[375.562786] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[375.571604] Starting dynamic subtest: C-eDP1
[384.380832] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[384.390362] Starting dynamic subtest: D-eDP1
[393.205216] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[393.209959] Subtest plain-flip-fb-recreate: SUCCESS (35.347s)
[394.403641] [049/132] (630s left) gem_eio (create-ext)
[394.642591] Starting subtest: create-ext
[394.982784] Subtest create-ext: SUCCESS (0.342s)
[395.146856] [050/132] (629s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[395.433889] Starting subtest: cursor-rapid-movement-512x512
[395.438408] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[395.642791] [051/132] (628s left) gem_mmap_offset (basic-uaf)
[395.702701] Starting subtest: basic-uaf
[395.704675] Subtest basic-uaf: SUCCESS (0.001s)
[395.844037] [052/132] (628s left) kms_psr (fbc-pr-cursor-blt)
[395.936505] Starting subtest: fbc-pr-cursor-blt
[395.940232] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[396.034537] [053/132] (628s left) gem_mmap (bad-offset)
[396.103568] Subtest bad-offset: SKIP (0.000s)
[396.178062] [054/132] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[396.282653] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[396.286307] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[396.421127] [055/132] (628s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[396.525468] Starting subtest: stress-xrgb8888-xtiled
[402.492949] Subtest stress-xrgb8888-xtiled: SUCCESS (5.967s)
[402.540184] [056/132] (622s left) prime_self_import (basic-with_two_bos)
[402.571541] Starting subtest: basic-with_two_bos
[402.594771] Subtest basic-with_two_bos: SUCCESS (0.025s)
[402.738438] [057/132] (622s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[402.836551] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[409.874747] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.040s)
[410.056733] [058/132] (614s left) prime_busy (hang)
[410.120424] Starting subtest: hang
[410.122662] Starting dynamic subtest: rcs0
[436.403866] Dynamic subtest rcs0: SUCCESS (26.282s)
[436.413969] Starting dynamic subtest: bcs0
[443.567106] Dynamic subtest bcs0: SUCCESS (7.162s)
[443.574774] Starting dynamic subtest: vcs0
[450.529774] Dynamic subtest vcs0: SUCCESS (6.962s)
[450.537835] Starting dynamic subtest: vcs1
[457.568885] Dynamic subtest vcs1: SUCCESS (7.038s)
[457.576664] Starting dynamic subtest: vecs0
[464.542848] Dynamic subtest vecs0: SUCCESS (6.973s)
[464.550715] Starting dynamic subtest: ccs0
[478.444727] Dynamic subtest ccs0: SUCCESS (13.903s)
[478.448294] Subtest hang: SUCCESS (68.326s)
[478.593980] [059/132] (546s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[478.684738] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[478.686863] Starting dynamic subtest: pipe-A-eDP-1
[478.708472] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[478.717954] Starting dynamic subtest: pipe-B-eDP-1
[478.738575] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[478.746393] Starting dynamic subtest: pipe-C-eDP-1
[478.767318] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[478.774884] Starting dynamic subtest: pipe-D-eDP-1
[478.796592] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[478.800957] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[481.000084] [060/132] (543s left) syncobj_wait (invalid-signal-bad-pad)
[481.058815] Starting subtest: invalid-signal-bad-pad
[481.061535] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[481.192626] [061/132] (543s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[481.261497] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[481.263822] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[481.383110] [062/132] (543s left) gem_linear_blits (normal)
[481.880230] Starting subtest: normal
[486.122779] Subtest normal: SUCCESS (4.241s)
[486.295601] [063/132] (538s left) kms_cursor_crc (cursor-offscreen-128x128)
[486.552905] Starting subtest: cursor-offscreen-128x128
[486.555144] Starting dynamic subtest: pipe-A-eDP-1
[488.510994] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s)
[488.540345] Starting dynamic subtest: pipe-D-eDP-1
[491.075518] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[491.077850] Subtest cursor-offscreen-128x128: SUCCESS (4.525s)
[491.967296] [064/132] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[492.066697] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[498.796134] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.732s)
[498.981981] [065/132] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[499.085515] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[499.089653] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[499.226891] [066/132] (525s left) gem_ctx_persistence (process)
[499.300721] Starting subtest: process
[499.571048] Subtest process: SUCCESS (0.270s)
[499.675333] [067/132] (525s left) kms_force_connector_basic (force-edid)
[499.761558] Starting subtest: force-edid
[500.124269] Subtest force-edid: SUCCESS (0.365s)
[500.290112] [068/132] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[500.372303] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[500.375903] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[500.514080] [069/132] (524s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[500.611543] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[500.613446] Starting dynamic subtest: pipe-A-eDP-1
[500.631824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[500.640580] Starting dynamic subtest: pipe-B-eDP-1
[500.656889] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[500.664356] Starting dynamic subtest: pipe-C-eDP-1
[500.681393] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[500.688917] Starting dynamic subtest: pipe-D-eDP-1
[500.706293] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[500.709750] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[502.901759] [070/132] (522s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[503.002563] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[510.318285] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.319s)
[510.477505] [071/132] (514s left) gem_exercise_blt (fast-copy-emit)
[510.541042] Starting subtest: fast-copy-emit
[510.543269] Starting dynamic subtest: linear-smem-smem-emit
[510.562439] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[510.573136] Starting dynamic subtest: xmajor-smem-smem-emit
[510.579854] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[510.588290] Starting dynamic subtest: tile4-smem-smem-emit
[510.597283] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[510.605765] Starting dynamic subtest: tile64-smem-smem-emit
[510.614281] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[510.616542] Subtest fast-copy-emit: SUCCESS (0.075s)
[510.780448] [072/132] (514s left) drm_read (short-buffer-block)
[510.936079] Starting subtest: short-buffer-block
[510.938535] Subtest short-buffer-block: SUCCESS (0.000s)
[511.096830] [073/132] (514s left) kms_atomic_interruptible (universal-setplane-primary)
[511.202057] Starting subtest: universal-setplane-primary
[511.204246] Starting dynamic subtest: pipe-A-eDP-1
[518.571336] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.367s)
[518.573684] Subtest universal-setplane-primary: SUCCESS (7.369s)
[519.399683] [074/132] (506s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[519.501375] Starting subtest: invalidate-primary-flip-overlay
[530.247198] Subtest invalidate-primary-flip-overlay: SUCCESS (10.748s)
[530.396109] [075/132] (495s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[530.483434] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[530.485267] Starting dynamic subtest: pipe-A-eDP-1
[530.626088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[530.636347] Starting dynamic subtest: pipe-B-eDP-1
[530.652776] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[530.661447] Starting dynamic subtest: pipe-C-eDP-1
[530.676741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[530.684901] Starting dynamic subtest: pipe-D-eDP-1
[530.700494] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[530.702238] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[532.892299] [076/132] (492s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[532.988170] Starting subtest: async-flip-with-page-flip-events-tiled
[533.357913] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[536.110839] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[536.127224] Starting dynamic subtest: pipe-A-eDP-1-4
[538.293482] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[538.306655] Starting dynamic subtest: pipe-A-eDP-1-4
[540.295733] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[540.304903] Starting dynamic subtest: pipe-A-eDP-1-x
[542.496895] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[542.861386] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[545.611199] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[545.620517] Starting dynamic subtest: pipe-B-eDP-1-4
[547.797437] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[547.806489] Starting dynamic subtest: pipe-B-eDP-1-4
[549.807830] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[549.819540] Starting dynamic subtest: pipe-B-eDP-1-x
[551.998406] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[552.362710] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[555.109257] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.752s)
[555.118660] Starting dynamic subtest: pipe-C-eDP-1-4
[557.284493] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[557.293310] Starting dynamic subtest: pipe-C-eDP-1-4
[559.295107] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[559.304208] Starting dynamic subtest: pipe-C-eDP-1-x
[561.474339] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[561.839123] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[564.611949] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.779s)
[564.623761] Starting dynamic subtest: pipe-D-eDP-1-4
[566.776075] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[566.787675] Starting dynamic subtest: pipe-D-eDP-1-4
[568.786606] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[568.796910] Starting dynamic subtest: pipe-D-eDP-1-x
[570.953454] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.166s)
[570.955726] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (37.965s)
[572.188523] [077/132] (453s left) gem_exec_balancer (persistence)
[572.454022] Starting subtest: persistence
[573.342606] Subtest persistence: SUCCESS (0.888s)
[573.506691] [078/132] (452s left) gem_exec_schedule (semaphore-codependency)
[573.574063] Starting subtest: semaphore-codependency
[573.580632] Subtest semaphore-codependency: SUCCESS (0.014s)
[573.941604] [079/132] (451s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[574.041131] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[578.477600] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.439s)
[579.702312] [080/132] (446s left) kms_psr (pr-sprite-blt)
[579.798379] Starting subtest: pr-sprite-blt
[579.802591] Subtest pr-sprite-blt: SKIP (0.000s)
[579.898083] [081/132] (445s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[580.010585] Starting subtest: flip-vs-cursor-legacy
[587.151153] Subtest flip-vs-cursor-legacy: SUCCESS (7.141s)
[588.013260] [082/132] (437s left) core_getclient (basic)
[588.069599] Starting subtest: basic
[588.071800] Subtest basic: SUCCESS (0.000s)
[588.211312] [083/132] (437s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[588.341846] Starting subtest: verify-pxp-key-change-after-suspend-resume
[599.307040] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (10.967s)
[599.465030] [084/132] (426s left) kms_plane_multiple (tiling-x)
[599.572397] Starting subtest: tiling-x
[599.574602] Starting dynamic subtest: pipe-A-eDP-1
[603.409822] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.836s)
[603.419378] Starting dynamic subtest: pipe-B-eDP-1
[607.995550] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.583s)
[608.005630] Starting dynamic subtest: pipe-C-eDP-1
[612.592145] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.596s)
[612.602101] Starting dynamic subtest: pipe-D-eDP-1
[617.183929] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.591s)
[617.186596] Subtest tiling-x: SUCCESS (17.613s)
[618.091028] [085/132] (407s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[618.192304] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[618.196653] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[618.320352] [086/132] (407s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[618.412091] Starting subtest: y-tiled-8bpp-rotate-0
[618.416620] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[618.546477] [087/132] (407s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[618.648072] Starting subtest: yf-tiled-8bpp-rotate-270
[618.652600] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[618.774934] [088/132] (407s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[618.899783] Starting subtest: cursorB-vs-flipA-atomic
[618.904355] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[619.070044] [089/132] (407s left) gem_exec_params (no-vebox)
[619.130659] Starting subtest: no-vebox
[619.132657] Subtest no-vebox: SUCCESS (0.002s)
[620.959126] [090/132] (405s left) gem_mmap_gtt (big-copy-odd)
[621.020896] Subtest big-copy-odd: SKIP (0.000s)
[621.080465] [091/132] (405s left) gem_eio (in-flight-contexts-immediate)
[621.320572] Starting subtest: in-flight-contexts-immediate
[634.850200] Subtest in-flight-contexts-immediate: SUCCESS (13.528s)
[635.045077] [092/132] (391s left) kms_universal_plane (universal-plane-pageflip-windowed)
[635.143183] Starting subtest: universal-plane-pageflip-windowed
[635.145469] Starting dynamic subtest: pipe-A-eDP-1
[635.722444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[635.732886] Starting dynamic subtest: pipe-B-eDP-1
[636.962650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.237s)
[636.972694] Starting dynamic subtest: pipe-C-eDP-1
[638.146495] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s)
[638.157041] Starting dynamic subtest: pipe-D-eDP-1
[639.346768] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[639.349091] Subtest universal-plane-pageflip-windowed: SUCCESS (4.205s)
[640.185661] [093/132] (386s left) kms_hdmi_inject (inject-audio)
[640.547781] Starting subtest: inject-audio
[640.826707] Subtest inject-audio: SUCCESS (0.280s)
[641.412027] [094/132] (384s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[641.472356] Starting subtest: etime-multi-wait-all-submitted-signaled
[641.576972] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[641.676682] [095/132] (384s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[646.656888] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[646.661503] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[647.491486] [096/132] (378s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[647.549692] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[647.551964] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[647.689443] [097/132] (378s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[647.787224] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[647.791150] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[647.927079] [098/132] (378s left) kms_vrr (negative-basic)
[648.025175] Starting subtest: negative-basic
[648.031491] Starting dynamic subtest: pipe-A-eDP-1
[653.448297] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[653.739325] Subtest negative-basic: SUCCESS (5.712s)
[654.588584] [099/132] (371s left) gem_tiled_fence_blits (basic)
[654.656970] Subtest basic: SKIP (0.000s)
[654.746325] [100/132] (371s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[654.875040] Starting subtest: 2x-long-flip-vs-cursor-atomic
[654.882101] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.003s)
[655.069253] [101/132] (371s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[655.145776] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[655.248340] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[655.351329] [102/132] (371s left) sw_sync (sync_busy)
[655.392786] Starting subtest: sync_busy
[655.395033] Subtest sync_busy: SUCCESS (0.002s)
[655.479086] [103/132] (371s left) gem_wait (write-busy)
[655.534989] Starting subtest: write-busy
[655.537435] Starting dynamic subtest: all-engines
[656.169630] Dynamic subtest all-engines: SUCCESS (0.634s)
[656.187386] Starting dynamic subtest: rcs0
[656.727600] Dynamic subtest rcs0: SUCCESS (0.556s)
[656.744900] Starting dynamic subtest: bcs0
[657.277864] Dynamic subtest bcs0: SUCCESS (0.549s)
[657.293524] Starting dynamic subtest: vcs0
[658.900883] Dynamic subtest vcs0: SUCCESS (1.620s)
[658.922023] Starting dynamic subtest: vcs1
[660.884233] Dynamic subtest vcs1: SUCCESS (1.981s)
[660.900939] Starting dynamic subtest: vecs0
[662.932479] Dynamic subtest vecs0: SUCCESS (2.046s)
[662.949161] Starting dynamic subtest: ccs0
[663.484292] Dynamic subtest ccs0: SUCCESS (0.551s)
[663.486865] Subtest write-busy: SUCCESS (7.950s)
[663.706036] [104/132] (363s left) gem_exec_gttfill (multigpu-basic)
[663.894247] Starting subtest: multigpu-basic
[682.952722] Subtest multigpu-basic: SUCCESS (19.058s)
[683.010239] [105/132] (343s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[683.163017] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[683.167575] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[683.290344] [106/132] (343s left) kms_chamelium_frames (hdmi-crc-fast)
[683.691837] Subtest hdmi-crc-fast: SKIP (0.000s)
[684.540238] [107/132] (342s left) kms_rotation_crc (exhaust-fences)
[684.640303] Starting subtest: exhaust-fences
[684.644350] Subtest exhaust-fences: SKIP (0.000s)
[684.739992] [108/132] (342s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[684.841021] Starting subtest: extended-modeset-hang-oldfb-with-reset
[684.843425] Starting dynamic subtest: pipe-A
[696.800060] Dynamic subtest pipe-A: SUCCESS (11.957s)
[696.810465] Starting dynamic subtest: pipe-D
[709.102799] Dynamic subtest pipe-D: SUCCESS (12.299s)
[709.105015] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.261s)
[709.982182] [109/132] (317s left) kms_addfb_basic (unused-pitches)
[710.053732] Starting subtest: unused-pitches
[710.056240] Subtest unused-pitches: SUCCESS (0.000s)
[710.232130] [110/132] (316s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[710.331230] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[710.335743] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[710.456823] [111/132] (316s left) gem_exec_whisper (basic-forked)
[710.521176] Starting subtest: basic-forked
[718.684474] Subtest basic-forked: SUCCESS (8.161s)
[718.895074] [112/132] (308s left) gem_ppgtt (shrink-vs-evict-pinned)
[718.965019] Starting subtest: shrink-vs-evict-pinned
[724.927977] Subtest shrink-vs-evict-pinned: SUCCESS (5.961s)
[725.042040] [113/132] (302s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[725.169114] Starting subtest: cursorA-vs-flipB-legacy
[725.174471] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[725.345305] [114/132] (301s left) kms_flip (bo-too-big-interruptible)
[725.446874] Starting subtest: bo-too-big-interruptible
[725.449215] Starting dynamic subtest: A-eDP1
[726.771560] Dynamic subtest A-eDP1: SUCCESS (1.325s)
[726.783068] Starting dynamic subtest: B-eDP1
[728.077365] Dynamic subtest B-eDP1: SUCCESS (1.304s)
[728.091458] Starting dynamic subtest: C-eDP1
[729.384516] Dynamic subtest C-eDP1: SUCCESS (1.303s)
[729.396789] Starting dynamic subtest: D-eDP1
[730.684078] Dynamic subtest D-eDP1: SUCCESS (1.299s)
[730.686500] Subtest bo-too-big-interruptible: SUCCESS (5.241s)
[731.876236] [115/132] (295s left) gem_exec_params (cliprects_ptr-dirt)
[731.944708] Starting subtest: cliprects_ptr-dirt
[731.947210] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[732.079877] [116/132] (295s left) gen9_exec_parse (bb-start-param)
[732.151386] Subtest bb-start-param: SKIP (0.000s)
[732.240697] [117/132] (295s left) syncobj_wait (multi-wait-all-submitted-signaled)
[732.312244] Starting subtest: multi-wait-all-submitted-signaled
[732.416979] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[732.517050] [118/132] (294s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[732.621407] Starting subtest: disable-crc-after-crtc
[732.623601] Starting dynamic subtest: pipe-A-eDP-1
[734.256225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.636s)
[734.266262] Starting dynamic subtest: pipe-B-eDP-1
[736.559325] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.300s)
[736.569125] Starting dynamic subtest: pipe-C-eDP-1
[738.860272] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.298s)
[738.870757] Starting dynamic subtest: pipe-D-eDP-1
[741.139841] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.280s)
[741.142316] Subtest disable-crc-after-crtc: SUCCESS (8.520s)
[741.994697] [119/132] (285s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[742.102280] Starting subtest: invalid-modeset-force-ultra-joiner
[742.106600] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[742.193982] [120/132] (285s left) gem_eio (wait-wedge-immediate)
[742.424260] Starting subtest: wait-wedge-immediate
[743.975540] Subtest wait-wedge-immediate: SUCCESS (1.551s)
[744.152130] [121/132] (283s left) perf (polling)
[744.315697] Starting subtest: polling
[744.317876] Starting dynamic subtest: 0-rcs0
[754.341694] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[754.352264] Starting dynamic subtest: 1-vcs0
[764.365614] Dynamic subtest 1-vcs0: SUCCESS (10.021s)
[764.367899] Subtest polling: SUCCESS (20.050s)
[764.416215] [122/132] (263s left) gem_spin_batch (legacy-resubmit-new)
[764.483074] Starting subtest: legacy-resubmit-new
[764.485538] Starting dynamic subtest: default
[764.497123] Dynamic subtest default: SUCCESS (0.013s)
[764.508938] Starting dynamic subtest: render
[764.511290] Dynamic subtest render: SUCCESS (0.004s)
[764.521155] Starting dynamic subtest: bsd
[764.523516] Dynamic subtest bsd: SUCCESS (0.007s)
[764.533158] Starting dynamic subtest: bsd1
[764.535134] Dynamic subtest bsd1: SUCCESS (0.006s)
[764.545025] Starting dynamic subtest: bsd2
[764.547303] Dynamic subtest bsd2: SUCCESS (0.004s)
[764.556748] Starting dynamic subtest: blt
[764.559061] Dynamic subtest blt: SUCCESS (0.007s)
[764.568576] Starting dynamic subtest: vebox
[764.570729] Dynamic subtest vebox: SUCCESS (0.006s)
[764.572870] Subtest legacy-resubmit-new: SUCCESS (0.054s)
[765.976228] [123/132] (261s left) kms_color (ctm-0-25)
[766.079091] Starting subtest: ctm-0-25
[766.081199] Starting dynamic subtest: pipe-A-eDP-1
[769.597707] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.520s)
[769.607546] Starting dynamic subtest: pipe-B-eDP-1
[773.850691] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.251s)
[773.862540] Starting dynamic subtest: pipe-C-eDP-1
[777.846041] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.995s)
[777.857422] Starting dynamic subtest: pipe-D-eDP-1
[781.853573] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.007s)
[781.855887] Subtest ctm-0-25: SUCCESS (15.777s)
[782.683392] [124/132] (244s left) fbdev (unaligned-write)
[782.728043] Starting subtest: unaligned-write
[782.827598] Subtest unaligned-write: SUCCESS (0.099s)
[782.921054] [125/132] (244s left) kms_color_pipeline (plane-lut1d-lut1d)
[783.029127] Starting subtest: plane-lut1d-lut1d
[783.048104] Starting dynamic subtest: pipe-A-eDP-1
[783.744794] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[784.493778] Starting dynamic subtest: pipe-B-eDP-1
[785.300603] Dynamic subtest pipe-B-eDP-1: FAIL (0.295s)
[785.904289] Starting dynamic subtest: pipe-C-eDP-1
[786.737566] Dynamic subtest pipe-C-eDP-1: FAIL (0.247s)
[787.201193] Starting dynamic subtest: pipe-D-eDP-1
[788.039094] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[788.041565] Subtest plane-lut1d-lut1d: FAIL (4.722s)
[788.570740] [126/132] (239s left) kms_cursor_crc (cursor-onscreen-32x32)
[788.716224] Starting subtest: cursor-onscreen-32x32
[788.762938] Subtest cursor-onscreen-32x32: SKIP (0.041s)
[789.085274] [127/132] (238s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[789.182729] Starting subtest: x-tiled-8bpp-rotate-90
[789.203838] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[789.342305] [128/132] (238s left) kms_dirtyfb (default-dirtyfb-ioctl)
[789.441468] Starting subtest: default-dirtyfb-ioctl
[789.443714] Starting dynamic subtest: A-eDP-1
[791.027052] Dynamic subtest A-eDP-1: SUCCESS (1.585s)
[791.029589] Subtest default-dirtyfb-ioctl: SUCCESS (1.587s)
[791.875577] [129/132] (235s left) gem_userptr_blits (invalid-null-pointer)
[791.950584] Starting subtest: invalid-null-pointer
[791.952888] Subtest invalid-null-pointer: SUCCESS (0.001s)
[792.121620] [130/132] (235s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[792.223316] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[792.225590] Starting dynamic subtest: pipe-A-default-mode
[792.519603] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[792.524271] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.295s)
[793.371183] [131/132] (234s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[793.437981] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[793.509515] [132/132] (234s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[793.606173] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[800.057266] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.453s)
[800.216129] Closing watchdogs
results: parsing output: 0/ for test: kms_dsc
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: i915_pm_rps
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: syncobj_eventfd
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ringfill
results: parsing output: 13/ for test: i915_hangman
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: sysfs_heartbeat_interval
results: parsing output: 16/ for test: kms_pm_dc
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: drm_read
results: parsing output: 19/ for test: gem_ctx_engines
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: i915_query
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: kms_flip_event_leak
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_chamelium_color
results: parsing output: 43/ for test: i915_pm_rc6_residency
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_atomic
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: gem_eio
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_pipe_stress
results: parsing output: 55/ for test: prime_self_import
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: prime_busy
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_linear_blits
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_force_connector_basic
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exercise_blt
results: parsing output: 71/ for test: drm_read
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: kms_psr_stress_test
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_async_flips
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: core_getclient
results: parsing output: 82/ for test: gem_pxp
results: parsing output: 83/ for test: kms_plane_multiple
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_universal_plane
results: parsing output: 92/ for test: kms_hdmi_inject
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_vrr
results: parsing output: 98/ for test: gem_tiled_fence_blits
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: gem_wait
results: parsing output: 103/ for test: gem_exec_gttfill
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: kms_rotation_crc
results: parsing output: 107/ for test: kms_busy
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: gem_ppgtt
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: gen9_exec_parse
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_joiner
results: parsing output: 119/ for test: gem_eio
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: gem_spin_batch
results: parsing output: 122/ for test: kms_color
results: parsing output: 123/ for test: fbdev
results: parsing output: 124/ for test: kms_color_pipeline
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_dirtyfb
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: kms_pipe_b_c_ivb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.