[58.504727] Initializing watchdogs
[58.504774]   /dev/watchdog0
[58.518766] [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.523486] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.525854] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.529117] [001/133] (960s left) kms_flip (flip-vs-panning)
[58.648393] Starting subtest: flip-vs-panning
[58.650829] Starting dynamic subtest: A-eDP1
[67.397506] Dynamic subtest A-eDP1: SUCCESS (8.730s)
[67.409616] Starting dynamic subtest: B-eDP1
[76.152855] Dynamic subtest B-eDP1: SUCCESS (8.748s)
[76.162570] Starting dynamic subtest: C-eDP1
[84.874491] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[84.881687] Starting dynamic subtest: D-eDP1
[93.609493] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[93.614398] Subtest flip-vs-panning: SUCCESS (34.939s)
[94.768995] [002/133] (924s left) api_intel_allocator (standalone)
[94.829919] Starting subtest: standalone
[94.845436] Subtest standalone: SUCCESS (0.017s)
[94.952616] [003/133] (924s left) gem_exec_reloc (basic-gtt-read-noreloc)
[95.019649] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[95.092465] [004/133] (924s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[95.192227] Starting subtest: fbc-indfb-scaledprimary
[98.126808] Subtest fbc-indfb-scaledprimary: SUCCESS (2.939s)
[99.257857] [005/133] (919s left) gem_create (create-ext-placement-sanity-check)
[99.438786] Starting subtest: create-ext-placement-sanity-check
[99.441180] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[99.555087] [006/133] (919s left) i915_query (query-garbage)
[99.610259] Starting subtest: query-garbage
[99.612543] Subtest query-garbage: SUCCESS (0.000s)
[99.696785] [007/133] (919s left) kms_vblank (query-busy)
[99.795499] Starting subtest: query-busy
[99.797690] Starting dynamic subtest: pipe-A-eDP-1
[101.672585] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[101.688512] Starting dynamic subtest: pipe-D-eDP-1
[104.213346] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s)
[104.215652] Subtest query-busy: SUCCESS (4.417s)
[105.013985] [008/133] (914s left) kms_psr (fbc-psr2-sprite-blt)
[105.112486] Starting subtest: fbc-psr2-sprite-blt
[105.114590] Starting dynamic subtest: eDP-1
[105.118566] Dynamic subtest eDP-1: SKIP (0.000s)
[105.122560] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[105.182989] [009/133] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[105.277136] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[105.281542] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[105.366041] [010/133] (914s left) gem_ctx_shared (q-in-order)
[105.428039] Starting subtest: Q-in-order
[105.430499] Starting dynamic subtest: rcs0
[105.551027] Dynamic subtest rcs0: SUCCESS (0.122s)
[105.567100] Starting dynamic subtest: vcs0
[105.632844] Dynamic subtest vcs0: SUCCESS (0.081s)
[105.647973] Starting dynamic subtest: vcs1
[105.707321] Dynamic subtest vcs1: SUCCESS (0.074s)
[105.724037] Starting dynamic subtest: vecs0
[105.778465] Dynamic subtest vecs0: SUCCESS (0.071s)
[105.793899] Starting dynamic subtest: ccs0
[105.852310] Dynamic subtest ccs0: SUCCESS (0.073s)
[105.854978] Subtest Q-in-order: SUCCESS (0.424s)
[106.985062] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[106.988871] [011/133] (912s left) kms_feature_discovery (display-3x)
[107.085993] Starting subtest: display-3x
[107.090444] Subtest display-3x: SKIP (0.000s)
[107.170051] [012/133] (912s left) gem_ctx_persistence (heartbeat-hostile)
[107.222942] Starting subtest: heartbeat-hostile
[107.227573] Subtest heartbeat-hostile: SKIP (0.000s)
[107.340319] [013/133] (912s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[107.438461] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[107.440857] Starting dynamic subtest: pipe-A-eDP-1
[123.898460] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.461s)
[123.906861] Starting dynamic subtest: pipe-B-eDP-1
[141.104104] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.203s)
[141.106535] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.667s)
[141.983592] [014/133] (877s left) kms_psr (pr-sprite-plane-move)
[142.086623] Starting subtest: pr-sprite-plane-move
[142.091158] Subtest pr-sprite-plane-move: SKIP (0.000s)
[142.156921] [015/133] (877s left) gem_workarounds (suspend-resume)
[142.227819] Starting subtest: suspend-resume
[158.230834] Subtest suspend-resume: SUCCESS (2.007s)
[159.380299] [016/133] (861s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[159.492388] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[166.301409] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.738s)
[166.405952] [017/133] (854s left) gem_readwrite (read-write)
[166.464767] Subtest read-write: SKIP (0.000s)
[166.528059] [018/133] (854s left) kms_pm_rpm (fences)
[168.056669] Starting subtest: fences
[168.061767] Subtest fences: SKIP (0.000s)
[168.785754] [019/133] (851s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[168.839735] Starting subtest: invalid-single-wait-unsubmitted
[168.841703] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[168.934659] [020/133] (851s left) kms_prop_blob (blob-prop-validate)
[168.988427] Starting subtest: blob-prop-validate
[168.990685] Subtest blob-prop-validate: SUCCESS (0.000s)
[169.086325] [021/133] (851s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[169.177296] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[169.179440] Starting dynamic subtest: pipe-A-eDP-1
[169.198704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[169.207960] Starting dynamic subtest: pipe-B-eDP-1
[169.225898] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[169.233470] Starting dynamic subtest: pipe-C-eDP-1
[169.252261] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[169.259808] Starting dynamic subtest: pipe-D-eDP-1
[169.278741] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[169.280606] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[171.360128] [022/133] (849s left) kms_atomic_transition (plane-all-modeset-transition)
[171.457986] Starting subtest: plane-all-modeset-transition
[171.462373] Subtest plane-all-modeset-transition: SKIP (0.000s)
[171.544592] [023/133] (849s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[171.634702] Starting subtest: yf-tiled-64bpp-rotate-90
[171.639130] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[171.728935] [024/133] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[171.834105] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[171.838304] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[171.922795] [025/133] (849s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[172.021784] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[172.026196] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[172.093580] [026/133] (848s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[172.205294] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[172.209737] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[172.313197] [027/133] (848s left) syncobj_timeline (single-wait-available-signaled)
[172.363049] Starting subtest: single-wait-available-signaled
[172.365450] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[172.446799] [028/133] (848s left) sysfs_defaults (readonly)
[172.514980] Starting subtest: readonly
[172.517063] Starting dynamic subtest: vecs0
[172.519138] Dynamic subtest vecs0: SUCCESS (0.000s)
[172.528866] Starting dynamic subtest: ccs0
[172.530515] Dynamic subtest ccs0: SUCCESS (0.001s)
[172.538210] Starting dynamic subtest: vcs0
[172.539924] Dynamic subtest vcs0: SUCCESS (0.000s)
[172.547567] Starting dynamic subtest: bcs0
[172.549612] Dynamic subtest bcs0: SUCCESS (0.000s)
[172.559494] Starting dynamic subtest: rcs0
[172.561301] Dynamic subtest rcs0: SUCCESS (0.000s)
[172.568972] Starting dynamic subtest: vcs1
[172.570813] Dynamic subtest vcs1: SUCCESS (0.000s)
[172.572675] Subtest readonly: SUCCESS (0.006s)
[172.634331] [029/133] (848s left) kms_flip (nonblocking-read)
[172.725034] Starting subtest: nonblocking-read
[172.726670] Subtest nonblocking-read: SUCCESS (0.000s)
[172.815884] [030/133] (848s left) kms_vblank (wait-busy)
[172.905164] Starting subtest: wait-busy
[172.907380] Starting dynamic subtest: pipe-A-eDP-1
[174.792234] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[174.806414] Starting dynamic subtest: pipe-D-eDP-1
[177.337670] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s)
[177.340163] Subtest wait-busy: SUCCESS (4.421s)
[178.147471] [031/133] (843s left) kms_atomic_interruptible (legacy-setmode)
[178.233287] Starting subtest: legacy-setmode
[178.235660] Starting dynamic subtest: pipe-A-eDP-1
[185.104367] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.859s)
[185.106440] Subtest legacy-setmode: SUCCESS (6.860s)
[185.909185] [032/133] (835s left) kms_flip (flip-vs-rmfb)
[186.015942] Starting subtest: flip-vs-rmfb
[186.018192] Starting dynamic subtest: A-eDP1
[194.690316] Dynamic subtest A-eDP1: SUCCESS (8.676s)
[194.701092] Starting dynamic subtest: B-eDP1
[203.317446] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[203.330784] Starting dynamic subtest: C-eDP1
[211.939728] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[211.950057] Starting dynamic subtest: D-eDP1
[220.571561] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[220.575864] Subtest flip-vs-rmfb: SUCCESS (34.562s)
[221.747784] [033/133] (799s left) syncobj_timeline (host-signal-points)
[221.806832] Starting subtest: host-signal-points
[221.809083] Subtest host-signal-points: SUCCESS (0.004s)
[221.903123] [034/133] (799s left) prime_mmap_coherency (write)
[221.969144] Starting subtest: write
[227.348421] Subtest write: SUCCESS (5.376s)
[227.508337] [035/133] (793s left) kms_psr (psr2-primary-mmap-cpu)
[227.615770] Starting subtest: psr2-primary-mmap-cpu
[227.618101] Starting dynamic subtest: eDP-1
[229.346295] Dynamic subtest eDP-1: SUCCESS (1.730s)
[229.348595] Subtest psr2-primary-mmap-cpu: SUCCESS (1.731s)
[230.215212] [036/133] (791s left) syncobj_wait (wait-any-snapshot)
[230.282293] Starting subtest: wait-any-snapshot
[230.362263] Subtest wait-any-snapshot: SUCCESS (0.081s)
[230.440557] [037/133] (791s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[230.535875] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[230.538239] Starting dynamic subtest: pipe-A-eDP-1
[246.420883] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.407s)
[246.430363] Starting dynamic subtest: pipe-B-eDP-1
[263.395421] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.320s)
[263.404745] Starting dynamic subtest: pipe-C-eDP-1
[280.379022] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.371s)
[280.388407] Starting dynamic subtest: pipe-D-eDP-1
[297.422231] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.381s)
[297.424547] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.484s)
[298.645739] [038/133] (722s left) kms_addfb_basic (basic)
[298.705551] Starting subtest: basic
[298.708407] Subtest basic: SUCCESS (0.000s)
[298.857472] [039/133] (722s left) gem_busy (semaphore)
[299.046412] Subtest semaphore: SKIP (0.000s)
[299.269392] [040/133] (722s left) gem_mmap_gtt (big-copy-xy)
[299.338441] Subtest big-copy-XY: SKIP (0.000s)
[299.394434] [041/133] (722s left) gem_exec_balancer (parallel-contexts)
[299.669233] Starting subtest: parallel-contexts
[302.520121] Subtest parallel-contexts: SUCCESS (2.823s)
[303.243673] [042/133] (718s left) i915_query (test-query-geometry-subslices)
[303.311420] Starting subtest: test-query-geometry-subslices
[303.313943] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[303.399918] [043/133] (718s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[303.497563] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[303.500276] Starting dynamic subtest: pipe-A-eDP-1
[303.527313] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[303.538397] Starting dynamic subtest: pipe-B-eDP-1
[303.564106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[303.572869] Starting dynamic subtest: pipe-C-eDP-1
[303.598369] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[303.610674] Starting dynamic subtest: pipe-D-eDP-1
[303.637377] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[303.642678] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[305.691726] [044/133] (716s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[305.745029] Starting subtest: invalid-bsd1-flag-on-vebox
[305.747552] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[305.851848] [045/133] (715s left) i915_pm_freq_api (freq-suspend)
[305.914336] Starting subtest: freq-suspend
[305.917256] Starting dynamic subtest: gt0
[322.228884] Dynamic subtest gt0: SUCCESS (1.201s)
[322.238134] Starting dynamic subtest: gt1
[338.247901] Dynamic subtest gt1: SUCCESS (1.211s)
[338.250169] Subtest freq-suspend: SUCCESS (2.418s)
[338.362904] [046/133] (683s left) gem_ctx_isolation (clean)
[338.427231] Starting subtest: clean
[338.429990] Starting dynamic subtest: rcs0
[338.490156] Dynamic subtest rcs0: SUCCESS (0.062s)
[338.500296] Starting dynamic subtest: bcs0
[338.568848] Dynamic subtest bcs0: SUCCESS (0.077s)
[338.579806] Starting dynamic subtest: vcs0
[338.647232] Dynamic subtest vcs0: SUCCESS (0.077s)
[338.658439] Starting dynamic subtest: vcs1
[340.101725] Dynamic subtest vcs1: SUCCESS (1.447s)
[340.114892] Starting dynamic subtest: vecs0
[342.102516] Dynamic subtest vecs0: SUCCESS (1.992s)
[342.112813] Starting dynamic subtest: ccs0
[344.087763] Dynamic subtest ccs0: SUCCESS (1.978s)
[344.090302] Subtest clean: SUCCESS (5.640s)
[344.321654] [047/133] (677s left) kms_chamelium_edid (hdmi-mode-timings)
[344.719209] Subtest hdmi-mode-timings: SKIP (0.000s)
[345.515806] [048/133] (676s left) kms_getfb (getfb2-handle-not-fb)
[345.625835] Starting subtest: getfb2-handle-not-fb
[345.628227] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[345.746734] [049/133] (676s left) gem_exec_fence (submit-chain)
[345.923626] Starting subtest: submit-chain
[345.943115] Subtest submit-chain: SUCCESS (0.020s)
[348.198235] [050/133] (673s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[348.317896] Starting subtest: cursorB-vs-flipA-toggle
[348.322339] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[348.465106] [051/133] (673s left) perf_pmu (faulting-read)
[348.506436] Starting subtest: faulting-read
[348.508821] Starting dynamic subtest: wb
[348.511223] Dynamic subtest wb: SUCCESS (0.001s)
[348.522094] Starting dynamic subtest: wc
[348.524297] Dynamic subtest wc: SUCCESS (0.000s)
[348.533542] Starting dynamic subtest: uc
[348.535776] Dynamic subtest uc: SUCCESS (0.000s)
[348.538020] Subtest faulting-read: SUCCESS (0.003s)
[348.612892] [052/133] (673s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[348.708894] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[348.713284] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[348.797015] [053/133] (673s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[348.882723] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[348.887114] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[348.993264] [054/133] (673s left) kms_feature_discovery (psr2)
[349.095837] Starting subtest: psr2
[349.097754] Subtest psr2: SUCCESS (0.000s)
[349.178612] [055/133] (673s left) gem_exec_schedule (u-independent)
[349.246584] Starting subtest: u-independent
[349.248300] Starting dynamic subtest: rcs0
[351.115724] Dynamic subtest rcs0: SUCCESS (1.868s)
[351.131079] Starting dynamic subtest: vcs0
[353.128972] Dynamic subtest vcs0: SUCCESS (2.008s)
[353.141558] Starting dynamic subtest: vcs1
[355.103101] Dynamic subtest vcs1: SUCCESS (1.970s)
[355.116253] Starting dynamic subtest: vecs0
[357.140089] Dynamic subtest vecs0: SUCCESS (2.033s)
[357.153551] Starting dynamic subtest: ccs0
[359.114704] Dynamic subtest ccs0: SUCCESS (1.970s)
[359.117700] Subtest u-independent: SUCCESS (9.861s)
[359.430217] [056/133] (662s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[359.546829] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[359.550931] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[359.654914] [057/133] (662s left) kms_lease (multimaster-lease)
[359.759882] Starting subtest: multimaster-lease
[359.765046] Subtest multimaster-lease: SUCCESS (0.003s)
[359.868116] [058/133] (662s left) kms_plane_alpha_blend (alpha-basic)
[359.970191] Starting subtest: alpha-basic
[360.250416] Starting dynamic subtest: pipe-A-eDP-1
[362.178880] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[362.205707] Starting dynamic subtest: pipe-D-eDP-1
[364.806602] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.606s)
[364.808897] Subtest alpha-basic: SUCCESS (4.834s)
[365.613312] [059/133] (656s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[365.711150] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[365.715310] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[365.797864] [060/133] (656s left) prime_vgem (basic-fence-flip)
[365.870691] Starting subtest: basic-fence-flip
[366.162050] Subtest basic-fence-flip: SUCCESS (0.293s)
[366.259472] [061/133] (656s left) kms_setmode (basic)
[366.319160] Starting subtest: basic
[366.685703] Starting dynamic subtest: pipe-A-eDP-1
[370.224476] Dynamic subtest pipe-A-eDP-1: FAIL (3.408s)
[370.438631] Starting dynamic subtest: pipe-B-eDP-1
[373.986015] Dynamic subtest pipe-B-eDP-1: FAIL (3.391s)
[374.155937] Subtest basic: FAIL (7.797s)
[374.961111] [062/133] (647s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[375.059529] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[375.063646] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[375.161852] [063/133] (647s left) kms_plane (plane-position-covered)
[375.255727] Starting subtest: plane-position-covered
[375.760099] Starting dynamic subtest: pipe-A-plane-1
[377.054258] Dynamic subtest pipe-A-plane-1: SUCCESS (1.288s)
[377.064713] Starting dynamic subtest: pipe-A-plane-2
[378.363290] Dynamic subtest pipe-A-plane-2: SUCCESS (1.302s)
[378.372789] Starting dynamic subtest: pipe-A-plane-3
[379.602860] Dynamic subtest pipe-A-plane-3: SUCCESS (1.235s)
[379.614253] Starting dynamic subtest: pipe-A-plane-4
[380.834595] Dynamic subtest pipe-A-plane-4: SUCCESS (1.225s)
[380.845550] Starting dynamic subtest: pipe-A-plane-5
[380.858142] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[382.001731] Starting dynamic subtest: pipe-B-plane-1
[383.240853] Dynamic subtest pipe-B-plane-1: SUCCESS (1.250s)
[383.250734] Starting dynamic subtest: pipe-B-plane-2
[384.553329] Dynamic subtest pipe-B-plane-2: SUCCESS (1.309s)
[384.564437] Starting dynamic subtest: pipe-B-plane-3
[385.874010] Dynamic subtest pipe-B-plane-3: SUCCESS (1.315s)
[385.884759] Starting dynamic subtest: pipe-B-plane-4
[387.137626] Dynamic subtest pipe-B-plane-4: SUCCESS (1.263s)
[387.149193] Starting dynamic subtest: pipe-B-plane-5
[387.169167] Dynamic subtest pipe-B-plane-5: SUCCESS (0.029s)
[387.171537] Subtest plane-position-covered: SUCCESS (11.877s)
[388.004825] [064/133] (634s left) gem_workarounds (basic-read-context)
[388.081340] Starting subtest: basic-read-context
[388.099097] Subtest basic-read-context: SUCCESS (0.018s)
[388.248574] [065/133] (634s left) gem_softpin (allocator-basic)
[388.313573] Starting subtest: allocator-basic
[388.381899] Subtest allocator-basic: SUCCESS (0.068s)
[388.506596] [066/133] (634s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[388.565729] Starting subtest: yf-tiled-to-vebox-x-tiled
[388.569766] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[388.748588] [067/133] (634s left) gen7_exec_parse (bitmasks)
[388.807895] Subtest bitmasks: SKIP (0.000s)
[388.869134] [068/133] (634s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[388.966016] Starting subtest: x-tiled-8bpp-rotate-180
[390.172955] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.206s)
[390.309372] [069/133] (632s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[390.407688] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[390.411167] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[390.482814] [070/133] (632s left) kms_chamelium_hpd (hdmi-hpd-fast)
[390.855047] Subtest hdmi-hpd-fast: SKIP (0.000s)
[391.636862] [071/133] (631s left) perf (invalid-oa-format-id)
[391.757247] Starting subtest: invalid-oa-format-id
[391.770107] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[391.808376] [072/133] (631s left) gem_exec_flush (basic-wb-rw-before-default)
[391.885118] Starting subtest: basic-wb-rw-before-default
[397.368131] Subtest basic-wb-rw-before-default: SUCCESS (5.478s)
[397.561760] [073/133] (625s left) perf (gen12-group-exclusive-stream-sample-oa)
[397.662815] Starting subtest: gen12-group-exclusive-stream-sample-oa
[397.682872] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[397.732080] [074/133] (625s left) kms_force_connector_basic (force-load-detect)
[397.814886] Starting subtest: force-load-detect
[397.819526] Subtest force-load-detect: SKIP (0.000s)
[397.934439] [075/133] (625s left) kms_cursor_crc (cursor-offscreen-256x85)
[398.177627] Starting subtest: cursor-offscreen-256x85
[398.230640] Subtest cursor-offscreen-256x85: SKIP (0.050s)
[398.399551] [076/133] (624s left) core_getversion (basic)
[398.443800] Starting subtest: basic
[398.448491] Subtest basic: SUCCESS (0.000s)
[398.502411] [077/133] (624s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[398.589616] Starting subtest: psr-indfb-scaledprimary
[404.288310] Subtest psr-indfb-scaledprimary: SUCCESS (5.698s)
[404.414287] [078/133] (618s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[404.524917] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[404.529159] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[404.610911] [079/133] (618s left) kms_panel_fitting (legacy)
[404.687443] Starting subtest: legacy
[404.689703] Starting dynamic subtest: pipe-A-eDP-1
[405.239714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[405.267453] Starting dynamic subtest: pipe-B-eDP-1
[406.829898] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.571s)
[406.858616] Starting dynamic subtest: pipe-C-eDP-1
[408.406778] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s)
[408.436563] Starting dynamic subtest: pipe-D-eDP-1
[409.976599] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.550s)
[409.978913] Subtest legacy: SUCCESS (5.291s)
[411.218149] [080/133] (612s left) kms_atomic (crtc-invalid-params-fence)
[411.310853] Starting subtest: crtc-invalid-params-fence
[411.313179] Starting dynamic subtest: pipe-A-eDP-1
[411.733020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[411.735007] Subtest crtc-invalid-params-fence: SUCCESS (0.422s)
[412.557505] [081/133] (610s left) kms_color (ctm-red-to-blue)
[412.653351] Starting subtest: ctm-red-to-blue
[412.655574] Starting dynamic subtest: pipe-A-eDP-1
[413.362246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[413.377269] Starting dynamic subtest: pipe-B-eDP-1
[414.750458] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[414.760276] Starting dynamic subtest: pipe-C-eDP-1
[416.127732] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[416.137810] Starting dynamic subtest: pipe-D-eDP-1
[417.474081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[417.476403] Subtest ctm-red-to-blue: SUCCESS (4.821s)
[418.279633] [082/133] (605s left) kms_flip (dpms-vs-vblank-race-interruptible)
[418.374793] Starting subtest: dpms-vs-vblank-race-interruptible
[418.377069] Starting dynamic subtest: A-eDP1
[423.303869] Dynamic subtest A-eDP1: SUCCESS (4.927s)
[423.314913] Starting dynamic subtest: B-eDP1
[427.903280] Dynamic subtest B-eDP1: SUCCESS (4.595s)
[427.914199] Starting dynamic subtest: C-eDP1
[432.526295] Dynamic subtest C-eDP1: SUCCESS (4.621s)
[432.537300] Starting dynamic subtest: D-eDP1
[437.158665] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[437.163986] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.784s)
[438.024561] [083/133] (585s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[438.096223] Starting subtest: invalid-multi-wait-unsubmitted
[438.098751] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[438.210375] [084/133] (585s left) gem_exec_suspend (basic-s0)
[438.270487] Starting subtest: basic-S0
[438.272874] Starting dynamic subtest: smem
[459.192466] Dynamic subtest smem: SUCCESS (6.832s)
[459.195581] Subtest basic-S0: SUCCESS (6.834s)
[459.381835] [085/133] (564s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[459.485754] Starting subtest: fbc-psr2-cursor-plane-update-sf
[459.487980] Starting dynamic subtest: pipe-A-eDP-1
[459.559502] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[459.570087] Starting dynamic subtest: pipe-B-eDP-1
[460.704396] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[460.709155] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.206s)
[461.906750] [086/133] (561s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[462.002382] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[462.644240] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[462.796986] [087/133] (560s left) kms_prime (d3hot)
[462.880304] Subtest D3hot: SKIP (0.000s)
[462.989149] [088/133] (560s left) kms_cdclk (mode-transition)
[463.072999] Starting subtest: mode-transition
[463.075319] Starting dynamic subtest: pipe-A-eDP-1
[463.364811] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[463.375390] Starting dynamic subtest: pipe-B-eDP-1
[463.380150] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[463.389837] Starting dynamic subtest: pipe-C-eDP-1
[463.394563] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[463.404237] Starting dynamic subtest: pipe-D-eDP-1
[463.408878] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[463.413393] Subtest mode-transition: SKIP (0.294s)
[464.164843] [089/133] (559s left) gem_ppgtt (shrink-vs-evict-any)
[464.228970] Starting subtest: shrink-vs-evict-any
[471.113949] Subtest shrink-vs-evict-any: SUCCESS (6.849s)
[471.224400] [090/133] (552s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[471.321250] Starting subtest: y-tiled-8bpp-rotate-90
[471.325505] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[471.420961] [091/133] (552s left) gem_eio (in-flight-contexts-10ms)
[471.638892] Starting subtest: in-flight-contexts-10ms
[483.217243] Subtest in-flight-contexts-10ms: SUCCESS (11.558s)
[483.357098] [092/133] (540s left) gem_mmap_offset (basic-uaf)
[483.416274] Starting subtest: basic-uaf
[483.418555] Subtest basic-uaf: SUCCESS (0.001s)
[483.521619] [093/133] (540s left) kms_content_protection (lic-type-0-hdcp14)
[483.671713] Starting subtest: lic-type-0-hdcp14
[483.676207] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[483.802149] [094/133] (540s left) gem_exec_capture (userptr)
[483.858748] Starting subtest: userptr
[484.679032] Subtest userptr: SUCCESS (0.820s)
[484.798440] [095/133] (539s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[484.905812] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[492.162753] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.256s)
[492.324009] [096/133] (531s left) gem_mmap_wc (write-cpu-read-wc)
[492.388385] Subtest write-cpu-read-wc: SKIP (0.000s)
[492.443043] [097/133] (531s left) gem_pipe_control_store_loop (fresh-buffer)
[492.502444] Starting subtest: fresh-buffer
[494.654788] Subtest fresh-buffer: SUCCESS (2.151s)
[494.778091] [098/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[494.877333] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[502.212023] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.336s)
[502.340975] [099/133] (521s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[502.399985] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[502.507957] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[502.587301] [100/133] (521s left) core_auth (getclient-simple)
[502.626345] Starting subtest: getclient-simple
[502.640578] Subtest getclient-simple: SUCCESS (0.012s)
[502.732510] [101/133] (521s left) kms_psr (fbc-psr-sprite-plane-move)
[502.820348] Starting subtest: fbc-psr-sprite-plane-move
[502.822629] Starting dynamic subtest: eDP-1
[502.827044] Dynamic subtest eDP-1: SKIP (0.000s)
[502.831310] Subtest fbc-psr-sprite-plane-move: SKIP (0.002s)
[502.903766] [102/133] (521s left) gem_exec_whisper (basic-queues-priority)
[502.962924] Starting subtest: basic-queues-priority
[527.283466] Subtest basic-queues-priority: SUCCESS (24.312s)
[527.468645] [103/133] (496s left) gem_exec_reloc (basic-wc-noreloc)
[527.536716] Subtest basic-wc-noreloc: SKIP (0.000s)
[527.624668] [104/133] (496s left) i915_drm_fdinfo (virtual-busy-hang)
[527.671435] Starting subtest: virtual-busy-hang
[527.675837] Subtest virtual-busy-hang: SKIP (0.000s)
[527.741731] [105/133] (496s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[527.802152] Starting subtest: multi-wait-all-for-submit-signaled
[527.804349] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[527.910239] [106/133] (496s left) syncobj_wait (multi-wait-submitted)
[527.967835] Starting subtest: multi-wait-submitted
[528.075600] Subtest multi-wait-submitted: SUCCESS (0.107s)
[528.177430] [107/133] (496s left) syncobj_timeline (multi-wait-available-submitted)
[528.228403] Starting subtest: multi-wait-available-submitted
[528.230766] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[528.335681] [108/133] (496s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[528.607811] Starting subtest: cursor-rapid-movement-256x85
[528.653572] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[528.840640] [109/133] (495s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[528.929178] Starting subtest: pixel-format-y-tiled-ccs-modifier
[528.933294] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[529.001315] [110/133] (495s left) gem_userptr_blits (userfault)
[529.066831] Starting subtest: userfault
[529.069227] Subtest userfault: SUCCESS (0.008s)
[529.194461] [111/133] (495s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[529.286671] Starting subtest: basic-modeset-with-all-modifiers-formats
[529.670572] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[530.477320] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.807s)
[530.487556] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[530.499024] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[530.508672] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[530.521356] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[530.531165] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[530.677112] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[530.692962] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[530.699444] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[530.709164] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[530.721573] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[530.731249] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[530.743793] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[530.753406] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[530.765917] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[530.775342] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[530.788170] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[530.797607] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[530.810075] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[530.819873] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[530.832881] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[530.845473] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[530.854852] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[530.864541] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[531.021745] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[531.033327] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[531.043796] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[531.054327] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[531.066045] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[531.080312] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[531.088269] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[531.098805] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[531.110546] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[531.120481] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[531.132975] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[531.144542] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[531.154890] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[531.164311] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[531.177133] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[531.186745] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[531.199180] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[531.209028] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[531.378298] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.178s)
[531.388795] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[531.399578] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.020s)
[531.409754] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[531.422011] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[531.432131] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[531.444468] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[531.454660] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[531.466380] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[531.476322] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[531.488849] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[531.502727] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[531.510619] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.020s)
[531.519839] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[531.532855] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[531.542231] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[531.555185] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[531.936181] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.649s)
[532.749086] [112/133] (492s left) gem_lmem_swapping (parallel-random-verify)
[532.802208] Subtest parallel-random-verify: SKIP (0.000s)
[532.865262] [113/133] (492s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[532.952918] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[532.957149] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[533.055299] [114/133] (491s left) gem_exec_gttfill (all-engines)
[533.120813] Starting subtest: all-engines
[556.350225] Subtest all-engines: SUCCESS (23.220s)
[556.545202] [115/133] (468s left) prime_vgem (shrink)
[556.676699] Starting subtest: shrink
[556.703731] Subtest shrink: SUCCESS (0.027s)
[556.817099] [116/133] (468s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[556.917401] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[556.919874] Starting dynamic subtest: pipe-A-eDP-1
[556.942891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[556.954358] Starting dynamic subtest: pipe-B-eDP-1
[556.977443] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[556.990003] Starting dynamic subtest: pipe-C-eDP-1
[557.012827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[557.025768] Starting dynamic subtest: pipe-D-eDP-1
[557.049359] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[557.053670] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[559.132358] [117/133] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[559.236341] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[559.240420] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[559.361181] [118/133] (465s left) kms_invalid_mode (zero-clock)
[559.459507] Starting subtest: zero-clock
[559.461748] Starting dynamic subtest: pipe-A-eDP-1
[559.744672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[559.754849] Starting dynamic subtest: pipe-B-eDP-1
[559.756742] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[559.766747] Starting dynamic subtest: pipe-C-eDP-1
[559.768895] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[559.778260] Starting dynamic subtest: pipe-D-eDP-1
[559.780165] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[559.782002] Subtest zero-clock: SUCCESS (0.290s)
[560.555343] [119/133] (464s left) kms_cursor_crc (cursor-sliding-256x256)
[560.805302] Starting subtest: cursor-sliding-256x256
[560.810863] Starting dynamic subtest: pipe-A-eDP-1
[564.084926] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.274s)
[564.113841] Starting dynamic subtest: pipe-D-eDP-1
[567.927981] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.824s)
[567.930352] Subtest cursor-sliding-256x256: SUCCESS (7.123s)
[568.741433] [120/133] (456s left) gem_eio (wait-immediate)
[568.955555] Starting subtest: wait-immediate
[569.335920] Subtest wait-immediate: SUCCESS (0.380s)
[569.458655] [121/133] (455s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[569.561821] Starting subtest: fb-8bpc-vs-panel-6bpc
[569.564142] Starting dynamic subtest: pipe-A-eDP-1
[570.995403] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.434s)
[570.997787] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.435s)
[571.793680] [122/133] (453s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[571.903862] Starting subtest: multiplane-rotation-cropping-bottom
[589.441021] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.540s)
[589.557953] [123/133] (435s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[589.658638] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[589.660664] Starting dynamic subtest: pipe-A-eDP-1
[589.927428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.244s)
[589.939211] Starting dynamic subtest: pipe-B-eDP-1
[591.187921] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[591.199174] Starting dynamic subtest: pipe-C-eDP-1
[592.448649] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.263s)
[592.460459] Starting dynamic subtest: pipe-D-eDP-1
[593.680440] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[593.682822] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.991s)
[594.812855] [124/133] (430s left) kms_properties (connector-properties-atomic)
[594.914638] Starting subtest: connector-properties-atomic
[594.916980] Starting dynamic subtest: pipe-A-eDP-1
[602.802479] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.886s)
[602.816460] Starting dynamic subtest: pipe-None-DP-1
[602.820898] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[602.831611] Starting dynamic subtest: pipe-None-HDMI-A-1
[602.835766] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[602.845833] Starting dynamic subtest: pipe-None-DP-2
[602.849897] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[602.860409] Starting dynamic subtest: pipe-None-HDMI-A-2
[602.865061] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[602.875519] Starting dynamic subtest: pipe-None-DP-3
[602.880094] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[602.890414] Starting dynamic subtest: pipe-None-DP-4
[602.894885] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[602.897100] Subtest connector-properties-atomic: SUCCESS (7.898s)
[603.678519] [125/133] (421s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[603.793430] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[603.797674] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[603.904181] [126/133] (421s left) gem_mmap_gtt (basic-wc)
[603.962891] Subtest basic-wc: SKIP (0.000s)
[604.036462] [127/133] (421s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[604.099971] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[604.104673] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[604.303479] [128/133] (421s left) kms_big_fb (linear-32bpp-rotate-180)
[604.407604] Starting subtest: linear-32bpp-rotate-180
[605.819861] Subtest linear-32bpp-rotate-180: SUCCESS (1.411s)
[605.952898] [129/133] (419s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[606.043738] Starting subtest: 4-tiled-64bpp-rotate-180
[607.917502] Subtest 4-tiled-64bpp-rotate-180: FAIL (1.274s)
[607.958091] [130/133] (417s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[608.048015] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[608.049913] Starting dynamic subtest: pipe-A
[608.111462] Dynamic subtest pipe-A: SUCCESS (0.065s)
[608.121935] Starting dynamic subtest: pipe-B
[609.213077] Dynamic subtest pipe-B: SUCCESS (1.099s)
[609.226160] Starting dynamic subtest: pipe-C
[610.324023] Dynamic subtest pipe-C: SUCCESS (1.109s)
[610.334293] Starting dynamic subtest: pipe-D
[611.457740] Dynamic subtest pipe-D: SUCCESS (1.133s)
[611.459952] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.411s)
[612.623858] [131/133] (413s left) i915_pm_rpm (system-suspend-devices)
[614.253884] Starting subtest: system-suspend-devices
[621.989039] Subtest system-suspend-devices: SUCCESS (7.733s)
[622.375981] [132/133] (403s left) gem_exec_balancer (bonded-chain)
[622.443428] Starting subtest: bonded-chain
[629.444538] Subtest bonded-chain: SUCCESS (7.000s)
[629.783009] [133/133] (395s left) gem_exec_schedule (preempt)
[629.865710] Starting subtest: preempt
[629.867890] Starting dynamic subtest: rcs0
[629.893851] Dynamic subtest rcs0: SUCCESS (0.033s)
[629.907090] Starting dynamic subtest: bcs0
[629.922948] Dynamic subtest bcs0: SUCCESS (0.028s)
[629.937410] Starting dynamic subtest: vcs0
[629.947634] Dynamic subtest vcs0: SUCCESS (0.023s)
[629.958459] Starting dynamic subtest: vcs1
[629.972289] Dynamic subtest vcs1: SUCCESS (0.025s)
[629.985113] Starting dynamic subtest: vecs0
[629.997157] Dynamic subtest vecs0: SUCCESS (0.024s)
[630.008444] Starting dynamic subtest: ccs0
[630.030034] Dynamic subtest ccs0: SUCCESS (0.032s)
[630.032249] Subtest preempt: SUCCESS (0.170s)
[631.239293] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: api_intel_allocator
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_create
results: parsing output: 5/ for test: i915_query
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ctx_shared
results: parsing output: 10/ for test: kms_feature_discovery
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_workarounds
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_readwrite
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_prop_blob
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_atomic_transition
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: sysfs_defaults
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: kms_atomic_interruptible
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: prime_mmap_coherency
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: gem_busy
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: i915_query
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: i915_pm_freq_api
results: parsing output: 45/ for test: gem_ctx_isolation
results: parsing output: 46/ for test: kms_chamelium_edid
results: parsing output: 47/ for test: kms_getfb
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: kms_feature_discovery
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: kms_plane_alpha_blend
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: kms_setmode
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: gem_workarounds
results: parsing output: 64/ for test: gem_softpin
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_force_connector_basic
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: core_getversion
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_panel_fitting
results: parsing output: 79/ for test: kms_atomic
results: parsing output: 80/ for test: kms_color
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_exec_suspend
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_prime
results: parsing output: 87/ for test: kms_cdclk
results: parsing output: 88/ for test: gem_ppgtt
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: gem_mmap_offset
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: gem_exec_capture
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_mmap_wc
results: parsing output: 96/ for test: gem_pipe_control_store_loop
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: core_auth
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: i915_drm_fdinfo
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_gttfill
results: parsing output: 114/ for test: prime_vgem
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_invalid_mode
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: gem_eio
results: parsing output: 120/ for test: kms_dither
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_properties
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: gem_exec_schedule
Done.