[60.277748] Initializing watchdogs
[60.277798]   /dev/watchdog0
[60.291613] [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]
[60.296254] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.298375] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.301586] [001/133] (960s left) gem_userptr_blits (sync-unmap)
[60.398293] Starting subtest: sync-unmap
[60.418716] Subtest sync-unmap: SUCCESS (0.021s)
[60.552566] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[60.658253] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[60.662326] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[60.747240] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[60.836883] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[60.841163] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[60.923144] [004/133] (959s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[61.021852] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[62.034266] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.013s)
[62.153229] [005/133] (958s left) vgem_basic (busy-fence)
[62.233158] Starting subtest: busy-fence
[62.235115] Subtest busy-fence: SUCCESS (0.000s)
[62.286335] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[62.288905] [006/133] (958s left) kms_fence_pin_leak
[62.454600] [007/133] (958s left) gem_exec_reloc (basic-cpu-wc)
[62.515481] Subtest basic-cpu-wc: SKIP (0.000s)
[62.595050] [008/133] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[62.691463] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[70.551146] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.863s)
[70.659751] [009/133] (950s left) gem_exec_fence (syncobj-timeline-signal)
[71.185885] Starting subtest: syncobj-timeline-signal
[71.192228] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[73.002008] [010/133] (948s left) gem_exec_basic (basic)
[73.062707] Starting subtest: basic
[73.065138] Starting dynamic subtest: rcs0-smem
[73.067408] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[73.077902] Starting dynamic subtest: bcs0-smem
[73.080086] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[73.087275] Starting dynamic subtest: vcs0-smem
[73.089395] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[73.096513] Starting dynamic subtest: vcs1-smem
[73.098684] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[73.105845] Starting dynamic subtest: vecs0-smem
[73.108085] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[73.115116] Starting dynamic subtest: ccs0-smem
[73.117190] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[73.119279] Subtest basic: SUCCESS (0.013s)
[74.937546] [011/133] (946s left) kms_flip (dpms-vs-vblank-race-interruptible)
[75.037317] Starting subtest: dpms-vs-vblank-race-interruptible
[75.039699] Starting dynamic subtest: A-eDP1
[78.880531] Dynamic subtest A-eDP1: SUCCESS (3.842s)
[78.890257] Starting dynamic subtest: B-eDP1
[82.406209] Dynamic subtest B-eDP1: SUCCESS (3.523s)
[82.414732] Starting dynamic subtest: C-eDP1
[87.000457] Dynamic subtest C-eDP1: SUCCESS (4.595s)
[87.008669] Starting dynamic subtest: D-eDP1
[91.640829] Dynamic subtest D-eDP1: SUCCESS (4.638s)
[91.643172] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.607s)
[92.518242] [012/133] (928s left) gem_exec_schedule (pi-userfault)
[92.695791] Starting subtest: pi-userfault
[92.698502] Starting dynamic subtest: rcs0
[92.706163] Dynamic subtest rcs0: SUCCESS (0.012s)
[92.715564] Starting dynamic subtest: bcs0
[92.717481] Dynamic subtest bcs0: SUCCESS (0.007s)
[92.724506] Starting dynamic subtest: vcs0
[92.726840] Dynamic subtest vcs0: SUCCESS (0.011s)
[92.736013] Starting dynamic subtest: vcs1
[92.738055] Dynamic subtest vcs1: SUCCESS (0.007s)
[92.745352] Starting dynamic subtest: vecs0
[92.749813] Dynamic subtest vecs0: SUCCESS (0.015s)
[92.759158] Starting dynamic subtest: ccs0
[92.761106] Dynamic subtest ccs0: SUCCESS (0.008s)
[92.762954] Subtest pi-userfault: SUCCESS (0.064s)
[92.941121] [013/133] (928s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[93.038160] Starting subtest: yf-tiled-64bpp-rotate-180
[93.042641] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[93.120136] [014/133] (928s left) core_auth (many-magics)
[93.170061] Starting subtest: many-magics
[93.950623] Subtest many-magics: SUCCESS (0.783s)
[94.116659] [015/133] (927s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[94.218100] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[94.220307] Starting dynamic subtest: pipe-A-eDP-1
[94.362640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[94.374779] Starting dynamic subtest: pipe-B-eDP-1
[94.393691] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[94.401403] Starting dynamic subtest: pipe-C-eDP-1
[94.419448] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[94.428647] Starting dynamic subtest: pipe-D-eDP-1
[94.447043] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[94.448928] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.169s)
[96.673249] [016/133] (924s left) gem_mmap_wc (write-read)
[96.736331] Subtest write-read: SKIP (0.000s)
[96.803482] [017/133] (924s left) kms_cursor_crc (cursor-onscreen-512x512)
[97.075568] Starting subtest: cursor-onscreen-512x512
[97.080092] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[97.228671] [018/133] (924s left) kms_chamelium_frames (vga-frame-dump)
[97.621438] Subtest vga-frame-dump: SKIP (0.000s)
[98.395295] [019/133] (923s left) kms_plane_scaling (invalid-num-scalers)
[98.492105] Starting subtest: invalid-num-scalers
[98.494463] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[98.515325] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.023s)
[98.523630] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[98.546964] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[98.555022] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[98.575813] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[98.583654] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[98.607949] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[98.610188] Subtest invalid-num-scalers: SUCCESS (0.117s)
[98.713900] [020/133] (922s left) gem_exec_reloc (basic-write-wc-active)
[98.770614] Subtest basic-write-wc-active: SKIP (0.000s)
[98.833918] [021/133] (922s left) perf_pmu (init-busy)
[98.878859] Starting subtest: init-busy
[98.881361] Starting dynamic subtest: rcs0
[98.883788] Dynamic subtest rcs0: SUCCESS (0.001s)
[98.892368] Starting dynamic subtest: bcs0
[98.894570] Dynamic subtest bcs0: SUCCESS (0.000s)
[98.901720] Starting dynamic subtest: vcs0
[98.903987] Dynamic subtest vcs0: SUCCESS (0.001s)
[98.911099] Starting dynamic subtest: vcs1
[98.913309] Dynamic subtest vcs1: SUCCESS (0.001s)
[98.920130] Starting dynamic subtest: vecs0
[98.921974] Dynamic subtest vecs0: SUCCESS (0.001s)
[98.928945] Starting dynamic subtest: ccs0
[98.931328] Dynamic subtest ccs0: SUCCESS (0.001s)
[98.933471] Subtest init-busy: SUCCESS (0.008s)
[98.986940] [022/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[99.109654] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[99.113889] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[99.223411] [023/133] (922s left) gem_lmem_swapping (heavy-verify-random)
[99.263894] Subtest heavy-verify-random: SKIP (0.000s)
[99.306833] [024/133] (922s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[99.390095] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[99.393868] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[100.544416] [025/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[100.647748] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[100.652324] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[100.741236] [026/133] (921s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[100.791023] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[100.793316] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[100.880404] [027/133] (920s left) kms_content_protection (type1)
[101.002309] Starting subtest: type1
[101.006758] Subtest type1: SKIP (0.000s)
[101.134177] [028/133] (920s left) prime_vgem (fence-wait)
[101.198405] Starting subtest: fence-wait
[101.200672] Starting dynamic subtest: rcs0
[102.245400] Dynamic subtest rcs0: SUCCESS (1.046s)
[102.255377] Starting dynamic subtest: bcs0
[103.299969] Dynamic subtest bcs0: SUCCESS (1.054s)
[103.310197] Starting dynamic subtest: vcs0
[104.341654] Dynamic subtest vcs0: SUCCESS (1.041s)
[104.352234] Starting dynamic subtest: vcs1
[105.384912] Dynamic subtest vcs1: SUCCESS (1.042s)
[105.395530] Starting dynamic subtest: vecs0
[106.429127] Dynamic subtest vecs0: SUCCESS (1.043s)
[106.439565] Starting dynamic subtest: ccs0
[107.849056] Dynamic subtest ccs0: SUCCESS (1.418s)
[107.851771] Subtest fence-wait: SUCCESS (6.652s)
[107.989979] [029/133] (913s left) syncobj_timeline (invalid-signal-zero-handles)
[108.043582] Starting subtest: invalid-signal-zero-handles
[108.045851] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[108.138055] [030/133] (913s left) gem_mmap_wc (coherency)
[108.203691] Subtest coherency: SKIP (0.000s)
[108.266185] [031/133] (913s left) gem_mmap_gtt (basic-short)
[108.317253] Subtest basic-short: SKIP (0.000s)
[108.376787] [032/133] (913s left) perf (per-context-mode-unprivileged)
[108.502298] Starting subtest: per-context-mode-unprivileged
[108.506967] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[108.543011] [033/133] (913s left) kms_chamelium_audio (dp-audio-edid)
[108.935047] Subtest dp-audio-edid: SKIP (0.000s)
[109.751822] [034/133] (912s left) gen9_exec_parse (cmd-crossing-page)
[109.803351] Subtest cmd-crossing-page: SKIP (0.000s)
[109.873696] [035/133] (912s left) gem_spin_batch (user-each)
[109.946638] Starting subtest: user-each
[113.217317] Subtest user-each: SUCCESS (3.263s)
[113.955804] [036/133] (908s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[114.050993] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[114.053289] Starting dynamic subtest: pipe-A-default-mode
[116.830316] Dynamic subtest pipe-A-default-mode: SUCCESS (2.777s)
[116.832315] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.778s)
[117.671833] [037/133] (904s left) gem_userptr_blits (create-destroy-unsync)
[117.732428] Subtest create-destroy-unsync: SKIP (0.000s)
[117.847903] [038/133] (904s left) kms_cursor_crc (cursor-sliding-512x512)
[118.112907] Starting subtest: cursor-sliding-512x512
[118.116956] Subtest cursor-sliding-512x512: SKIP (0.001s)
[118.277436] [039/133] (904s left) gem_ctx_persistence (heartbeat-many)
[118.341109] Starting subtest: heartbeat-many
[118.345949] Subtest heartbeat-many: SKIP (0.000s)
[118.442265] [040/133] (903s left) gem_exec_whisper (basic-forked-all)
[118.504337] Starting subtest: basic-forked-all
[131.515290] Subtest basic-forked-all: SUCCESS (13.013s)
[131.707606] [041/133] (890s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[131.804620] Starting subtest: fbcpsr-tiling-4
[138.893443] Subtest fbcpsr-tiling-4: SUCCESS (7.093s)
[139.032406] [042/133] (883s left) kms_psr (fbc-psr2-sprite-plane-move)
[139.130210] Starting subtest: fbc-psr2-sprite-plane-move
[139.132083] Starting dynamic subtest: eDP-1
[139.136017] Dynamic subtest eDP-1: SKIP (0.000s)
[139.140023] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[139.211573] [043/133] (883s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[139.308996] Starting subtest: fb-8bpc-vs-panel-6bpc
[139.311246] Starting dynamic subtest: pipe-A-eDP-1
[140.701465] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.390s)
[140.703718] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.392s)
[141.564863] [044/133] (880s left) kms_vblank (query-idle-hang)
[141.649125] Starting subtest: query-idle-hang
[141.651480] Starting dynamic subtest: pipe-A-eDP-1
[168.654411] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.002s)
[168.666982] Starting dynamic subtest: pipe-D-eDP-1
[192.670909] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.016s)
[192.673490] Subtest query-idle-hang: SUCCESS (51.023s)
[193.518489] [045/133] (829s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[193.609667] Starting subtest: async-flip-with-page-flip-events-linear
[193.985344] Starting dynamic subtest: pipe-A-eDP-1
[196.852120] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.812s)
[197.175510] Starting dynamic subtest: pipe-B-eDP-1
[199.941775] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.772s)
[200.316865] Starting dynamic subtest: pipe-C-eDP-1
[203.119627] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.757s)
[203.428159] Starting dynamic subtest: pipe-D-eDP-1
[206.249688] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[206.252143] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.589s)
[207.400340] [046/133] (815s left) sw_sync (alloc_fence_invalid_timeline)
[207.440874] Starting subtest: alloc_fence_invalid_timeline
[207.443027] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[207.501283] [047/133] (815s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[207.583141] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[207.585353] Starting dynamic subtest: pipe-A-default-mode
[210.356224] Dynamic subtest pipe-A-default-mode: SUCCESS (2.771s)
[210.358468] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.774s)
[211.201171] [048/133] (811s left) kms_flip (2x-flip-vs-wf_vblank)
[211.297116] Starting subtest: 2x-flip-vs-wf_vblank
[211.305313] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[211.409096] [049/133] (811s left) kms_flip (2x-nonexisting-fb)
[211.509814] Starting subtest: 2x-nonexisting-fb
[211.518397] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[211.598738] [050/133] (811s left) gem_exec_schedule (promotion)
[211.679738] Starting subtest: promotion
[211.681917] Starting dynamic subtest: rcs0
[211.789819] Dynamic subtest rcs0: SUCCESS (0.111s)
[211.800270] Starting dynamic subtest: vcs0
[211.888523] Dynamic subtest vcs0: SUCCESS (0.098s)
[211.896364] Starting dynamic subtest: vcs1
[211.999946] Dynamic subtest vcs1: SUCCESS (0.111s)
[212.010835] Starting dynamic subtest: vecs0
[212.080774] Dynamic subtest vecs0: SUCCESS (0.080s)
[212.093082] Starting dynamic subtest: ccs0
[212.167568] Dynamic subtest ccs0: SUCCESS (0.086s)
[212.169828] Subtest promotion: SUCCESS (0.490s)
[213.027859] [051/133] (809s left) kms_cursor_crc (cursor-random-max-size)
[213.338560] Starting subtest: cursor-random-max-size
[213.345398] Subtest cursor-random-max-size: SKIP (0.000s)
[213.477436] [052/133] (809s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[213.582689] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[220.962166] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.380s)
[221.093569] [053/133] (801s left) kms_flip (flip-vs-blocking-wf-vblank)
[221.186198] Starting subtest: flip-vs-blocking-wf-vblank
[221.188492] Starting dynamic subtest: A-eDP1
[230.141477] Dynamic subtest A-eDP1: SUCCESS (8.954s)
[230.152091] Starting dynamic subtest: B-eDP1
[239.078652] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[239.089451] Starting dynamic subtest: C-eDP1
[248.053742] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[248.063934] Starting dynamic subtest: D-eDP1
[256.991632] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[256.993705] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.762s)
[258.171442] [054/133] (764s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[258.258948] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[258.261180] Starting dynamic subtest: pipe-A-eDP-1
[274.739221] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.484s)
[274.747700] Starting dynamic subtest: pipe-B-eDP-1
[291.960204] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.215s)
[291.962144] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.702s)
[292.756258] [055/133] (730s left) i915_drm_fdinfo (most-busy-check-all)
[292.795843] Starting subtest: most-busy-check-all
[292.797860] Starting dynamic subtest: rcs0
[292.802709] Dynamic subtest rcs0: SKIP (0.004s)
[292.814692] Starting dynamic subtest: bcs0
[292.819334] Dynamic subtest bcs0: SKIP (0.000s)
[292.829750] Starting dynamic subtest: vcs0
[292.833938] Dynamic subtest vcs0: SKIP (0.000s)
[292.841488] Starting dynamic subtest: vcs1
[292.845578] Dynamic subtest vcs1: SKIP (0.000s)
[292.853050] Starting dynamic subtest: vecs0
[292.857146] Dynamic subtest vecs0: SKIP (0.000s)
[292.866918] Starting dynamic subtest: ccs0
[292.871090] Dynamic subtest ccs0: SKIP (0.000s)
[292.875194] Subtest most-busy-check-all: SKIP (0.009s)
[292.911322] [056/133] (730s left) gem_pxp (verify-pxp-stale-buf-execution)
[293.071094] Starting subtest: verify-pxp-stale-buf-execution
[294.132594] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[294.271986] [057/133] (728s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[294.340822] Starting subtest: y-tiled-ccs-to-yf-tiled
[294.345571] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[294.536341] [058/133] (728s left) i915_pm_rpm (gem-idle)
[296.064766] Starting subtest: gem-idle
[302.279724] Subtest gem-idle: SUCCESS (6.204s)
[302.596913] [059/133] (720s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[303.866666] Starting subtest: y-tiled-ccs-to-y-tiled
[303.871637] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[304.062953] [060/133] (719s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[304.159199] Starting subtest: fbc-psr2-cursor-mmap-gtt
[304.161444] Starting dynamic subtest: eDP-1
[304.165678] Dynamic subtest eDP-1: SKIP (0.000s)
[304.169948] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[304.232453] [061/133] (718s left) kms_color_pipeline (plane-ctm3x4)
[304.324223] Starting subtest: plane-ctm3x4
[304.447908] Starting dynamic subtest: pipe-A-plane-0
[304.569939] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[304.578918] Starting dynamic subtest: pipe-A-plane-1
[304.682601] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[304.691182] Starting dynamic subtest: pipe-A-plane-2
[304.792292] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[305.987391] Starting dynamic subtest: pipe-B-plane-0
[306.103507] Dynamic subtest pipe-B-plane-0: SUCCESS (0.122s)
[306.112163] Starting dynamic subtest: pipe-B-plane-1
[306.214040] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[306.222568] Starting dynamic subtest: pipe-B-plane-2
[306.325161] Dynamic subtest pipe-B-plane-2: SUCCESS (0.110s)
[307.517881] Starting dynamic subtest: pipe-C-plane-0
[307.622333] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[307.634353] Starting dynamic subtest: pipe-C-plane-1
[307.733927] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[307.744678] Starting dynamic subtest: pipe-C-plane-2
[307.855599] Dynamic subtest pipe-C-plane-2: SUCCESS (0.121s)
[309.068033] Starting dynamic subtest: pipe-D-plane-0
[309.203696] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[309.212274] Starting dynamic subtest: pipe-D-plane-1
[309.315348] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[309.323488] Starting dynamic subtest: pipe-D-plane-2
[309.426289] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[309.712918] Subtest plane-ctm3x4: SUCCESS (5.389s)
[310.528431] [062/133] (712s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[310.631477] Starting subtest: x-tiled-8bpp-rotate-180
[311.800556] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.169s)
[311.921625] [063/133] (711s left) perf_pmu (invalid-init)
[311.960888] Starting subtest: invalid-init
[311.963264] Subtest invalid-init: SUCCESS (0.000s)
[312.058868] [064/133] (711s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[312.151324] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[312.154523] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[312.231398] [065/133] (711s left) gem_reg_read (bad-register)
[312.282454] Starting subtest: bad-register
[312.284085] Subtest bad-register: SUCCESS (0.000s)
[312.375421] [066/133] (711s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[312.465323] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[312.468744] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[312.559941] [067/133] (710s left) gem_ccs (suspend-resume)
[312.611673] Starting subtest: suspend-resume
[312.615534] Subtest suspend-resume: SKIP (0.000s)
[312.706761] [068/133] (710s left) perf (gen12-oa-tlb-invalidate)
[312.796629] Starting subtest: gen12-oa-tlb-invalidate
[312.798733] Starting dynamic subtest: 0-rcs0
[322.898204] Dynamic subtest 0-rcs0: SUCCESS (10.048s)
[322.908286] Starting dynamic subtest: 1-vecs0
[332.949152] Dynamic subtest 1-vecs0: SUCCESS (10.048s)
[332.951647] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.099s)
[332.989535] [069/133] (690s left) prime_vgem (fence-read-hang)
[333.071348] Subtest fence-read-hang: SKIP (0.000s)
[333.175971] [070/133] (690s left) syncobj_basic (bad-create-flags)
[333.226629] Starting subtest: bad-create-flags
[333.228890] Subtest bad-create-flags: SUCCESS (0.000s)
[333.323594] [071/133] (690s left) kms_setmode (basic)
[333.384025] Starting subtest: basic
[333.706098] Starting dynamic subtest: pipe-A-eDP-1
[335.841809] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.131s)
[336.177759] Starting dynamic subtest: pipe-B-eDP-1
[338.270559] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.095s)
[338.575527] Subtest basic: SUCCESS (5.190s)
[339.421629] [072/133] (684s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[339.489681] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[339.591763] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[339.679825] [073/133] (684s left) gem_vm_create (invalid-create)
[339.750462] Starting subtest: invalid-create
[339.752780] Subtest invalid-create: SUCCESS (0.003s)
[339.889162] [074/133] (683s left) kms_prop_blob (invalid-get-prop)
[339.956917] Starting subtest: invalid-get-prop
[339.958961] Subtest invalid-get-prop: SUCCESS (0.000s)
[340.063732] [075/133] (683s left) gem_exec_alignment (pi-isolated)
[340.121426] Starting subtest: pi-isolated
[391.375587] Subtest pi-isolated: SUCCESS (51.249s)
[392.490870] [076/133] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[392.644339] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[392.648581] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[392.733703] [077/133] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[392.836500] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[392.840490] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[392.920337] [078/133] (631s left) gem_ctx_exec (basic-norecovery)
[392.977034] Starting subtest: basic-norecovery
[393.300908] Subtest basic-norecovery: SUCCESS (0.324s)
[393.432740] [079/133] (630s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[393.533346] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[393.535351] Starting dynamic subtest: pipe-A-eDP-1
[393.554466] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.571087] Starting dynamic subtest: pipe-B-eDP-1
[393.589387] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.597277] Starting dynamic subtest: pipe-C-eDP-1
[393.615256] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.623501] Starting dynamic subtest: pipe-D-eDP-1
[393.642127] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.645543] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[395.782732] [080/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[395.880575] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[395.884928] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[395.970389] [081/133] (628s left) kms_getfb (getfb2-handle-not-fb)
[396.073202] Starting subtest: getfb2-handle-not-fb
[396.075048] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[396.174073] [082/133] (627s left) gem_mmap_offset (partial-remap)
[396.242313] Starting subtest: partial-remap
[396.244715] Starting dynamic subtest: smem0
[396.253714] Dynamic subtest smem0: SUCCESS (0.003s)
[396.255691] Subtest partial-remap: SUCCESS (0.004s)
[396.374616] [083/133] (627s left) kms_psr (pr-suspend)
[396.473264] Starting subtest: pr-suspend
[396.477286] Subtest pr-suspend: SKIP (0.000s)
[396.557420] [084/133] (627s left) kms_plane_alpha_blend (alpha-basic)
[396.658881] Starting subtest: alpha-basic
[396.950368] Starting dynamic subtest: pipe-A-eDP-1
[398.878181] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[398.905790] Starting dynamic subtest: pipe-D-eDP-1
[401.551537] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.656s)
[401.553955] Subtest alpha-basic: SUCCESS (4.897s)
[402.359158] [085/133] (621s left) gem_set_tiling_vs_gtt
[402.483045] [086/133] (621s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[402.584722] Starting subtest: yf-tiled-16bpp-rotate-90
[402.589198] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[402.674446] [087/133] (621s left) kms_psr (psr2-suspend)
[402.764209] Starting subtest: psr2-suspend
[402.766544] Starting dynamic subtest: eDP-1
[420.209265] Dynamic subtest eDP-1: SUCCESS (3.717s)
[420.211906] Subtest psr2-suspend: SUCCESS (3.718s)
[421.090050] [088/133] (603s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[421.198860] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[421.203126] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[421.293755] [089/133] (603s left) gem_ctx_create (basic)
[421.356501] Starting subtest: basic
[421.359374] Subtest basic: SUCCESS (0.000s)
[421.556562] [090/133] (602s left) kms_pm_dc (dc5-retention-flops)
[422.659715] Starting subtest: dc5-retention-flops
[422.665316] Subtest dc5-retention-flops: SKIP (0.000s)
[422.734184] [091/133] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[422.831523] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[422.836580] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[422.927202] [092/133] (601s left) kms_sequence (get-forked-busy)
[423.010990] Starting subtest: get-forked-busy
[423.013381] Starting dynamic subtest: pipe-A-eDP-1
[424.936515] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[424.946666] Starting dynamic subtest: pipe-B-eDP-1
[427.599715] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.661s)
[427.611711] Starting dynamic subtest: pipe-C-eDP-1
[430.203713] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.600s)
[430.215454] Starting dynamic subtest: pipe-D-eDP-1
[432.753867] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[432.756425] Subtest get-forked-busy: SUCCESS (9.740s)
[433.568538] [093/133] (591s left) dmabuf_sync_file (import-multiple-read-write)
[433.619231] Starting subtest: import-multiple-read-write
[433.624408] Subtest import-multiple-read-write: SUCCESS (0.006s)
[433.677719] [094/133] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[433.774723] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[433.778931] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[433.873317] [095/133] (590s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[433.978092] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[433.980471] Starting dynamic subtest: pipe-A-eDP-1
[434.001282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[434.012460] Starting dynamic subtest: pipe-B-eDP-1
[434.033393] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[434.042455] Starting dynamic subtest: pipe-C-eDP-1
[434.063407] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[434.072113] Starting dynamic subtest: pipe-D-eDP-1
[434.092463] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[434.094398] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.009s)
[436.144897] [096/133] (588s left) gem_exec_flush (basic-uc-prw-default)
[436.213821] Starting subtest: basic-uc-prw-default
[441.718673] Subtest basic-uc-prw-default: SUCCESS (5.476s)
[441.875469] [097/133] (582s left) gem_exec_reloc (basic-wc)
[441.937568] Subtest basic-wc: SKIP (0.000s)
[442.004985] [098/133] (582s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[442.105583] Starting subtest: y-tiled-64bpp-rotate-90
[442.110462] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[442.201462] [099/133] (582s left) i915_suspend (debugfs-reader)
[442.267715] Starting subtest: debugfs-reader
[460.761238] Subtest debugfs-reader: SUCCESS (3.137s)
[460.854383] [100/133] (564s left) gem_exec_params (invalid-bsd-ring)
[460.922078] Starting subtest: invalid-bsd-ring
[460.924037] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[461.018943] [101/133] (563s left) kms_plane_scaling (planes-upscale-factor-0-25)
[461.127177] Starting subtest: planes-upscale-factor-0-25
[461.129493] Starting dynamic subtest: pipe-A
[461.187330] Dynamic subtest pipe-A: SUCCESS (0.062s)
[461.197581] Starting dynamic subtest: pipe-B
[462.365336] Dynamic subtest pipe-B: SUCCESS (1.176s)
[462.377209] Starting dynamic subtest: pipe-C
[463.485671] Dynamic subtest pipe-C: SUCCESS (1.119s)
[463.496244] Starting dynamic subtest: pipe-D
[464.623374] Dynamic subtest pipe-D: SUCCESS (1.137s)
[464.625696] Subtest planes-upscale-factor-0-25: SUCCESS (3.498s)
[465.792923] [102/133] (559s left) i915_pm_freq_api (freq-reset)
[465.865361] Starting subtest: freq-reset
[465.867772] Starting dynamic subtest: gt0
[466.055647] Dynamic subtest gt0: SUCCESS (0.189s)
[466.067439] Starting dynamic subtest: gt1
[466.224233] Dynamic subtest gt1: SUCCESS (0.166s)
[466.227099] Subtest freq-reset: SUCCESS (0.358s)
[466.300565] [103/133] (558s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[466.412135] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[466.416075] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[466.479212] [104/133] (558s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[466.534836] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[466.641643] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[466.716586] [105/133] (558s left) syncobj_wait (wait-for-submit-snapshot)
[466.785493] Starting subtest: wait-for-submit-snapshot
[466.866386] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[466.943523] [106/133] (558s left) kms_pm_rpm (pm-tiling)
[469.098583] Starting subtest: pm-tiling
[469.103423] Subtest pm-tiling: SKIP (0.000s)
[469.492603] [107/133] (555s left) gem_mmap_gtt (cpuset-basic-small-copy)
[469.543109] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[469.600354] [108/133] (555s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[469.701042] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[473.348510] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.651s)
[474.489043] [109/133] (550s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[474.554617] Starting subtest: single-wait-all-for-submit-available-submitted
[474.556885] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[474.652279] [110/133] (550s left) kms_rotation_crc (primary-rotation-180)
[474.746679] Starting subtest: primary-rotation-180
[481.657056] Subtest primary-rotation-180: SUCCESS (6.910s)
[482.861251] [111/133] (542s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[482.959198] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[482.963623] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[483.077471] [112/133] (542s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[483.160210] Starting subtest: primary-4-tiled-reflect-x-0
[490.094067] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.933s)
[491.341910] [113/133] (534s left) kms_plane_lowres (tiling-x)
[491.440252] Starting subtest: tiling-x
[491.442487] Starting dynamic subtest: pipe-A-eDP-1
[491.447031] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[491.738522] Starting dynamic subtest: pipe-B-eDP-1
[491.743078] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[491.752560] Starting dynamic subtest: pipe-C-eDP-1
[491.757058] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[491.766594] Starting dynamic subtest: pipe-D-eDP-1
[491.770692] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[491.774700] Subtest tiling-x: SKIP (0.295s)
[492.550917] [114/133] (532s left) kms_lease (lease-revoke)
[492.646072] Starting subtest: lease-revoke
[492.648343] Starting dynamic subtest: pipe-A-eDP-1
[492.703756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.056s)
[492.715530] Starting dynamic subtest: pipe-B-eDP-1
[492.751905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.047s)
[492.766183] Starting dynamic subtest: pipe-C-eDP-1
[492.786985] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.032s)
[492.797307] Starting dynamic subtest: pipe-D-eDP-1
[492.819785] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[492.821751] Subtest lease-revoke: SUCCESS (0.174s)
[492.955047] [115/133] (532s left) kms_hdr (static-toggle-dpms)
[493.054047] Starting subtest: static-toggle-dpms
[493.060437] Subtest static-toggle-dpms: SKIP (0.000s)
[493.130601] [116/133] (532s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[493.227879] Starting subtest: primary-yf-tiled-reflect-x-270
[493.232117] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[493.310011] [117/133] (532s left) gem_ccs (block-copy-uncompressed)
[493.366106] Starting subtest: block-copy-uncompressed
[493.368393] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[493.388309] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[493.398237] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[493.405288] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[493.421898] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[493.424613] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[493.444884] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[493.447076] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[493.449119] Subtest block-copy-uncompressed: SUCCESS (0.074s)
[493.560237] [118/133] (532s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[493.648410] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[493.650324] Starting dynamic subtest: pipe-A-eDP-1
[493.668453] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[493.677959] Starting dynamic subtest: pipe-B-eDP-1
[493.694836] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[493.703811] Starting dynamic subtest: pipe-C-eDP-1
[493.720764] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[493.729890] Starting dynamic subtest: pipe-D-eDP-1
[493.746932] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[493.750296] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[495.827707] [119/133] (529s left) vgem_basic (setversion)
[495.887632] Starting subtest: setversion
[495.891653] Subtest setversion: SUCCESS (0.000s)
[495.945299] [120/133] (529s left) api_intel_bb (purge-bb)
[496.002844] Starting subtest: purge-bb
[496.007473] Subtest purge-bb: SUCCESS (0.005s)
[496.119162] [121/133] (529s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[496.243220] Starting subtest: cursorB-vs-flipA-toggle
[496.247802] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[496.405335] [122/133] (529s left) kms_draw_crc (draw-method-pwrite)
[496.510914] Starting subtest: draw-method-pwrite
[496.513055] Starting dynamic subtest: xrgb8888-untiled
[497.032362] Dynamic subtest xrgb8888-untiled: SUCCESS (0.522s)
[497.042285] Starting dynamic subtest: rgb565-untiled
[497.455494] Dynamic subtest rgb565-untiled: SUCCESS (0.421s)
[497.467650] Starting dynamic subtest: xrgb2101010-untiled
[497.999911] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[498.010599] Starting dynamic subtest: xbgr16161616f-untiled
[498.756044] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.753s)
[498.766636] Starting dynamic subtest: xrgb8888-xtiled
[500.468364] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.710s)
[500.480998] Starting dynamic subtest: rgb565-xtiled
[501.491289] Dynamic subtest rgb565-xtiled: SUCCESS (1.022s)
[501.500912] Starting dynamic subtest: xrgb2101010-xtiled
[503.192400] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.699s)
[503.202685] Starting dynamic subtest: xbgr16161616f-xtiled
[506.393964] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.199s)
[506.403835] Starting dynamic subtest: xrgb8888-4tiled
[507.494914] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[507.507447] Starting dynamic subtest: rgb565-4tiled
[508.016903] Dynamic subtest rgb565-4tiled: SUCCESS (0.522s)
[508.027373] Starting dynamic subtest: xrgb2101010-4tiled
[509.073588] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.055s)
[509.083184] Starting dynamic subtest: xbgr16161616f-4tiled
[511.941084] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.866s)
[511.943401] Subtest draw-method-pwrite: SUCCESS (15.423s)
[512.051224] [123/133] (513s left) kms_flip (dpms-off-confusion-interruptible)
[512.146609] Starting subtest: dpms-off-confusion-interruptible
[512.149106] Starting dynamic subtest: A-eDP1
[520.875579] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[520.887870] Starting dynamic subtest: B-eDP1
[529.520597] Dynamic subtest B-eDP1: SUCCESS (8.643s)
[529.532540] Starting dynamic subtest: C-eDP1
[538.148698] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[538.161565] Starting dynamic subtest: D-eDP1
[546.720874] Dynamic subtest D-eDP1: SUCCESS (8.617s)
[546.725700] Subtest dpms-off-confusion-interruptible: SUCCESS (34.578s)
[547.941164] [124/133] (478s left) kms_atomic (atomic-invalid-params)
[548.050771] Starting subtest: atomic-invalid-params
[548.053038] Starting dynamic subtest: pipe-A-eDP-1
[548.441145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[548.443076] Subtest atomic-invalid-params: SUCCESS (0.390s)
[549.336828] [125/133] (476s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[549.418130] Starting subtest: map-fixed-invalidate-overlap-busy
[549.422511] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[549.539317] [126/133] (476s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[549.635767] Starting subtest: plane-all-modeset-transition-fencing
[549.639987] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[549.708164] [127/133] (476s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[549.796546] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[549.800744] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[549.903061] [128/133] (476s left) gem_exec_balancer (bonded-false-hang)
[550.171179] Starting subtest: bonded-false-hang
[550.175949] Subtest bonded-false-hang: SKIP (0.000s)
[550.275048] [129/133] (476s left) kms_chamelium_edid (hdmi-edid-read)
[550.661447] Subtest hdmi-edid-read: SKIP (0.000s)
[551.440635] [130/133] (474s left) gem_tiled_partial_pwrite_pread (reads)
[551.495929] Subtest reads: SKIP (0.000s)
[551.570711] [131/133] (474s left) kms_big_fb (linear-32bpp-rotate-180)
[551.666240] Starting subtest: linear-32bpp-rotate-180
[553.290132] Subtest linear-32bpp-rotate-180: SUCCESS (1.623s)
[553.433770] [132/133] (472s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[554.004005] Starting subtest: syncobj-timeline-invalid-flags
[554.006142] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[555.087136] [133/133] (471s left) gem_ppgtt (shrink-vs-evict-pinned)
[555.156714] Starting subtest: shrink-vs-evict-pinned
[561.032803] Subtest shrink-vs-evict-pinned: SUCCESS (5.820s)
[561.076069] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: kms_fence_pin_leak
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: gem_exec_basic
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: core_auth
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_chamelium_frames
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_spin_batch
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_dither
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_reg_read
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ccs
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_setmode
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_vm_create
results: parsing output: 73/ for test: kms_prop_blob
results: parsing output: 74/ for test: gem_exec_alignment
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_exec
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_getfb
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_plane_alpha_blend
results: parsing output: 84/ for test: gem_set_tiling_vs_gtt
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_create
results: parsing output: 89/ for test: kms_pm_dc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_sequence
results: parsing output: 92/ for test: dmabuf_sync_file
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: i915_suspend
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: i915_pm_freq_api
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_plane_lowres
results: parsing output: 113/ for test: kms_lease
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: gem_ccs
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_atomic
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_atomic_transition
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_chamelium_edid
results: parsing output: 129/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: gem_ppgtt
Done.