[58.698454] Initializing watchdogs
[58.698503]   /dev/watchdog0
[58.713447] [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.718055] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.720116] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.722365] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[58.834786] Starting subtest: fbcpsr-2p-rte
[58.836746] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[58.976795] [002/132] (960s left) i915_pm_rps (basic-api)
[59.030410] Starting subtest: basic-api
[59.032478] Subtest basic-api: SKIP (0.001s)
[59.142103] [003/132] (960s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[59.234814] Starting subtest: fbc-farfromfence-mmap-gtt
[59.236669] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[59.354941] [004/132] (959s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[59.410990] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[59.413013] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[59.602364] [005/132] (959s left) gem_exec_schedule (timeslicing)
[59.658385] Starting subtest: timeslicing
[59.659373] Starting dynamic subtest: rcs0
[59.680872] Dynamic subtest rcs0: SUCCESS (0.023s)
[59.689226] Starting dynamic subtest: bcs0
[59.701465] Dynamic subtest bcs0: SUCCESS (0.020s)
[59.709073] Starting dynamic subtest: vcs0
[59.721507] Dynamic subtest vcs0: SUCCESS (0.020s)
[59.727055] Starting dynamic subtest: vcs1
[59.741199] Dynamic subtest vcs1: SUCCESS (0.020s)
[59.746707] Starting dynamic subtest: vecs0
[59.761840] Dynamic subtest vecs0: SUCCESS (0.020s)
[59.767156] Starting dynamic subtest: ccs0
[59.782193] Dynamic subtest ccs0: SUCCESS (0.020s)
[59.783400] Subtest timeslicing: SUCCESS (0.125s)
[60.937263] [006/132] (958s left) gem_tiled_partial_pwrite_pread (writes)
[60.989952] Subtest writes: SKIP (0.000s)
[61.055472] [007/132] (958s left) gem_close_race (basic-threads)
[61.120098] Starting subtest: basic-threads
[62.526226] Subtest basic-threads: SUCCESS (1.410s)
[62.711692] [008/132] (956s left) gem_exec_balancer (parallel-bb-first)
[62.975743] Starting subtest: parallel-bb-first
[63.905300] Subtest parallel-bb-first: SUCCESS (0.933s)
[64.961465] [009/132] (954s left) kms_pm_rpm (system-suspend-modeset)
[67.002075] Starting subtest: system-suspend-modeset
[86.811568] Subtest system-suspend-modeset: SUCCESS (5.112s)
[90.206959] [010/132] (932s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[90.266430] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[90.267538] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[90.401922] [011/132] (932s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[90.489848] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[90.490747] Starting dynamic subtest: pipe-A
[90.506982] Dynamic subtest pipe-A: SKIP (0.016s)
[90.516370] Starting dynamic subtest: pipe-B
[90.537679] Dynamic subtest pipe-B: SKIP (0.030s)
[90.544276] Starting dynamic subtest: pipe-C
[90.567618] Dynamic subtest pipe-C: SKIP (0.030s)
[90.573937] Starting dynamic subtest: pipe-D
[90.597248] Dynamic subtest pipe-D: SKIP (0.030s)
[90.599109] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.107s)
[90.725321] [012/132] (931s left) gem_ctx_isolation (dirty-switch)
[90.785553] Starting subtest: dirty-switch
[90.786633] Starting dynamic subtest: rcs0
[90.986943] Dynamic subtest rcs0: SUCCESS (0.203s)
[90.994004] Starting dynamic subtest: bcs0
[91.213046] Dynamic subtest bcs0: SUCCESS (0.227s)
[91.220958] Starting dynamic subtest: vcs0
[91.438304] Dynamic subtest vcs0: SUCCESS (0.228s)
[91.444845] Starting dynamic subtest: vcs1
[92.823330] Dynamic subtest vcs1: SUCCESS (1.397s)
[92.832145] Starting dynamic subtest: vecs0
[94.826140] Dynamic subtest vecs0: SUCCESS (2.017s)
[94.834978] Starting dynamic subtest: ccs0
[96.823504] Dynamic subtest ccs0: SUCCESS (2.009s)
[96.824641] Subtest dirty-switch: SUCCESS (6.084s)
[97.083439] [013/132] (925s left) gem_exec_balancer (bonded-sync)
[97.140209] Starting subtest: bonded-sync
[97.142039] Subtest bonded-sync: SKIP (0.000s)
[97.461163] [014/132] (925s left) perf (rc6-disable)
[97.571474] Starting subtest: rc6-disable
[97.763435] Subtest rc6-disable: SUCCESS (0.192s)
[97.804025] [015/132] (924s left) gem_exec_gttfill (engines)
[97.865972] Starting subtest: engines
[97.866896] Starting dynamic subtest: rcs0
[121.285811] Dynamic subtest rcs0: SUCCESS (23.456s)
[121.296376] Starting dynamic subtest: bcs0
[144.565132] Dynamic subtest bcs0: SUCCESS (23.278s)
[144.572171] Starting dynamic subtest: vcs0
[167.839982] Dynamic subtest vcs0: SUCCESS (23.285s)
[167.847287] Starting dynamic subtest: vcs1
[191.150156] Dynamic subtest vcs1: SUCCESS (23.313s)
[191.157529] Starting dynamic subtest: vecs0
[214.376015] Dynamic subtest vecs0: SUCCESS (23.223s)
[214.385496] Starting dynamic subtest: ccs0
[237.711279] Dynamic subtest ccs0: SUCCESS (23.340s)
[237.712540] Subtest engines: SUCCESS (139.901s)
[237.904637] [016/132] (784s left) gem_exec_reloc (basic-write-read-noreloc)
[237.996541] Subtest basic-write-read-noreloc: SKIP (0.000s)
[238.069763] [017/132] (784s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[238.128522] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[238.183656] [018/132] (784s left) perf_pmu (busy-check-all)
[238.217117] Starting subtest: busy-check-all
[238.218010] Starting dynamic subtest: rcs0
[238.794793] Dynamic subtest rcs0: SUCCESS (0.578s)
[238.805295] Starting dynamic subtest: bcs0
[239.347906] Dynamic subtest bcs0: SUCCESS (0.553s)
[239.358246] Starting dynamic subtest: vcs0
[240.647779] Dynamic subtest vcs0: SUCCESS (1.297s)
[240.656980] Starting dynamic subtest: vcs1
[242.631922] Dynamic subtest vcs1: SUCCESS (1.983s)
[242.641892] Starting dynamic subtest: vecs0
[244.615345] Dynamic subtest vecs0: SUCCESS (1.983s)
[244.624797] Starting dynamic subtest: ccs0
[245.166971] Dynamic subtest ccs0: SUCCESS (0.553s)
[245.168483] Subtest busy-check-all: SUCCESS (6.953s)
[245.302551] [019/132] (777s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[245.392812] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[245.393751] Starting dynamic subtest: pipe-A-default-mode
[245.686352] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[245.688202] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.292s)
[246.493406] [020/132] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[246.587619] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[246.589536] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[246.719879] [021/132] (776s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[246.816333] Starting subtest: fbcpsr-stridechange
[252.938349] Subtest fbcpsr-stridechange: SUCCESS (6.124s)
[253.092723] [022/132] (769s left) kms_invalid_mode (bad-htotal)
[253.176419] Starting subtest: bad-htotal
[253.177349] Starting dynamic subtest: pipe-A-eDP-1
[253.457305] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[253.467145] Starting dynamic subtest: pipe-B-eDP-1
[253.468282] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[253.475390] Starting dynamic subtest: pipe-C-eDP-1
[253.476322] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[253.483549] Starting dynamic subtest: pipe-D-eDP-1
[253.484454] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[253.485357] Subtest bad-htotal: SUCCESS (0.286s)
[254.329739] [023/132] (768s left) prime_mmap (test_dup)
[254.390369] Starting subtest: test_dup
[254.391462] Starting dynamic subtest: test_dup-smem
[254.421870] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[254.423602] Subtest test_dup: SUCCESS (0.032s)
[254.509248] [024/132] (768s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[259.517041] Starting subtest: psr2-overlay-plane-move-continuous-sf
[259.518136] Starting dynamic subtest: pipe-A-eDP-1
[266.203021] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.686s)
[266.211911] Starting dynamic subtest: pipe-B-eDP-1
[272.942795] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.740s)
[272.943896] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.429s)
[273.839691] [025/132] (749s left) gem_exec_fence (syncobj-timeline-export)
[274.428838] Starting subtest: syncobj-timeline-export
[274.435187] Subtest syncobj-timeline-export: SUCCESS (0.009s)
[275.682646] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[275.684490] [026/132] (747s left) kms_addfb_basic (bad-pitch-63)
[275.739277] Starting subtest: bad-pitch-63
[275.740383] Subtest bad-pitch-63: SUCCESS (0.000s)
[275.909376] [027/132] (747s left) api_intel_bb (object-reloc-keep-cache)
[275.964452] Starting subtest: object-reloc-keep-cache
[275.968665] Subtest object-reloc-keep-cache: SKIP (0.004s)
[276.107421] [028/132] (746s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[276.196662] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[276.197616] Starting dynamic subtest: pipe-A-default-mode
[278.981846] Dynamic subtest pipe-A-default-mode: SUCCESS (2.786s)
[278.982888] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.787s)
[279.818407] [029/132] (743s left) prime_vgem (basic-write)
[279.902397] Starting subtest: basic-write
[279.909162] Subtest basic-write: SKIP (0.006s)
[280.051818] [030/132] (743s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[280.145404] Starting subtest: flip-primary-invalidate-overlay
[291.749149] Subtest flip-primary-invalidate-overlay: SUCCESS (11.608s)
[291.884344] [031/132] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[291.974538] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[291.976091] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[292.086354] [032/132] (731s left) kms_pm_dc (dc6-psr)
[293.176188] Starting subtest: dc6-psr
[296.052445] Subtest dc6-psr: SUCCESS (2.876s)
[296.870917] [033/132] (726s left) i915_drm_fdinfo (memory-info-purgeable)
[296.905694] Starting subtest: memory-info-purgeable
[296.906657] Starting dynamic subtest: smem0
[299.802942] Dynamic subtest smem0: SUCCESS (2.898s)
[299.804274] Subtest memory-info-purgeable: SUCCESS (2.899s)
[299.899109] [034/132] (723s left) gem_exec_schedule (pi-common)
[300.075942] Starting subtest: pi-common
[300.077148] Starting dynamic subtest: rcs0
[300.112242] Dynamic subtest rcs0: SUCCESS (0.039s)
[300.125134] Starting dynamic subtest: bcs0
[300.153859] Dynamic subtest bcs0: SUCCESS (0.041s)
[300.161586] Starting dynamic subtest: vcs0
[300.187928] Dynamic subtest vcs0: SUCCESS (0.034s)
[300.195705] Starting dynamic subtest: vcs1
[300.222023] Dynamic subtest vcs1: SUCCESS (0.034s)
[300.229567] Starting dynamic subtest: vecs0
[300.253908] Dynamic subtest vecs0: SUCCESS (0.031s)
[300.261566] Starting dynamic subtest: ccs0
[300.283261] Dynamic subtest ccs0: SUCCESS (0.029s)
[300.284192] Subtest pi-common: SUCCESS (0.211s)
[300.519242] [035/132] (722s left) perf_pmu (render-node-busy-idle)
[300.593422] Starting subtest: render-node-busy-idle
[300.594632] Starting dynamic subtest: rcs0
[301.261900] Dynamic subtest rcs0: SUCCESS (0.668s)
[301.272822] Starting dynamic subtest: bcs0
[301.929532] Dynamic subtest bcs0: SUCCESS (0.667s)
[301.940011] Starting dynamic subtest: vcs0
[303.624035] Dynamic subtest vcs0: SUCCESS (1.691s)
[303.633405] Starting dynamic subtest: vcs1
[305.607844] Dynamic subtest vcs1: SUCCESS (1.982s)
[305.617159] Starting dynamic subtest: vecs0
[307.592012] Dynamic subtest vecs0: SUCCESS (1.982s)
[307.604505] Starting dynamic subtest: ccs0
[308.255008] Dynamic subtest ccs0: SUCCESS (0.661s)
[308.256905] Subtest render-node-busy-idle: SUCCESS (7.665s)
[308.334848] [036/132] (714s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[308.433105] Starting subtest: yf-tiled-16bpp-rotate-0
[308.435058] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[308.564282] [037/132] (714s left) gem_flink_basic (bad-flink)
[308.618229] Starting subtest: bad-flink
[308.619130] Subtest bad-flink: SUCCESS (0.000s)
[308.727817] [038/132] (714s left) kms_cursor_edge_walk (64x64-left-edge)
[308.822230] Starting subtest: 64x64-left-edge
[308.823351] Starting dynamic subtest: pipe-A-eDP-1
[312.298974] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[312.306595] Starting dynamic subtest: pipe-D-eDP-1
[315.435188] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[315.436307] Subtest 64x64-left-edge: SUCCESS (6.612s)
[316.252192] [039/132] (707s left) syncobj_timeline (invalid-wait-illegal-handle)
[316.296191] Starting subtest: invalid-wait-illegal-handle
[316.297147] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[316.398741] [040/132] (707s left) gen9_exec_parse (allowed-all)
[316.460119] Subtest allowed-all: SKIP (0.000s)
[316.518317] [041/132] (706s left) i915_pm_freq_api (freq-suspend)
[316.575300] Starting subtest: freq-suspend
[316.576519] Starting dynamic subtest: gt0
[333.284630] Dynamic subtest gt0: SUCCESS (1.648s)
[333.300484] Starting dynamic subtest: gt1
[350.234974] Dynamic subtest gt1: SUCCESS (1.563s)
[350.236194] Subtest freq-suspend: SUCCESS (3.213s)
[356.337431] [042/132] (673s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[356.393158] Subtest writes-after-reads-snoop: SKIP (0.000s)
[356.454212] [043/132] (673s left) kms_pm_backlight (bad-brightness)
[356.538796] Starting subtest: bad-brightness
[356.586559] Starting dynamic subtest: eDP-1
[356.908299] Dynamic subtest eDP-1: SUCCESS (0.325s)
[356.909121] Subtest bad-brightness: SUCCESS (0.375s)
[357.776822] [044/132] (671s left) gem_exec_await (wide-all)
[357.950571] Starting subtest: wide-all
[380.750830] Subtest wide-all: SUCCESS (22.882s)
[380.956055] [045/132] (648s left) gem_mmap_gtt (close-race)
[381.033792] Subtest close-race: SKIP (0.000s)
[381.098203] [046/132] (648s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[381.135158] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[381.175199] [047/132] (648s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[381.276942] Starting subtest: fbc-psr-cursor-mmap-cpu
[381.277872] Starting dynamic subtest: eDP-1
[381.284191] Dynamic subtest eDP-1: SKIP (0.000s)
[381.285983] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[381.357927] [048/132] (648s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[381.448986] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[403.706277] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.254s)
[403.873767] [049/132] (625s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[403.980099] Starting subtest: y-tiled-64bpp-rotate-270
[403.981867] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[404.116645] [050/132] (625s left) kms_properties (connector-properties-atomic)
[404.196181] Starting subtest: connector-properties-atomic
[404.197216] Starting dynamic subtest: pipe-A-eDP-1
[412.079880] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.881s)
[412.087981] Starting dynamic subtest: pipe-None-DP-1
[412.090135] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[412.098221] Starting dynamic subtest: pipe-None-HDMI-A-1
[412.100169] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[412.107959] Starting dynamic subtest: pipe-None-DP-2
[412.109649] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[412.117021] Starting dynamic subtest: pipe-None-HDMI-A-2
[412.118781] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[412.126068] Starting dynamic subtest: pipe-None-DP-3
[412.127843] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[412.135240] Starting dynamic subtest: pipe-None-DP-4
[412.137132] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[412.138076] Subtest connector-properties-atomic: SUCCESS (7.892s)
[412.956095] [051/132] (616s left) kms_content_protection (dp-mst-type-0)
[413.096639] Starting subtest: dp-mst-type-0
[413.099297] Subtest dp-mst-type-0: SKIP (0.000s)
[413.240606] [052/132] (616s left) kms_lease (simple-lease)
[413.339045] Starting subtest: simple-lease
[413.339860] Starting dynamic subtest: pipe-A-eDP-1
[413.846132] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.507s)
[413.855927] Starting dynamic subtest: pipe-B-eDP-1
[415.297673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[415.307730] Starting dynamic subtest: pipe-C-eDP-1
[416.694299] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[416.702993] Starting dynamic subtest: pipe-D-eDP-1
[418.096126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[418.097174] Subtest simple-lease: SUCCESS (4.758s)
[418.910427] [053/132] (610s left) gem_ctx_engines (execute-allforone)
[418.954739] Starting subtest: execute-allforone
[418.967531] Subtest execute-allforone: SUCCESS (0.013s)
[420.162384] [054/132] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[420.259406] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[420.261168] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[420.379488] [055/132] (609s left) kms_properties (invalid-properties-atomic)
[420.463125] Starting subtest: invalid-properties-atomic
[420.729186] Subtest invalid-properties-atomic: SUCCESS (0.264s)
[420.806552] [056/132] (609s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[420.923509] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[420.925119] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[421.086016] [057/132] (608s left) kms_atomic_interruptible (legacy-dpms)
[421.171166] Starting subtest: legacy-dpms
[421.172155] Starting dynamic subtest: pipe-A-eDP-1
[428.620715] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.449s)
[428.621737] Subtest legacy-dpms: SUCCESS (7.451s)
[429.456512] [058/132] (600s left) kms_atomic (plane-primary-legacy)
[429.538997] Starting subtest: plane-primary-legacy
[429.539950] Starting dynamic subtest: pipe-A-eDP-1
[429.996270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[429.997195] Subtest plane-primary-legacy: SUCCESS (0.458s)
[430.807184] [059/132] (599s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[431.208115] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[432.002669] [060/132] (598s left) api_intel_allocator (reloc-allocator)
[432.063867] Starting subtest: reloc-allocator
[432.064931] Starting dynamic subtest: basic
[432.065916] Dynamic subtest basic: SUCCESS (0.003s)
[432.076360] Starting dynamic subtest: parallel-one
[432.077403] Dynamic subtest parallel-one: SUCCESS (0.007s)
[432.085226] Starting dynamic subtest: print
[432.086138] Dynamic subtest print: SUCCESS (0.000s)
[432.093784] Starting dynamic subtest: reuse
[432.094696] Dynamic subtest reuse: SUCCESS (0.000s)
[432.106787] Starting dynamic subtest: fork-reopen-allocator
[432.107693] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[432.108611] Subtest reloc-allocator: SUCCESS (0.030s)
[432.253876] [061/132] (597s left) kms_atomic_interruptible (legacy-pageflip)
[432.337196] Starting subtest: legacy-pageflip
[432.338193] Starting dynamic subtest: pipe-A-eDP-1
[439.753950] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[439.754824] Subtest legacy-pageflip: SUCCESS (7.418s)
[440.606845] [062/132] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[440.693540] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[444.962872] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.272s)
[446.181254] [063/132] (584s left) kms_universal_plane (universal-plane-sanity)
[446.258002] Starting subtest: universal-plane-sanity
[446.259235] Starting dynamic subtest: pipe-A-eDP-1
[446.847787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[446.855953] Starting dynamic subtest: pipe-B-eDP-1
[448.089376] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.241s)
[448.098822] Starting dynamic subtest: pipe-C-eDP-1
[449.303765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[449.313982] Starting dynamic subtest: pipe-D-eDP-1
[450.541769] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[450.542703] Subtest universal-plane-sanity: SUCCESS (4.286s)
[451.417175] [064/132] (578s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[451.475006] Starting subtest: etime-single-wait-all-for-submit-submitted
[451.585500] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[451.668266] [065/132] (578s left) syncobj_timeline (signal-point-0)
[451.714774] Starting subtest: signal-point-0
[451.715839] Subtest signal-point-0: SUCCESS (0.000s)
[451.817580] [066/132] (578s left) gem_exec_reloc (basic-range-active)
[451.865600] Subtest basic-range-active: SKIP (0.000s)
[451.937592] [067/132] (578s left) perf (invalid-open-flags)
[452.049120] Starting subtest: invalid-open-flags
[452.050334] Subtest invalid-open-flags: SUCCESS (0.000s)
[452.081574] [068/132] (578s left) sysfs_heartbeat_interval (precise)
[452.139135] Starting subtest: precise
[452.140227] Starting dynamic subtest: vecs0
[460.110773] Dynamic subtest vecs0: SUCCESS (7.966s)
[460.121560] Starting dynamic subtest: ccs0
[461.363309] Dynamic subtest ccs0: SUCCESS (1.251s)
[461.374052] Starting dynamic subtest: vcs0
[469.051062] Dynamic subtest vcs0: SUCCESS (7.685s)
[469.071193] Starting dynamic subtest: bcs0
[470.292446] Dynamic subtest bcs0: SUCCESS (1.236s)
[470.301173] Starting dynamic subtest: rcs0
[473.106805] Dynamic subtest rcs0: SUCCESS (2.814s)
[473.117684] Starting dynamic subtest: vcs1
[481.100765] Dynamic subtest vcs1: SUCCESS (7.989s)
[481.102260] Subtest precise: SUCCESS (28.957s)
[481.184641] [069/132] (549s left) kms_big_fb (linear-64bpp-rotate-270)
[481.278811] Starting subtest: linear-64bpp-rotate-270
[481.299215] Subtest linear-64bpp-rotate-270: SKIP (0.020s)
[481.453914] [070/132] (549s left) gem_render_copy (yf-tiled-ccs-to-linear)
[481.500015] Starting subtest: yf-tiled-ccs-to-linear
[481.501697] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[481.704563] [071/132] (548s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[486.677278] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[486.678296] Starting dynamic subtest: pipe-A-eDP-1
[487.468070] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[487.477865] Starting dynamic subtest: pipe-B-eDP-1
[488.596065] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[488.598079] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.920s)
[489.802732] [072/132] (540s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[489.901070] Starting subtest: psr-farfromfence-mmap-gtt
[489.902756] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[490.021927] [073/132] (540s left) vgem_basic (busy-fence)
[490.064915] Starting subtest: busy-fence
[490.065849] Subtest busy-fence: SUCCESS (0.000s)
[490.130030] [074/132] (540s left) gem_exec_params (secure-non-root)
[490.192658] Starting subtest: secure-non-root
[490.194505] Subtest secure-non-root: SKIP (0.000s)
[490.310795] [075/132] (540s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[490.423501] Starting subtest: 2x-long-cursor-vs-flip-atomic
[490.426480] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[490.585808] [076/132] (540s left) gem_exec_reloc (basic-wc-cpu-active)
[490.644442] Subtest basic-wc-cpu-active: SKIP (0.000s)
[490.736349] [077/132] (539s left) kms_lease (atomic-implicit-crtc)
[490.826300] Starting subtest: atomic-implicit-crtc
[490.827300] Starting dynamic subtest: pipe-A-eDP-1
[490.832316] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[490.840624] Starting dynamic subtest: pipe-B-eDP-1
[490.845232] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[490.853487] Starting dynamic subtest: pipe-C-eDP-1
[490.857863] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[490.865879] Starting dynamic subtest: pipe-D-eDP-1
[490.870122] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[490.871011] Subtest atomic-implicit-crtc: SUCCESS (0.032s)
[490.997790] [078/132] (539s left) kms_psr (pr-basic)
[491.089084] Starting subtest: pr-basic
[491.090941] Subtest pr-basic: SKIP (0.000s)
[491.167257] [079/132] (539s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[491.254345] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[491.255322] Starting dynamic subtest: pipe-A-eDP-1
[491.263007] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[491.271471] Starting dynamic subtest: pipe-B-eDP-1
[491.279428] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[491.287616] Starting dynamic subtest: pipe-C-eDP-1
[491.295158] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[491.303099] Starting dynamic subtest: pipe-D-eDP-1
[491.310594] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[491.311492] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[493.491460] [080/132] (537s left) gem_caching (reads)
[493.545875] Subtest reads: SKIP (0.000s)
[493.618503] [081/132] (537s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[493.711547] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[493.713393] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[493.811022] [082/132] (537s left) dmabuf_sync_file (import-basic)
[493.844211] Starting subtest: import-basic
[493.845240] Subtest import-basic: SUCCESS (0.002s)
[493.909950] [083/132] (537s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[494.002213] Starting subtest: crc-primary-basic-y-tiled-ccs
[494.003231] Starting dynamic subtest: pipe-A-eDP-1
[494.013531] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[494.021435] Starting dynamic subtest: pipe-B-eDP-1
[494.030636] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[494.039701] Starting dynamic subtest: pipe-C-eDP-1
[494.047462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[494.055142] Starting dynamic subtest: pipe-D-eDP-1
[494.063555] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[494.065268] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[496.151086] [084/132] (534s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[496.524702] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[497.346386] [085/132] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[497.430748] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[497.432558] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[497.538278] [086/132] (533s left) gem_eio (in-flight-internal-10ms)
[497.745877] Starting subtest: in-flight-internal-10ms
[499.127818] Subtest in-flight-internal-10ms: SUCCESS (1.381s)
[499.279756] [087/132] (531s left) syncobj_wait (invalid-reset-illegal-handle)
[499.327847] Starting subtest: invalid-reset-illegal-handle
[499.328903] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[499.455081] [088/132] (531s left) kms_psr (fbc-pr-primary-page-flip)
[499.550605] Starting subtest: fbc-pr-primary-page-flip
[499.552478] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[499.640542] [089/132] (531s left) kms_feature_discovery (chamelium)
[499.732183] Starting subtest: chamelium
[499.734099] Subtest chamelium: SKIP (0.000s)
[499.813225] [090/132] (531s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[499.906560] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[500.962849] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.057s)
[501.103943] [091/132] (530s left) kms_flip (nonblocking-read)
[501.186187] Starting subtest: nonblocking-read
[501.187016] Subtest nonblocking-read: SUCCESS (0.000s)
[501.310922] [092/132] (529s left) gem_vm_create (invalid-destroy)
[501.369015] Starting subtest: invalid-destroy
[501.371854] Subtest invalid-destroy: SUCCESS (0.001s)
[501.489629] [093/132] (529s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[501.578876] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[501.590681] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[501.687338] [094/132] (529s left) kms_psr (psr-primary-mmap-cpu)
[501.767415] Starting subtest: psr-primary-mmap-cpu
[501.768452] Starting dynamic subtest: eDP-1
[503.470320] Dynamic subtest eDP-1: SUCCESS (1.702s)
[503.471465] Subtest psr-primary-mmap-cpu: SUCCESS (1.703s)
[504.344526] [095/132] (526s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[504.445201] Starting subtest: yf-tiled-64bpp-rotate-90
[504.446862] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[504.567427] [096/132] (526s left) kms_cursor_crc (cursor-offscreen-max-size)
[504.884999] Starting subtest: cursor-offscreen-max-size
[504.887531] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[505.042534] [097/132] (526s left) gem_mmap_gtt (hang-user)
[505.091295] Subtest hang-user: SKIP (0.000s)
[505.145890] [098/132] (526s left) i915_suspend (sysfs-reader)
[505.191187] Starting subtest: sysfs-reader
[523.281426] Subtest sysfs-reader: SUCCESS (3.515s)
[529.377776] [099/132] (508s left) gem_tiling_max_stride
[529.491584] [100/132] (508s left) syncobj_basic (bad-destroy-pad)
[529.540583] Starting subtest: bad-destroy-pad
[529.541859] Subtest bad-destroy-pad: SUCCESS (0.000s)
[529.661946] [101/132] (507s left) kms_vblank (wait-idle-hang)
[529.740440] Starting subtest: wait-idle-hang
[529.741334] Starting dynamic subtest: pipe-A-eDP-1
[556.448529] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.782s)
[556.458826] Starting dynamic subtest: pipe-D-eDP-1
[571.430098] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s)
[571.431269] Subtest wait-idle-hang: SUCCESS (41.765s)
[572.244512] [102/132] (465s left) kms_psr (psr2-primary-blt)
[572.336810] Starting subtest: psr2-primary-blt
[572.337776] Starting dynamic subtest: eDP-1
[574.056641] Dynamic subtest eDP-1: SUCCESS (1.719s)
[574.057598] Subtest psr2-primary-blt: SUCCESS (1.720s)
[574.931250] [103/132] (462s left) kms_plane_cursor (primary)
[575.025636] Starting subtest: primary
[575.027386] Starting dynamic subtest: pipe-A-eDP-1-size-64
[577.755704] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.729s)
[577.783215] Starting dynamic subtest: pipe-A-eDP-1-size-128
[580.479879] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.706s)
[580.504316] Starting dynamic subtest: pipe-A-eDP-1-size-256
[583.145678] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.649s)
[583.459351] Starting dynamic subtest: pipe-B-eDP-1-size-64
[586.877637] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.426s)
[586.904411] Starting dynamic subtest: pipe-B-eDP-1-size-128
[589.578131] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.682s)
[589.609489] Starting dynamic subtest: pipe-B-eDP-1-size-256
[592.290020] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.694s)
[592.612456] Starting dynamic subtest: pipe-C-eDP-1-size-64
[595.549607] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.947s)
[595.578144] Starting dynamic subtest: pipe-C-eDP-1-size-128
[597.927008] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.358s)
[597.954429] Starting dynamic subtest: pipe-C-eDP-1-size-256
[600.204018] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.258s)
[600.518133] Starting dynamic subtest: pipe-D-eDP-1-size-64
[603.515243] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.006s)
[603.543611] Starting dynamic subtest: pipe-D-eDP-1-size-128
[605.759768] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.224s)
[605.788121] Starting dynamic subtest: pipe-D-eDP-1-size-256
[608.014281] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s)
[608.320819] Subtest primary: SUCCESS (33.300s)
[609.165747] [104/132] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[609.252832] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[609.254570] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[609.375687] [105/132] (428s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[609.478824] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[610.600625] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.123s)
[610.758937] [106/132] (426s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[610.851099] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[614.962380] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.113s)
[616.161161] [107/132] (421s left) gem_exec_flush (basic-wb-rw-before-default)
[616.226091] Starting subtest: basic-wb-rw-before-default
[621.682411] Subtest basic-wb-rw-before-default: SUCCESS (5.458s)
[621.876326] [108/132] (415s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[621.926155] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[621.927796] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[622.036730] [109/132] (415s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[622.121574] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[622.122483] Starting dynamic subtest: pipe-A-eDP-1
[622.132237] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[622.141025] Starting dynamic subtest: pipe-B-eDP-1
[622.150637] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[622.158968] Starting dynamic subtest: pipe-C-eDP-1
[622.168171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[622.176307] Starting dynamic subtest: pipe-D-eDP-1
[622.185929] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[622.187573] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[624.408899] [110/132] (413s left) gem_exec_whisper (basic-forked-all)
[624.477321] Starting subtest: basic-forked-all
[637.608340] Subtest basic-forked-all: SUCCESS (13.127s)
[637.801421] [111/132] (400s left) fbdev (unaligned-read)
[637.842089] Starting subtest: unaligned-read
[637.857284] Subtest unaligned-read: SUCCESS (0.015s)
[637.942041] [112/132] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[638.031745] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[641.613108] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.582s)
[642.810709] [113/132] (395s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[642.905652] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[649.908881] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.005s)
[650.044214] [114/132] (388s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[650.139040] Starting subtest: fbcpsr-rgb565-draw-render
[657.069906] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.932s)
[657.216680] [115/132] (380s left) gem_exec_params (rel-constants-invalid)
[657.279574] Starting subtest: rel-constants-invalid
[657.280694] Subtest rel-constants-invalid: SUCCESS (0.000s)
[657.405734] [116/132] (380s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[657.647441] Starting subtest: cursor-rapid-movement-256x85
[657.686478] Subtest cursor-rapid-movement-256x85: SKIP (0.038s)
[657.894919] [117/132] (380s left) kms_flip (plain-flip-fb-recreate)
[657.986062] Starting subtest: plain-flip-fb-recreate
[657.988774] Starting dynamic subtest: A-eDP1
[666.850873] Dynamic subtest A-eDP1: SUCCESS (8.864s)
[666.867977] Starting dynamic subtest: B-eDP1
[675.683643] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[675.694280] Starting dynamic subtest: C-eDP1
[684.506411] Dynamic subtest C-eDP1: SUCCESS (8.823s)
[684.516660] Starting dynamic subtest: D-eDP1
[693.331723] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[693.335302] Subtest plain-flip-fb-recreate: SUCCESS (35.358s)
[694.603818] [118/132] (343s left) gem_pxp (create-regular-context-2)
[694.710893] Starting subtest: create-regular-context-2
[694.712006] Subtest create-regular-context-2: SUCCESS (0.002s)
[694.845890] [119/132] (343s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[694.938192] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[694.939201] Starting dynamic subtest: pipe-A-eDP-1
[695.353035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[695.362002] Starting dynamic subtest: pipe-B-eDP-1
[696.795538] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[696.804203] Starting dynamic subtest: pipe-C-eDP-1
[698.173533] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[698.182866] Starting dynamic subtest: pipe-D-eDP-1
[699.500613] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[699.501534] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.554s)
[700.722637] [120/132] (337s left) gem_pipe_control_store_loop (fresh-buffer)
[700.789783] Starting subtest: fresh-buffer
[702.943964] Subtest fresh-buffer: SUCCESS (2.153s)
[703.097449] [121/132] (335s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[703.197908] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[703.199601] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[703.328897] [122/132] (334s left) gem_softpin (safe-alignment)
[703.391888] Starting subtest: safe-alignment
[703.414096] Subtest safe-alignment: SUCCESS (0.022s)
[704.657376] [123/132] (333s left) gem_ctx_persistence (heartbeat-hang)
[704.717636] Starting subtest: heartbeat-hang
[704.719514] Subtest heartbeat-hang: SKIP (0.000s)
[704.848430] [124/132] (333s left) kms_sharpness_filter (invalid-filter-with-plane)
[704.933642] Starting subtest: invalid-filter-with-plane
[704.938797] Subtest invalid-filter-with-plane: SKIP (0.001s)
[705.026727] [125/132] (333s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[705.117747] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[705.118647] Starting dynamic subtest: pipe-A-eDP-1
[705.126759] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[705.137459] Starting dynamic subtest: pipe-B-eDP-1
[705.145898] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[705.154263] Starting dynamic subtest: pipe-C-eDP-1
[705.162434] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[705.170681] Starting dynamic subtest: pipe-D-eDP-1
[705.179330] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[705.181069] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[707.299800] [126/132] (331s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[707.419966] Starting subtest: basic-busy-flip-before-cursor-varying-size
[707.421806] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[707.575892] [127/132] (330s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[707.666579] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[707.667397] Starting dynamic subtest: pipe-A-eDP-1
[709.824029] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.158s)
[709.834294] Starting dynamic subtest: pipe-B-eDP-1
[711.953798] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.129s)
[711.963603] Starting dynamic subtest: pipe-C-eDP-1
[714.063920] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.109s)
[714.073965] Starting dynamic subtest: pipe-D-eDP-1
[716.079643] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.015s)
[716.080528] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.417s)
[717.329281] [128/132] (321s left) kms_async_flips (alternate-sync-async-flip-atomic)
[717.421159] Starting subtest: alternate-sync-async-flip-atomic
[717.801434] Starting dynamic subtest: pipe-A-eDP-1
[720.621618] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.821s)
[720.994375] Starting dynamic subtest: pipe-B-eDP-1
[723.753586] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[724.118034] Starting dynamic subtest: pipe-C-eDP-1
[726.873628] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[727.237490] Starting dynamic subtest: pipe-D-eDP-1
[730.003452] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[730.004545] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.589s)
[731.177247] [129/132] (307s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[731.267972] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[731.269780] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[731.361719] [130/132] (307s left) gem_ctx_shared (exec-single-timeline)
[731.416072] Starting subtest: exec-single-timeline
[731.417139] Starting dynamic subtest: rcs0
[732.482411] Dynamic subtest rcs0: SUCCESS (1.063s)
[732.494431] Starting dynamic subtest: bcs0
[733.570347] Dynamic subtest bcs0: SUCCESS (1.085s)
[733.582172] Starting dynamic subtest: vcs0
[734.657127] Dynamic subtest vcs0: SUCCESS (1.085s)
[734.670834] Starting dynamic subtest: vcs1
[735.747307] Dynamic subtest vcs1: SUCCESS (1.085s)
[735.758958] Starting dynamic subtest: vecs0
[736.835381] Dynamic subtest vecs0: SUCCESS (1.085s)
[736.845677] Starting dynamic subtest: ccs0
[737.923122] Dynamic subtest ccs0: SUCCESS (1.085s)
[737.924931] Subtest exec-single-timeline: SUCCESS (6.509s)
[738.661741] [131/132] (299s left) syncobj_timeline (device-signal-unordered)
[738.710250] Starting subtest: device-signal-unordered
[738.711296] Subtest device-signal-unordered: SUCCESS (0.000s)
[738.845374] [132/132] (299s left) gem_ppgtt (blt-vs-render-ctxn)
[738.894404] Starting subtest: blt-vs-render-ctxN
[771.903772] Subtest blt-vs-render-ctxN: SUCCESS (33.004s)
[772.063350] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_pm_rps
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 6/ for test: gem_close_race
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_ctx_isolation
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: gem_exec_gttfill
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_pipe_b_c_ivb
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_invalid_mode
results: parsing output: 22/ for test: prime_mmap
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: prime_vgem
results: parsing output: 29/ for test: kms_psr_stress_test
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_pm_dc
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_flink_basic
results: parsing output: 37/ for test: kms_cursor_edge_walk
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: i915_pm_freq_api
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: kms_pm_backlight
results: parsing output: 43/ for test: gem_exec_await
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_properties
results: parsing output: 50/ for test: kms_content_protection
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_ctx_engines
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_properties
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_atomic_interruptible
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: kms_atomic_interruptible
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_universal_plane
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: sysfs_heartbeat_interval
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: vgem_basic
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_caching
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: dmabuf_sync_file
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_chamelium_edid
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_feature_discovery
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_vm_create
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: i915_suspend
results: parsing output: 98/ for test: gem_tiling_max_stride
results: parsing output: 99/ for test: syncobj_basic
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane_cursor
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_flush
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_pipe_control_store_loop
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: kms_sharpness_filter
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_async_flips
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_ctx_shared
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: gem_ppgtt
Done.