[58.910894] Initializing watchdogs
[58.910965]   /dev/watchdog0
[58.924055] [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.928101] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.930172] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.933439] [001/130] (960s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[59.049737] Starting subtest: invalid-signal-one-illegal-handle
[59.052114] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[59.120179] [002/130] (960s left) gem_caching (writes)
[59.191741] Subtest writes: SKIP (0.000s)
[59.255564] [003/130] (960s left) kms_dp_linktrain_fallback (dsc-fallback)
[59.351094] Starting subtest: dsc-fallback
[59.357618] Subtest dsc-fallback: SKIP (0.000s)
[59.415759] [004/130] (960s left) gem_exec_schedule (preempt-hang)
[59.598500] Starting subtest: preempt-hang
[59.600716] Starting dynamic subtest: rcs0
[59.814054] Dynamic subtest rcs0: SUCCESS (0.217s)
[59.823431] Starting dynamic subtest: bcs0
[60.020043] Dynamic subtest bcs0: SUCCESS (0.206s)
[60.029368] Starting dynamic subtest: vcs0
[60.220230] Dynamic subtest vcs0: SUCCESS (0.200s)
[60.226473] Starting dynamic subtest: vcs1
[60.429614] Dynamic subtest vcs1: SUCCESS (0.208s)
[60.437323] Starting dynamic subtest: vecs0
[60.640754] Dynamic subtest vecs0: SUCCESS (0.211s)
[60.646898] Starting dynamic subtest: ccs0
[60.857757] Dynamic subtest ccs0: SUCCESS (0.218s)
[60.859991] Subtest preempt-hang: SUCCESS (1.260s)
[62.018322] [005/130] (957s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[62.119045] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[62.121435] Starting dynamic subtest: pipe-A-eDP-1
[62.130757] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.138831] Starting dynamic subtest: pipe-B-eDP-1
[62.147697] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.153558] Starting dynamic subtest: pipe-C-eDP-1
[62.161933] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.167552] Starting dynamic subtest: pipe-D-eDP-1
[62.175986] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.180069] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.002s)
[64.328484] [006/130] (955s left) gem_exec_params (dr1-dirt)
[64.393176] Starting subtest: DR1-dirt
[64.395583] Subtest DR1-dirt: SUCCESS (0.000s)
[64.489188] [007/130] (955s left) syncobj_eventfd (invalid-illegal-eventfd)
[64.558326] Starting subtest: invalid-illegal-eventfd
[64.560692] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[64.661543] [008/130] (955s left) syncobj_timeline (device-submit-unordered)
[64.719144] Starting subtest: device-submit-unordered
[64.721477] Subtest device-submit-unordered: SUCCESS (0.000s)
[64.793747] [009/130] (954s left) kms_psr (psr2-cursor-mmap-gtt)
[64.896677] Starting subtest: psr2-cursor-mmap-gtt
[64.898869] Starting dynamic subtest: eDP-1
[66.575422] Dynamic subtest eDP-1: SUCCESS (1.679s)
[66.577597] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.679s)
[67.345435] [010/130] (952s left) gem_mmap_gtt (pf-nonblock)
[67.403892] Subtest pf-nonblock: SKIP (0.000s)
[67.458271] [011/130] (952s left) kms_big_fb (linear-addfb)
[67.562081] Starting subtest: linear-addfb
[67.564031] Subtest linear-addfb: SUCCESS (0.000s)
[67.669462] [012/130] (952s left) kms_psr (psr2-sprite-plane-onoff)
[67.767194] Starting subtest: psr2-sprite-plane-onoff
[67.769587] Starting dynamic subtest: eDP-1
[69.443562] Dynamic subtest eDP-1: SUCCESS (1.674s)
[69.445512] Subtest psr2-sprite-plane-onoff: SUCCESS (1.675s)
[70.289838] [013/130] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[70.384356] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[70.388870] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[70.496711] [014/130] (949s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[70.593377] Starting subtest: flip-vs-dpms-off-vs-modeset
[70.595838] Starting dynamic subtest: A-eDP1
[74.203149] Dynamic subtest A-eDP1: SUCCESS (3.608s)
[74.210717] Starting dynamic subtest: B-eDP1
[77.275185] Dynamic subtest B-eDP1: SUCCESS (3.073s)
[77.282086] Starting dynamic subtest: C-eDP1
[80.332436] Dynamic subtest C-eDP1: SUCCESS (3.057s)
[80.340800] Starting dynamic subtest: D-eDP1
[83.409602] Dynamic subtest D-eDP1: SUCCESS (3.077s)
[83.411997] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.820s)
[84.201146] [015/130] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[84.325449] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[84.329935] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[84.405739] [016/130] (935s left) gem_exec_schedule (fifo)
[84.482822] Starting subtest: fifo
[84.484749] Starting dynamic subtest: rcs0
[84.565446] Dynamic subtest rcs0: SUCCESS (0.091s)
[84.575063] Starting dynamic subtest: vcs0
[84.640084] Dynamic subtest vcs0: SUCCESS (0.075s)
[84.650077] Starting dynamic subtest: vcs1
[84.710103] Dynamic subtest vcs1: SUCCESS (0.070s)
[84.719569] Starting dynamic subtest: vecs0
[84.778989] Dynamic subtest vecs0: SUCCESS (0.069s)
[84.789077] Starting dynamic subtest: ccs0
[84.853604] Dynamic subtest ccs0: SUCCESS (0.074s)
[84.856216] Subtest fifo: SUCCESS (0.379s)
[86.052485] [017/130] (933s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[86.166699] Starting subtest: 2x-long-flip-vs-cursor-legacy
[86.171230] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[86.258538] [018/130] (933s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[86.364538] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[89.826094] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (3.466s)
[89.965330] [019/130] (930s left) kms_psr (pr-cursor-mmap-cpu)
[90.061699] Starting subtest: pr-cursor-mmap-cpu
[90.065553] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[90.125055] [020/130] (929s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[90.225229] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[90.236146] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[90.350292] [021/130] (929s left) kms_flip (2x-modeset-vs-vblank-race)
[90.437540] Starting subtest: 2x-modeset-vs-vblank-race
[90.447796] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[90.564182] [022/130] (929s left) gem_exec_reloc (basic-gtt-wc-active)
[90.617894] Subtest basic-gtt-wc-active: SKIP (0.000s)
[90.689530] [023/130] (929s left) kms_plane_alpha_blend (constant-alpha-mid)
[90.779596] Starting subtest: constant-alpha-mid
[91.171216] Starting dynamic subtest: pipe-A-eDP-1
[91.959820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[91.967572] Starting dynamic subtest: pipe-D-eDP-1
[93.381773] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.422s)
[93.384041] Subtest constant-alpha-mid: SUCCESS (2.601s)
[94.178134] [024/130] (925s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[94.273742] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[94.278370] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[94.371429] [025/130] (925s left) gem_exec_whisper (basic-sync)
[94.439249] Starting subtest: basic-sync
[101.311706] Subtest basic-sync: SUCCESS (6.872s)
[101.489277] [026/130] (918s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[101.594067] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[101.596388] Starting dynamic subtest: pipe-A-eDP-1
[103.730557] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.135s)
[103.737875] Starting dynamic subtest: pipe-B-eDP-1
[105.828630] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.097s)
[105.837636] Starting dynamic subtest: pipe-C-eDP-1
[107.823908] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.995s)
[107.831508] Starting dynamic subtest: pipe-D-eDP-1
[109.844336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.020s)
[109.846691] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.250s)
[110.991514] [027/130] (909s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[111.065127] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[111.069792] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[111.242157] [028/130] (909s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[116.239625] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[116.244094] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[117.087226] [029/130] (903s left) kms_plane_multiple (tiling-x)
[117.186078] Starting subtest: tiling-x
[117.188529] Starting dynamic subtest: pipe-A-eDP-1
[120.781880] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.594s)
[120.789919] Starting dynamic subtest: pipe-B-eDP-1
[125.198843] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.416s)
[125.206499] Starting dynamic subtest: pipe-C-eDP-1
[129.475940] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.277s)
[129.482911] Starting dynamic subtest: pipe-D-eDP-1
[133.755226] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.277s)
[133.757222] Subtest tiling-x: SUCCESS (16.567s)
[134.586406] [030/130] (885s left) gem_softpin (invalid)
[134.652174] Starting subtest: invalid
[134.659118] Subtest invalid: SUCCESS (0.005s)
[134.782941] [031/130] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[134.886208] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[134.890329] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[134.998717] [032/130] (885s left) gem_exec_params (secure-non-master)
[135.065578] Starting subtest: secure-non-master
[135.070100] Subtest secure-non-master: SKIP (0.000s)
[135.168598] [033/130] (885s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[135.264965] Starting subtest: fbc-psr2-cursor-plane-onoff
[135.267266] Starting dynamic subtest: eDP-1
[135.271580] Dynamic subtest eDP-1: SKIP (0.000s)
[135.275560] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.002s)
[135.338234] [034/130] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[135.439576] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[138.051301] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.616s)
[138.206634] [035/130] (882s left) kms_addfb_basic (bad-pitch-63)
[138.266904] Starting subtest: bad-pitch-63
[138.268833] Subtest bad-pitch-63: SUCCESS (0.000s)
[138.414896] [036/130] (882s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[138.529734] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[139.588043] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.059s)
[139.732252] [037/130] (880s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[139.858051] Starting subtest: short-flip-after-cursor-toggle
[140.773827] Subtest short-flip-after-cursor-toggle: SUCCESS (0.915s)
[141.623377] [038/130] (878s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[141.718066] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[141.720291] Starting dynamic subtest: pipe-A-eDP-1
[141.740216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[141.746972] Starting dynamic subtest: pipe-B-eDP-1
[141.766041] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[141.772713] Starting dynamic subtest: pipe-C-eDP-1
[141.792385] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[141.800071] Starting dynamic subtest: pipe-D-eDP-1
[141.818781] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[141.820916] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[143.876246] [039/130] (876s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[143.987897] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[146.738972] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.756s)
[146.880391] [040/130] (873s left) kms_chamelium_frames (dp-crc-fast)
[147.267048] Subtest dp-crc-fast: SKIP (0.000s)
[148.103891] [041/130] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[148.204443] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[151.150092] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.949s)
[151.303431] [042/130] (869s left) perf_pmu (semaphore-wait-idle)
[151.341511] Starting subtest: semaphore-wait-idle
[151.343455] Starting dynamic subtest: rcs0
[151.857756] Dynamic subtest rcs0: SUCCESS (0.513s)
[151.868209] Starting dynamic subtest: bcs0
[152.370608] Dynamic subtest bcs0: SUCCESS (0.510s)
[152.380833] Starting dynamic subtest: vcs0
[152.883999] Dynamic subtest vcs0: SUCCESS (0.511s)
[152.894519] Starting dynamic subtest: vcs1
[153.397355] Dynamic subtest vcs1: SUCCESS (0.510s)
[153.405981] Starting dynamic subtest: vecs0
[153.910529] Dynamic subtest vecs0: SUCCESS (0.510s)
[153.921052] Starting dynamic subtest: ccs0
[154.425421] Dynamic subtest ccs0: SUCCESS (0.513s)
[154.428772] Subtest semaphore-wait-idle: SUCCESS (3.082s)
[154.533944] [043/130] (866s left) api_intel_allocator (reopen)
[154.591078] Starting subtest: reopen
[154.596515] Subtest reopen: SUCCESS (0.007s)
[154.735901] [044/130] (866s left) kms_big_fb (linear-16bpp-rotate-0)
[154.845086] Starting subtest: linear-16bpp-rotate-0
[156.279058] Subtest linear-16bpp-rotate-0: SUCCESS (1.433s)
[156.437250] [045/130] (864s left) syncobj_timeline (single-wait-for-submit-signaled)
[156.501258] Starting subtest: single-wait-for-submit-signaled
[156.502969] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[156.611189] [046/130] (864s left) kms_getfb (getfb2-into-addfb2)
[156.667934] Starting subtest: getfb2-into-addfb2
[156.669832] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[156.769445] [047/130] (864s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[156.873086] Starting subtest: psr-rgb565-draw-pwrite
[161.696383] Subtest psr-rgb565-draw-pwrite: SUCCESS (4.824s)
[161.834889] [048/130] (859s left) gem_readwrite (read-write)
[161.890689] Subtest read-write: SKIP (0.000s)
[161.940953] [049/130] (859s left) kms_flip (basic-flip-vs-modeset)
[162.043073] Starting subtest: basic-flip-vs-modeset
[162.045193] Starting dynamic subtest: A-eDP1
[164.591236] Dynamic subtest A-eDP1: SUCCESS (2.547s)
[164.599442] Starting dynamic subtest: B-eDP1
[166.733658] Dynamic subtest B-eDP1: SUCCESS (2.141s)
[166.741660] Starting dynamic subtest: C-eDP1
[168.874666] Dynamic subtest C-eDP1: SUCCESS (2.140s)
[168.882276] Starting dynamic subtest: D-eDP1
[171.023567] Dynamic subtest D-eDP1: SUCCESS (2.148s)
[171.026018] Subtest basic-flip-vs-modeset: SUCCESS (8.983s)
[171.817295] [050/130] (849s left) kms_color (ctm-blue-to-red)
[171.923141] Starting subtest: ctm-blue-to-red
[171.925416] Starting dynamic subtest: pipe-A-eDP-1
[172.621769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[172.628794] Starting dynamic subtest: pipe-B-eDP-1
[173.985955] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.364s)
[173.993909] Starting dynamic subtest: pipe-C-eDP-1
[175.265598] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s)
[175.274037] Starting dynamic subtest: pipe-D-eDP-1
[176.594632] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[176.597172] Subtest ctm-blue-to-red: SUCCESS (4.670s)
[177.422748] [051/130] (843s left) gem_mmap_gtt (basic-read-write)
[177.491709] Subtest basic-read-write: SKIP (0.000s)
[177.547178] [052/130] (843s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[177.648385] Starting subtest: psr-2p-pri-indfb-multidraw
[177.652613] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[177.743102] [053/130] (843s left) kms_rmfb (close-fd)
[177.847116] Starting subtest: close-fd
[177.849414] Starting dynamic subtest: pipe-A-eDP-1
[177.965615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.114s)
[177.978270] Starting dynamic subtest: pipe-B-eDP-1
[179.095945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[179.106406] Starting dynamic subtest: pipe-C-eDP-1
[180.213504] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[180.221748] Starting dynamic subtest: pipe-D-eDP-1
[181.338199] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[181.340481] Subtest close-fd: SUCCESS (3.489s)
[182.529512] [054/130] (838s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[182.638065] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[182.642358] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[182.734455] [055/130] (838s left) gem_sync (basic-store-each)
[182.803700] Starting subtest: basic-store-each
[185.075592] Subtest basic-store-each: SUCCESS (2.281s)
[185.248717] [056/130] (835s left) kms_chamelium_audio (hdmi-audio-edid)
[185.635755] Subtest hdmi-audio-edid: SKIP (0.000s)
[186.433875] [057/130] (834s left) i915_query (test-query-geometry-subslices)
[186.491982] Starting subtest: test-query-geometry-subslices
[186.494345] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[186.575929] [058/130] (834s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[186.678113] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[186.680341] Starting dynamic subtest: pipe-A-default-mode
[186.981205] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[186.987743] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.289s)
[187.775960] [059/130] (833s left) kms_cursor_crc (cursor-sliding-max-size)
[188.056998] Starting subtest: cursor-sliding-max-size
[188.063478] Subtest cursor-sliding-max-size: SKIP (0.000s)
[188.186617] [060/130] (833s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[188.289719] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[188.293807] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[188.373232] [061/130] (832s left) kms_content_protection (uevent)
[188.547824] Starting subtest: uevent
[191.913383] Subtest uevent: SKIP (3.363s)
[193.074374] [062/130] (828s left) gem_exec_balancer (parallel-keep-in-fence)
[193.317468] Starting subtest: parallel-keep-in-fence
[194.351186] Subtest parallel-keep-in-fence: SUCCESS (1.034s)
[194.454202] [063/130] (826s left) gem_exec_fence (syncobj-unused-fence)
[194.894144] Starting subtest: syncobj-unused-fence
[194.900220] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[195.972827] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[195.975492] [064/130] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[196.075654] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[196.079832] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[196.163104] [065/130] (825s left) dmabuf_sync_file (import-multiple-read-write)
[196.212097] Starting subtest: import-multiple-read-write
[196.214482] Subtest import-multiple-read-write: SUCCESS (0.003s)
[196.262229] [066/130] (825s left) gem_vm_create (invalid-destroy)
[196.325339] Starting subtest: invalid-destroy
[196.330567] Subtest invalid-destroy: SUCCESS (0.003s)
[196.432140] [067/130] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[196.539299] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[196.543609] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[196.626073] [068/130] (824s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[196.720148] Starting subtest: primary-4-tiled-reflect-x-180
[203.775905] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.053s)
[205.026599] [069/130] (816s left) gem_pipe_control_store_loop (fresh-buffer)
[205.087226] Starting subtest: fresh-buffer
[207.240645] Subtest fresh-buffer: SUCCESS (2.151s)
[207.378877] [070/130] (814s left) gem_exec_reloc (basic-write-cpu-noreloc)
[207.447279] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[207.525668] [071/130] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[207.639502] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[212.220376] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.583s)
[212.349387] [072/130] (809s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[212.442204] Starting subtest: compare-crc-sanitycheck-nv12
[212.444505] Starting dynamic subtest: pipe-A-eDP-1
[213.108102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s)
[213.121614] Starting dynamic subtest: pipe-B-eDP-1
[214.349289] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.237s)
[214.357100] Starting dynamic subtest: pipe-C-eDP-1
[215.505610] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.156s)
[215.515238] Starting dynamic subtest: pipe-D-eDP-1
[216.730996] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[216.733402] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.288s)
[217.581476] [073/130] (804s left) api_intel_bb (reset-bb)
[217.641614] Starting subtest: reset-bb
[217.643518] Subtest reset-bb: SUCCESS (0.004s)
[217.767903] [074/130] (804s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[217.826563] Starting subtest: etime-single-wait-for-submit-unsubmitted
[217.934530] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[218.008154] [075/130] (803s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[218.393141] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[219.183291] [076/130] (802s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[219.244153] Starting subtest: invalid-multi-wait-unsubmitted
[219.246627] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[219.339143] [077/130] (802s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[219.394101] Starting subtest: single-wait-all-for-submit-available-submitted
[219.396399] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[219.485786] [078/130] (802s left) kms_cursor_crc (cursor-onscreen-128x128)
[219.667976] Starting subtest: cursor-onscreen-128x128
[219.670258] Starting dynamic subtest: pipe-A-eDP-1
[221.900787] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.230s)
[221.925682] Starting dynamic subtest: pipe-D-eDP-1
[224.875606] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.954s)
[224.877793] Subtest cursor-onscreen-128x128: SUCCESS (5.209s)
[225.657892] [079/130] (796s left) gem_ctx_isolation (nonpriv)
[225.720609] Starting subtest: nonpriv
[225.722986] Starting dynamic subtest: rcs0
[226.254191] Dynamic subtest rcs0: SUCCESS (0.536s)
[226.264138] Starting dynamic subtest: bcs0
[226.799737] Dynamic subtest bcs0: SUCCESS (0.545s)
[226.809507] Starting dynamic subtest: vcs0
[227.334657] Dynamic subtest vcs0: SUCCESS (0.534s)
[227.344519] Starting dynamic subtest: vcs1
[229.462475] Dynamic subtest vcs1: SUCCESS (2.126s)
[229.469902] Starting dynamic subtest: vecs0
[231.512049] Dynamic subtest vecs0: SUCCESS (2.050s)
[231.522069] Starting dynamic subtest: ccs0
[233.549742] Dynamic subtest ccs0: SUCCESS (2.036s)
[233.552536] Subtest nonpriv: SUCCESS (7.831s)
[233.827949] [080/130] (788s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[233.930774] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[233.933151] Starting dynamic subtest: pipe-A-default-mode
[234.221418] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[234.226046] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.287s)
[235.078602] [081/130] (786s left) gem_ctx_param (invalid-ctx-set)
[235.132786] Starting subtest: invalid-ctx-set
[235.135056] Subtest invalid-ctx-set: SUCCESS (0.001s)
[235.233479] [082/130] (786s left) kms_joiner (basic-max-non-joiner)
[235.337761] Starting subtest: basic-max-non-joiner
[235.342271] Subtest basic-max-non-joiner: SKIP (0.000s)
[235.396663] [083/130] (786s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[240.430489] Starting subtest: pr-overlay-plane-move-continuous-sf
[240.435581] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[241.264074] [084/130] (780s left) kms_vblank (wait-forked-hang)
[241.360098] Starting subtest: wait-forked-hang
[241.362555] Starting dynamic subtest: pipe-A-eDP-1
[267.688478] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.324s)
[267.701170] Starting dynamic subtest: pipe-D-eDP-1
[282.657051] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.965s)
[282.658994] Subtest wait-forked-hang: SUCCESS (41.293s)
[283.513800] [085/130] (738s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[283.614169] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[283.616493] Starting dynamic subtest: pipe-A-eDP-1
[283.798047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.173s)
[283.810386] Starting dynamic subtest: pipe-B-eDP-1
[283.830536] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[283.838686] Starting dynamic subtest: pipe-C-eDP-1
[283.858170] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[283.870258] Starting dynamic subtest: pipe-D-eDP-1
[283.890357] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.003s)
[283.892338] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.186s)
[286.057266] [086/130] (736s left) gem_tiled_pread_pwrite
[286.174429] [087/130] (736s left) gem_eio (create)
[286.373700] Starting subtest: create
[286.644362] Subtest create: SUCCESS (0.268s)
[286.755651] [088/130] (735s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[286.864709] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[286.869220] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[286.945536] [089/130] (735s left) prime_mmap (test_invalid_sync_flags)
[287.007805] Starting subtest: test_invalid_sync_flags
[287.009872] Starting dynamic subtest: test_invalid_sync_flags-smem
[287.011832] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[287.013488] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[287.112640] [090/130] (735s left) gem_fenced_exec_thrash (2-spare-fences)
[287.178515] Subtest 2-spare-fences: SKIP (0.000s)
[287.241567] [091/130] (735s left) i915_hangman (gt-error-state-capture)
[287.316762] Starting subtest: gt-error-state-capture
[287.318757] Starting dynamic subtest: rcs0
[298.888531] Dynamic subtest rcs0: SUCCESS (11.571s)
[298.902343] Starting dynamic subtest: bcs0
[310.921357] Dynamic subtest bcs0: SUCCESS (12.030s)
[310.931082] Starting dynamic subtest: vcs0
[321.864634] Dynamic subtest vcs0: SUCCESS (10.941s)
[321.874244] Starting dynamic subtest: vcs1
[333.832432] Dynamic subtest vcs1: SUCCESS (11.965s)
[333.843489] Starting dynamic subtest: vecs0
[342.921102] Dynamic subtest vecs0: SUCCESS (9.086s)
[342.931857] Starting dynamic subtest: ccs0
[354.889375] Dynamic subtest ccs0: SUCCESS (11.966s)
[354.892235] Subtest gt-error-state-capture: SUCCESS (67.571s)
[354.965360] [092/130] (667s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[355.065311] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[355.067631] Starting dynamic subtest: pipe-A-default-mode
[356.213993] Dynamic subtest pipe-A-default-mode: SKIP (1.142s)
[356.218684] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.144s)
[356.348956] [093/130] (666s left) drm_fdinfo (virtual-busy)
[356.388819] Starting subtest: virtual-busy
[356.393152] Subtest virtual-busy: SKIP (0.000s)
[356.443424] [094/130] (666s left) perf (gen12-mi-rpc)
[356.538584] Starting subtest: gen12-mi-rpc
[356.540765] Starting dynamic subtest: rcs0
[356.565086] Dynamic subtest rcs0: SUCCESS (0.024s)
[356.567331] Subtest gen12-mi-rpc: SUCCESS (0.024s)
[356.599614] [095/130] (665s left) gem_exec_balancer (sliced)
[356.709946] Starting subtest: sliced
[356.714633] Subtest sliced: SKIP (0.000s)
[356.980655] [096/130] (665s left) gem_exec_schedule (semaphore-user)
[357.060583] Starting subtest: semaphore-user
[357.109448] Subtest semaphore-user: SUCCESS (0.057s)
[358.985928] [097/130] (663s left) gem_softpin (evict-active-interruptible)
[359.042901] Starting subtest: evict-active-interruptible
[359.059304] Subtest evict-active-interruptible: SUCCESS (0.016s)
[359.193525] [098/130] (663s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[359.296318] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[359.298711] Starting dynamic subtest: pipe-A
[359.315944] Dynamic subtest pipe-A: SKIP (0.014s)
[359.325131] Starting dynamic subtest: pipe-B
[359.342260] Dynamic subtest pipe-B: SKIP (0.024s)
[359.350209] Starting dynamic subtest: pipe-C
[359.367401] Dynamic subtest pipe-C: SKIP (0.025s)
[359.374912] Starting dynamic subtest: pipe-D
[359.393644] Dynamic subtest pipe-D: SKIP (0.027s)
[359.397884] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.093s)
[359.494098] [099/130] (663s left) i915_pm_rps (thresholds-idle)
[359.547686] Starting subtest: thresholds-idle
[359.552325] Subtest thresholds-idle: SKIP (0.001s)
[359.622677] [100/130] (663s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[359.730785] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[359.735771] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[359.833287] [101/130] (662s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[359.949942] Starting subtest: basic-flip-before-cursor-varying-size
[360.865715] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.916s)
[361.704033] [102/130] (661s left) kms_addfb_basic (basic-y-tiled-legacy)
[361.760071] Starting subtest: basic-y-tiled-legacy
[361.764213] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[361.900119] [103/130] (660s left) kms_getfb (getfb-reject-ccs)
[361.952071] Starting subtest: getfb-reject-ccs
[361.954319] Subtest getfb-reject-ccs: SUCCESS (0.000s)
[362.055567] [104/130] (660s left) gem_create (busy-create)
[362.114476] Starting subtest: busy-create
[362.116744] Starting dynamic subtest: smem0
[394.948498] Dynamic subtest smem0: SUCCESS (32.831s)
[394.951205] Subtest busy-create: SUCCESS (32.832s)
[395.127348] [105/130] (627s left) kms_psr (fbc-pr-primary-page-flip)
[395.223192] Starting subtest: fbc-pr-primary-page-flip
[395.227703] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[395.290860] [106/130] (627s left) kms_cursor_legacy (single-bo)
[395.401507] Starting subtest: single-bo
[395.403644] Starting dynamic subtest: pipe-A
[400.785103] Dynamic subtest pipe-A: SUCCESS (5.381s)
[400.794662] Starting dynamic subtest: pipe-B
[406.168953] Dynamic subtest pipe-B: SUCCESS (5.381s)
[406.178828] Starting dynamic subtest: pipe-C
[411.553191] Dynamic subtest pipe-C: SUCCESS (5.382s)
[411.563110] Starting dynamic subtest: pipe-D
[416.938292] Dynamic subtest pipe-D: SUCCESS (5.382s)
[416.948959] Starting dynamic subtest: all-pipes
[422.329071] Dynamic subtest all-pipes: SUCCESS (5.389s)
[422.331505] Subtest single-bo: SUCCESS (26.926s)
[422.456997] [107/130] (600s left) api_intel_allocator (alloc-simple)
[422.508345] Starting subtest: alloc-simple
[422.512836] Subtest alloc-simple: SUCCESS (0.006s)
[422.626487] [108/130] (600s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[422.729704] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[422.734222] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[422.833758] [109/130] (600s left) gem_softpin (reverse)
[422.890995] Starting subtest: reverse
[422.898161] Subtest reverse: SUCCESS (0.007s)
[423.020326] [110/130] (599s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[423.073890] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[423.078126] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[423.251464] [111/130] (599s left) gem_basic (bad-close)
[423.308257] Starting subtest: bad-close
[423.312416] Subtest bad-close: SUCCESS (0.000s)
[423.419265] [112/130] (599s left) gem_partial_pwrite_pread (reads-display)
[423.488174] Subtest reads-display: SKIP (0.000s)
[423.565750] [113/130] (599s left) gen9_exec_parse (batch-invalid-length)
[423.623591] Subtest batch-invalid-length: SKIP (0.000s)
[423.705193] [114/130] (599s left) kms_atomic (plane-overlay-legacy)
[423.804327] Starting subtest: plane-overlay-legacy
[423.806522] Starting dynamic subtest: pipe-A-eDP-1
[424.218327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[424.220714] Subtest plane-overlay-legacy: SUCCESS (0.416s)
[425.024169] [115/130] (598s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[430.074474] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[430.079136] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[430.923278] [116/130] (592s left) gem_eio (unwedge-stress)
[431.156047] Starting subtest: unwedge-stress
[474.493674] Subtest unwedge-stress: SUCCESS (43.335s)
[475.979883] [117/130] (547s left) vgem_basic (bad-handle)
[476.025837] Starting subtest: bad-handle
[476.028078] Subtest bad-handle: SUCCESS (0.000s)
[476.077557] [118/130] (547s left) gem_pxp (fail-invalid-protected-context)
[476.210808] Starting subtest: fail-invalid-protected-context
[476.213082] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[476.322333] [119/130] (546s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[476.418433] Starting subtest: extended-modeset-hang-oldfb-with-reset
[476.420775] Starting dynamic subtest: pipe-A
[488.383354] Dynamic subtest pipe-A: SUCCESS (11.964s)
[488.392191] Starting dynamic subtest: pipe-D
[500.637214] Dynamic subtest pipe-D: SUCCESS (12.250s)
[500.639589] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.219s)
[501.412930] [120/130] (521s left) gem_partial_pwrite_pread (writes-after-reads-display)
[501.471527] Subtest writes-after-reads-display: SKIP (0.000s)
[501.531169] [121/130] (521s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[501.637329] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[501.641853] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[501.739185] [122/130] (521s left) gem_ctx_isolation (preservation-reset)
[501.918594] Starting subtest: preservation-reset
[501.921525] Starting dynamic subtest: rcs0
[502.290054] Dynamic subtest rcs0: SUCCESS (0.372s)
[502.301023] Starting dynamic subtest: bcs0
[502.726824] Dynamic subtest bcs0: SUCCESS (0.436s)
[502.737464] Starting dynamic subtest: vcs0
[503.161096] Dynamic subtest vcs0: SUCCESS (0.434s)
[503.170938] Starting dynamic subtest: vcs1
[504.333065] Dynamic subtest vcs1: SUCCESS (1.171s)
[504.340943] Starting dynamic subtest: vecs0
[506.382596] Dynamic subtest vecs0: SUCCESS (2.049s)
[506.390826] Starting dynamic subtest: ccs0
[508.348298] Dynamic subtest ccs0: SUCCESS (1.965s)
[508.350711] Subtest preservation-reset: SUCCESS (6.432s)
[508.537224] [123/130] (514s left) gem_ctx_shared (detached-shared-gtt)
[508.604988] Starting subtest: detached-shared-gtt
[510.762241] Subtest detached-shared-gtt: SUCCESS (2.156s)
[511.061095] [124/130] (512s left) kms_universal_plane (universal-plane-functional)
[511.163115] Starting subtest: universal-plane-functional
[511.165411] Starting dynamic subtest: pipe-A-eDP-1
[514.943844] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.779s)
[514.952470] Starting dynamic subtest: pipe-B-eDP-1
[519.314979] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.369s)
[519.323816] Starting dynamic subtest: pipe-C-eDP-1
[523.561349] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.245s)
[523.570065] Starting dynamic subtest: pipe-D-eDP-1
[527.842830] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.279s)
[527.845272] Subtest universal-plane-functional: SUCCESS (16.677s)
[528.621514] [125/130] (494s left) sw_sync (sync_multi_producer_single_consumer)
[528.660528] Starting subtest: sync_multi_producer_single_consumer
[529.737044] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[529.789641] [126/130] (493s left) gem_lmem_swapping (verify)
[529.834768] Subtest verify: SKIP (0.000s)
[529.868813] [127/130] (493s left) gem_exec_reloc (basic-write-cpu-active)
[529.938368] Subtest basic-write-cpu-active: SKIP (0.000s)
[530.038349] [128/130] (493s left) gem_mmap_offset (oob-read)
[530.098574] Starting subtest: oob-read
[530.100857] Subtest oob-read: SUCCESS (0.001s)
[530.190520] [129/130] (493s left) kms_plane_scaling (planes-scaler-unity-scaling)
[530.296191] Starting subtest: planes-scaler-unity-scaling
[530.298462] Starting dynamic subtest: pipe-A
[530.380247] Dynamic subtest pipe-A: SUCCESS (0.084s)
[530.390559] Starting dynamic subtest: pipe-B
[531.554908] Dynamic subtest pipe-B: SUCCESS (1.174s)
[531.564602] Starting dynamic subtest: pipe-C
[532.656187] Dynamic subtest pipe-C: SUCCESS (1.100s)
[532.664454] Starting dynamic subtest: pipe-D
[533.793248] Dynamic subtest pipe-D: SUCCESS (1.135s)
[533.795640] Subtest planes-scaler-unity-scaling: SUCCESS (3.497s)
[534.928788] [130/130] (488s left) prime_vgem (basic-write)
[535.014814] Starting subtest: basic-write
[535.024524] Subtest basic-write: SKIP (0.008s)
[535.142758] Closing watchdogs
Done.