[59.287038] Initializing watchdogs
[59.287088]   /dev/watchdog0
[59.301816] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.305766] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.308075] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.311731] [001/156] (960s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[59.415777] Starting subtest: plane-upscale-factor-0-25-with-rotation
[59.418063] Starting dynamic subtest: pipe-A
[59.649974] Dynamic subtest pipe-A: SUCCESS (0.237s)
[59.659223] Starting dynamic subtest: pipe-B
[61.201430] Dynamic subtest pipe-B: SUCCESS (1.559s)
[61.210438] Starting dynamic subtest: pipe-C
[62.522592] Dynamic subtest pipe-C: SUCCESS (1.326s)
[62.531725] Starting dynamic subtest: pipe-D
[63.840360] Dynamic subtest pipe-D: SUCCESS (1.322s)
[63.842677] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.447s)
[65.028568] [002/156] (954s left) kms_chamelium_audio (hdmi-audio)
[65.390630] Subtest hdmi-audio: SKIP (0.000s)
[66.219210] [003/156] (953s left) sw_sync (sync_merge_invalid)
[66.252420] Starting subtest: sync_merge_invalid
[66.267881] Subtest sync_merge_invalid: SUCCESS (0.018s)
[66.366942] [004/156] (953s left) gem_reg_read (timestamp-moving)
[66.411974] Starting subtest: timestamp-moving
[67.412761] Subtest timestamp-moving: SUCCESS (1.003s)
[67.484152] [005/156] (952s left) kms_joiner (basic-ultra-joiner)
[67.559481] Starting subtest: basic-ultra-joiner
[67.563766] Subtest basic-ultra-joiner: SKIP (0.000s)
[67.630626] [006/156] (952s left) prime_busy (before)
[67.695273] Starting subtest: before
[67.700818] Starting dynamic subtest: rcs0
[67.740995] Dynamic subtest rcs0: SUCCESS (0.040s)
[67.749774] Starting dynamic subtest: bcs0
[67.795253] Dynamic subtest bcs0: SUCCESS (0.054s)
[67.804138] Starting dynamic subtest: vcs0
[67.835439] Dynamic subtest vcs0: SUCCESS (0.040s)
[67.842928] Starting dynamic subtest: vcs1
[67.876101] Dynamic subtest vcs1: SUCCESS (0.040s)
[67.884221] Starting dynamic subtest: vecs0
[67.918062] Dynamic subtest vecs0: SUCCESS (0.041s)
[67.926159] Starting dynamic subtest: ccs0
[67.958259] Dynamic subtest ccs0: SUCCESS (0.040s)
[68.067780] Subtest before: SUCCESS (0.371s)
[68.140177] [007/156] (951s left) gem_exec_whisper (basic-queues)
[68.200876] Starting subtest: basic-queues
[73.656079] Subtest basic-queues: SUCCESS (5.460s)
[73.835120] [008/156] (946s left) gem_fence_thrash (bo-write-verify-threaded-none)
[73.866651] Starting subtest: bo-write-verify-threaded-none
[73.890210] Subtest bo-write-verify-threaded-none: SKIP (0.021s)
[73.946184] [009/156] (946s left) gem_lmem_swapping (parallel-random-verify-ccs)
[73.986702] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[74.026980] [010/156] (946s left) gem_eio (in-flight-contexts-10ms)
[74.281304] Starting subtest: in-flight-contexts-10ms
[88.272982] Subtest in-flight-contexts-10ms: SUCCESS (13.994s)
[88.422855] [011/156] (931s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[88.510196] Starting subtest: psr-rgb101010-draw-mmap-gtt
[88.514434] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[88.595810] [012/156] (931s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[88.671751] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[88.674126] Starting dynamic subtest: pipe-A-eDP-1
[88.694633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[88.705640] Starting dynamic subtest: pipe-B-eDP-1
[88.725111] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[88.733854] Starting dynamic subtest: pipe-C-eDP-1
[88.753178] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[88.763189] Starting dynamic subtest: pipe-D-eDP-1
[88.783084] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[88.785383] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.005s)
[90.987502] [013/156] (929s left) prime_vgem (basic-gtt)
[91.104733] Starting subtest: basic-gtt
[91.109509] Subtest basic-gtt: SKIP (0.000s)
[91.195017] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[91.197958] [014/156] (929s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[91.271042] Starting subtest: fbc-dirtyfb-ioctl
[91.273704] Starting dynamic subtest: A-eDP-1
[93.863041] Dynamic subtest A-eDP-1: SUCCESS (2.590s)
[93.865722] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.591s)
[94.748389] [015/156] (925s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[94.859112] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[94.863796] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[95.010901] [016/156] (925s left) kms_lease (simple-lease)
[95.080773] Starting subtest: simple-lease
[95.083124] Starting dynamic subtest: pipe-A-eDP-1
[95.606703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.525s)
[95.620959] Starting dynamic subtest: pipe-B-eDP-1
[97.095826] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.489s)
[97.105706] Starting dynamic subtest: pipe-C-eDP-1
[98.503892] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s)
[98.514052] Starting dynamic subtest: pipe-D-eDP-1
[99.912476] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s)
[99.914940] Subtest simple-lease: SUCCESS (4.832s)
[100.724340] [017/156] (919s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[100.770812] Starting subtest: wait-all-for-submit-delayed-submit
[100.871957] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[100.966471] [018/156] (919s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[101.046392] Starting subtest: psr-rgb565-draw-render
[108.115427] Subtest psr-rgb565-draw-render: SUCCESS (7.075s)
[108.224633] [019/156] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[108.305028] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[108.309300] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[108.404048] [020/156] (912s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[108.495353] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[115.365835] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.875s)
[115.504779] [021/156] (905s left) gem_userptr_blits (sync-unmap)
[115.568908] Starting subtest: sync-unmap
[115.579238] Subtest sync-unmap: SUCCESS (0.013s)
[115.708921] [022/156] (904s left) kms_flip (flip-vs-rmfb-interruptible)
[115.792064] Starting subtest: flip-vs-rmfb-interruptible
[115.794496] Starting dynamic subtest: A-eDP1
[124.451497] Dynamic subtest A-eDP1: SUCCESS (8.658s)
[124.462276] Starting dynamic subtest: B-eDP1
[133.080468] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[133.090944] Starting dynamic subtest: C-eDP1
[141.695300] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[141.706909] Starting dynamic subtest: D-eDP1
[150.348077] Dynamic subtest D-eDP1: SUCCESS (8.650s)
[150.352450] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.560s)
[151.594482] [023/156] (869s left) gem_ctx_param (invalid-get-no-zeromap)
[151.656589] Starting subtest: invalid-get-no-zeromap
[151.658544] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[151.765599] [024/156] (868s left) gem_spin_batch (legacy)
[151.825905] Starting subtest: legacy
[151.828218] Starting dynamic subtest: default
[155.063227] Dynamic subtest default: SUCCESS (3.231s)
[155.074170] Starting dynamic subtest: render
[158.296867] Dynamic subtest render: SUCCESS (3.231s)
[158.307792] Starting dynamic subtest: bsd
[161.531854] Dynamic subtest bsd: SUCCESS (3.232s)
[161.542637] Starting dynamic subtest: bsd1
[164.766018] Dynamic subtest bsd1: SUCCESS (3.232s)
[164.778075] Starting dynamic subtest: bsd2
[167.998493] Dynamic subtest bsd2: SUCCESS (3.229s)
[168.009767] Starting dynamic subtest: blt
[171.231936] Dynamic subtest blt: SUCCESS (3.230s)
[171.243270] Starting dynamic subtest: vebox
[174.466964] Dynamic subtest vebox: SUCCESS (3.232s)
[174.469135] Subtest legacy: SUCCESS (22.636s)
[175.317904] [025/156] (845s left) dumb_buffer (create-valid-dumb)
[175.372693] Starting subtest: create-valid-dumb
[175.374654] Subtest create-valid-dumb: SUCCESS (0.000s)
[175.468588] [026/156] (845s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[176.011434] Starting subtest: syncobj-stationary-timeline-chain-engines
[176.195389] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.183s)
[177.281277] [027/156] (843s left) kms_flip (bo-too-big-interruptible)
[177.366133] Starting subtest: bo-too-big-interruptible
[177.368357] Starting dynamic subtest: A-eDP1
[178.641563] Dynamic subtest A-eDP1: SUCCESS (1.274s)
[178.650795] Starting dynamic subtest: B-eDP1
[179.874716] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[179.885100] Starting dynamic subtest: C-eDP1
[181.207411] Dynamic subtest C-eDP1: SUCCESS (1.332s)
[181.219317] Starting dynamic subtest: D-eDP1
[182.440449] Dynamic subtest D-eDP1: SUCCESS (1.232s)
[182.442910] Subtest bo-too-big-interruptible: SUCCESS (5.077s)
[183.665389] [028/156] (837s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[183.742536] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[184.742698] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.000s)
[184.875054] [029/156] (836s left) gem_exec_fence (invalid-fence-array)
[185.294331] Starting subtest: invalid-fence-array
[185.296672] Subtest invalid-fence-array: SUCCESS (0.003s)
[187.354547] [030/156] (833s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[187.439194] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[194.753511] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.321s)
[194.889655] [031/156] (826s left) perf (gen12-unprivileged-single-ctx-counters)
[195.016417] Starting subtest: gen12-unprivileged-single-ctx-counters
[195.018642] Starting dynamic subtest: rcs0
[195.191199] Dynamic subtest rcs0: SUCCESS (0.176s)
[195.193527] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.177s)
[195.232266] [032/156] (825s left) vgem_basic (busy-fence)
[195.275504] Starting subtest: busy-fence
[195.277479] Subtest busy-fence: SUCCESS (0.000s)
[195.336288] [033/156] (825s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[195.412060] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[195.420419] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.008s)
[195.495078] [034/156] (825s left) kms_big_fb (linear-8bpp-rotate-270)
[195.568939] Starting subtest: linear-8bpp-rotate-270
[195.589318] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[195.704454] [035/156] (825s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[195.758510] Starting subtest: map-fixed-invalidate-overlap
[195.762411] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[195.894740] [036/156] (825s left) gem_busy (close-race)
[195.944186] Starting subtest: close-race
[221.183055] Subtest close-race: SUCCESS (25.235s)
[221.540576] [037/156] (799s left) kms_plane (pixel-format-yf-tiled-modifier)
[221.654995] Starting subtest: pixel-format-yf-tiled-modifier
[221.659084] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[221.737485] [038/156] (799s left) core_auth (basic-auth)
[221.793626] Starting subtest: basic-auth
[221.795585] Subtest basic-auth: SUCCESS (0.001s)
[221.910727] [039/156] (799s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[221.997211] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[222.001523] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[222.106496] [040/156] (799s left) kms_pm_rpm (package-g7)
[224.443915] Starting subtest: package-g7
[224.448472] Subtest package-g7: SKIP (0.000s)
[224.827099] [041/156] (796s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[224.904701] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[224.908813] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[225.000719] [042/156] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[225.083035] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[225.087224] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[225.183944] [043/156] (796s left) kms_chamelium_frames (dp-frame-dump)
[225.541383] Subtest dp-frame-dump: SKIP (0.000s)
[226.325525] [044/156] (795s left) gem_barrier_race (remote-request)
[226.395229] Starting subtest: remote-request
[226.397384] Starting dynamic subtest: rcs0
[231.547242] Dynamic subtest rcs0: SUCCESS (5.152s)
[231.552014] Subtest remote-request: SUCCESS (5.153s)
[231.691392] [045/156] (789s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[231.760544] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[231.762481] Starting dynamic subtest: pipe-A-eDP-1
[231.783715] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.794634] Starting dynamic subtest: pipe-B-eDP-1
[231.813094] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.822109] Starting dynamic subtest: pipe-C-eDP-1
[231.840372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.849040] Starting dynamic subtest: pipe-D-eDP-1
[231.867271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.870802] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[234.008088] [046/156] (787s left) kms_cursor_crc (cursor-sliding-128x42)
[234.211059] Starting subtest: cursor-sliding-128x42
[234.255338] Subtest cursor-sliding-128x42: SKIP (0.041s)
[234.439045] [047/156] (787s left) gem_exec_schedule (u-submit-golden-slice)
[234.513970] Starting subtest: u-submit-golden-slice
[234.516212] Starting dynamic subtest: rcs0
[234.546229] Dynamic subtest rcs0: SUCCESS (0.036s)
[234.556109] Starting dynamic subtest: bcs0
[234.582693] Dynamic subtest bcs0: SUCCESS (0.035s)
[234.592912] Starting dynamic subtest: vcs0
[234.614818] Dynamic subtest vcs0: SUCCESS (0.032s)
[234.624969] Starting dynamic subtest: vcs1
[234.650909] Dynamic subtest vcs1: SUCCESS (0.035s)
[234.660523] Starting dynamic subtest: vecs0
[234.684739] Dynamic subtest vecs0: SUCCESS (0.033s)
[234.694696] Starting dynamic subtest: ccs0
[234.720663] Dynamic subtest ccs0: SUCCESS (0.035s)
[234.723100] Subtest u-submit-golden-slice: SUCCESS (0.211s)
[236.308333] [048/156] (785s left) gem_userptr_blits (mmap-offset-banned)
[236.386072] Starting subtest: mmap-offset-banned
[236.388367] Starting dynamic subtest: wb
[236.390608] Dynamic subtest wb: SUCCESS (0.000s)
[236.403070] Starting dynamic subtest: wc
[236.405176] Dynamic subtest wc: SUCCESS (0.000s)
[236.415075] Starting dynamic subtest: uc
[236.417203] Dynamic subtest uc: SUCCESS (0.000s)
[236.419328] Subtest mmap-offset-banned: SUCCESS (0.002s)
[236.509606] [049/156] (785s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[236.600165] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[236.604803] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[236.724417] [050/156] (785s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[236.814787] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[236.818931] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[236.919751] [051/156] (784s left) gem_ctx_shared (q-independent)
[236.988554] Starting subtest: Q-independent
[236.990893] Starting dynamic subtest: rcs0
[237.054180] Dynamic subtest rcs0: SUCCESS (0.065s)
[237.065754] Starting dynamic subtest: vcs0
[237.094505] Dynamic subtest vcs0: SUCCESS (0.040s)
[237.104726] Starting dynamic subtest: vcs1
[237.138220] Dynamic subtest vcs1: SUCCESS (0.043s)
[237.151475] Starting dynamic subtest: vecs0
[237.180300] Dynamic subtest vecs0: SUCCESS (0.042s)
[237.190559] Starting dynamic subtest: ccs0
[237.239280] Dynamic subtest ccs0: SUCCESS (0.058s)
[237.241921] Subtest Q-independent: SUCCESS (0.251s)
[238.293917] [052/156] (783s left) kms_universal_plane (universal-plane-pageflip-windowed)
[238.383732] Starting subtest: universal-plane-pageflip-windowed
[238.386046] Starting dynamic subtest: pipe-A-eDP-1
[238.938558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[238.948733] Starting dynamic subtest: pipe-B-eDP-1
[240.110965] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s)
[240.122896] Starting dynamic subtest: pipe-C-eDP-1
[241.321564] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[241.331832] Starting dynamic subtest: pipe-D-eDP-1
[242.553709] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[242.556041] Subtest universal-plane-pageflip-windowed: SUCCESS (4.169s)
[243.430883] [053/156] (778s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt)
[243.518268] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt
[243.522196] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[243.620296] [054/156] (778s left) kms_vrr (flip-basic-fastset)
[243.694601] Starting subtest: flip-basic-fastset
[243.700606] Subtest flip-basic-fastset: SKIP (0.000s)
[243.768569] [055/156] (778s left) gem_mmap_gtt (fault-concurrent)
[243.829994] Subtest fault-concurrent: SKIP (0.000s)
[243.884866] [056/156] (778s left) kms_plane_cursor (viewport)
[243.950313] Starting subtest: viewport
[243.954562] Starting dynamic subtest: pipe-A-eDP-1-size-64
[246.470448] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.519s)
[246.529947] Starting dynamic subtest: pipe-A-eDP-1-size-128
[248.992840] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.472s)
[249.056213] Starting dynamic subtest: pipe-A-eDP-1-size-256
[251.550381] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.505s)
[251.902830] Starting dynamic subtest: pipe-B-eDP-1-size-64
[255.122141] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.231s)
[255.180503] Starting dynamic subtest: pipe-B-eDP-1-size-128
[257.659299] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.484s)
[257.717258] Starting dynamic subtest: pipe-B-eDP-1-size-256
[260.201266] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.493s)
[260.555048] Starting dynamic subtest: pipe-C-eDP-1-size-64
[263.358958] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.815s)
[263.396909] Starting dynamic subtest: pipe-C-eDP-1-size-128
[265.525756] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s)
[265.565087] Starting dynamic subtest: pipe-C-eDP-1-size-256
[267.625602] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.070s)
[267.963792] Starting dynamic subtest: pipe-D-eDP-1-size-64
[270.797564] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.848s)
[270.836628] Starting dynamic subtest: pipe-D-eDP-1-size-128
[272.942160] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[272.982310] Starting dynamic subtest: pipe-D-eDP-1-size-256
[275.063901] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.092s)
[275.381671] Subtest viewport: SUCCESS (31.430s)
[276.269411] [057/156] (745s left) kms_addfb_basic (legacy-format)
[276.331783] Starting subtest: legacy-format
[276.357639] Subtest legacy-format: SUCCESS (0.024s)
[276.486591] [058/156] (745s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[276.552062] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[276.556575] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[276.648102] [059/156] (745s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[276.728831] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[276.733208] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[276.849558] [060/156] (745s left) kms_cursor_edge_walk (128x128-right-edge)
[276.924841] Starting subtest: 128x128-right-edge
[276.927616] Starting dynamic subtest: pipe-A-eDP-1
[280.423861] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s)
[280.436483] Starting dynamic subtest: pipe-D-eDP-1
[283.648713] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.223s)
[283.650939] Subtest 128x128-right-edge: SUCCESS (6.723s)
[284.459344] [061/156] (737s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[284.560892] Starting subtest: cursorB-vs-flipA-varying-size
[284.565507] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[284.703190] [062/156] (737s left) gem_compute (compute-square)
[284.755068] Starting subtest: compute-square
[284.761781] Subtest compute-square: SUCCESS (0.009s)
[284.847995] [063/156] (737s left) kms_psr (fbc-psr-primary-render)
[284.927067] Starting subtest: fbc-psr-primary-render
[284.929227] Starting dynamic subtest: eDP-1
[284.933104] Dynamic subtest eDP-1: SKIP (0.000s)
[284.937130] Subtest fbc-psr-primary-render: SKIP (0.001s)
[285.003203] [064/156] (737s left) gem_mmap_offset (pf-nonblock)
[285.060738] Starting subtest: pf-nonblock
[285.063092] Subtest pf-nonblock: SUCCESS (0.005s)
[285.189895] [065/156] (737s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[285.275472] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[285.280041] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[285.376761] [066/156] (737s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[285.462049] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[285.465537] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[285.553889] [067/156] (736s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[285.627570] Starting subtest: psrhdr-2p-rte
[285.630885] Subtest psrhdr-2p-rte: SKIP (0.000s)
[285.722896] [068/156] (736s left) kms_feature_discovery (display-3x)
[285.792815] Starting subtest: display-3x
[285.796701] Subtest display-3x: SKIP (0.000s)
[285.877271] [069/156] (736s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[285.959072] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[285.962460] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[286.054992] [070/156] (736s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[286.128694] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[290.431427] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.305s)
[291.590297] [071/156] (731s left) gem_userptr_blits (invalid-null-pointer)
[291.643805] Starting subtest: invalid-null-pointer
[291.645712] Subtest invalid-null-pointer: SUCCESS (0.001s)
[291.769398] [072/156] (730s left) kms_invalid_mode (bad-hsync-end)
[291.845401] Starting subtest: bad-hsync-end
[291.847558] Starting dynamic subtest: pipe-A-eDP-1
[292.126536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[292.136879] Starting dynamic subtest: pipe-B-eDP-1
[292.139046] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[292.149114] Starting dynamic subtest: pipe-C-eDP-1
[292.150969] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[292.160144] Starting dynamic subtest: pipe-D-eDP-1
[292.162036] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[292.164608] Subtest bad-hsync-end: SUCCESS (0.289s)
[292.998166] [073/156] (729s left) kms_color (legacy-gamma-reset)
[293.073063] Starting subtest: legacy-gamma-reset
[293.074976] Starting dynamic subtest: pipe-A-eDP-1
[293.445792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s)
[293.455651] Starting dynamic subtest: pipe-B-eDP-1
[293.457773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[293.467413] Starting dynamic subtest: pipe-C-eDP-1
[293.469624] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[293.479242] Starting dynamic subtest: pipe-D-eDP-1
[293.481566] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[293.483937] Subtest legacy-gamma-reset: SUCCESS (0.408s)
[294.310310] [074/156] (728s left) i915_pm_freq_mult (media-freq)
[294.360750] Starting subtest: media-freq
[294.363035] Starting dynamic subtest: gt0
[294.367567] Dynamic subtest gt0: SKIP (0.000s)
[294.377317] Starting dynamic subtest: gt1
[294.381835] Dynamic subtest gt1: SKIP (0.000s)
[294.386206] Subtest media-freq: SKIP (0.002s)
[294.458359] [075/156] (728s left) template (a)
[294.510564] Starting subtest: A
[294.512966] Subtest A: SUCCESS (0.000s)
[294.606104] [076/156] (728s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[294.683910] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[294.686192] Starting dynamic subtest: pipe-A-eDP-1
[294.759087] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[294.770969] Starting dynamic subtest: pipe-B-eDP-1
[295.887357] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[295.892117] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.206s)
[297.064896] [077/156] (725s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[297.136719] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[297.139092] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[297.243010] [078/156] (725s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[297.303870] Starting subtest: x-tiled-to-vebox-yf-tiled
[297.308174] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[297.482038] [079/156] (725s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[297.563360] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[297.567801] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[297.654521] [080/156] (725s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[297.732894] Starting subtest: hdr-1p-pri-indfb-multidraw
[297.737098] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[297.831455] [081/156] (725s left) gem_exec_reloc (basic-cpu-read)
[297.896062] Subtest basic-cpu-read: SKIP (0.000s)
[297.976711] [082/156] (725s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[298.026078] Starting subtest: invalid-multi-wait-all-unsubmitted
[298.028442] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[298.146808] [083/156] (725s left) api_intel_allocator (reopen-fork)
[298.193100] Starting subtest: reopen-fork
[301.490036] Subtest reopen-fork: SUCCESS (3.298s)
[301.568235] [084/156] (721s left) gem_mmap_wc (bad-size)
[301.626470] Subtest bad-size: SKIP (0.000s)
[301.694083] [085/156] (721s left) tools_test (sysfs_l3_parity)
[301.744266] Starting subtest: sysfs_l3_parity
[301.815382] Subtest sysfs_l3_parity: SKIP (0.079s)
[301.872487] [086/156] (721s left) perf_pmu (semaphore-wait)
[301.912443] Starting subtest: semaphore-wait
[301.914787] Starting dynamic subtest: rcs0
[302.427373] Dynamic subtest rcs0: SUCCESS (0.513s)
[302.440549] Starting dynamic subtest: bcs0
[302.942270] Dynamic subtest bcs0: SUCCESS (0.512s)
[302.955677] Starting dynamic subtest: vcs0
[303.456569] Dynamic subtest vcs0: SUCCESS (0.512s)
[303.470047] Starting dynamic subtest: vcs1
[303.972550] Dynamic subtest vcs1: SUCCESS (0.513s)
[303.986208] Starting dynamic subtest: vecs0
[304.489389] Dynamic subtest vecs0: SUCCESS (0.514s)
[304.502993] Starting dynamic subtest: ccs0
[305.004091] Dynamic subtest ccs0: SUCCESS (0.512s)
[305.006939] Subtest semaphore-wait: SUCCESS (3.090s)
[306.326215] [087/156] (717s left) gem_ctx_persistence (heartbeat-hang)
[306.385232] Starting subtest: heartbeat-hang
[306.389953] Subtest heartbeat-hang: SKIP (0.000s)
[306.481151] [088/156] (716s left) drm_read (empty-nonblock)
[306.607215] Starting subtest: empty-nonblock
[306.609548] Subtest empty-nonblock: SUCCESS (0.000s)
[306.733902] [089/156] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[306.812423] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[306.816305] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[306.911908] [090/156] (716s left) syncobj_timeline (reset-during-wait-for-submit)
[306.964441] Starting subtest: reset-during-wait-for-submit
[307.066675] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[307.140920] [091/156] (716s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[307.214403] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[307.216818] Starting dynamic subtest: pipe-A-default-mode
[308.417130] Dynamic subtest pipe-A-default-mode: SKIP (1.200s)
[308.421296] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.201s)
[308.599282] [092/156] (714s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[308.966058] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[309.793625] [093/156] (713s left) gem_render_copy_redux (flink-interruptible)
[309.848771] Starting subtest: flink-interruptible
[310.610828] Subtest flink-interruptible: SUCCESS (0.762s)
[310.718622] [094/156] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[310.799480] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[310.803058] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[310.888998] [095/156] (712s left) perf (sysctl-defaults)
[310.947039] Starting subtest: sysctl-defaults
[310.949217] Subtest sysctl-defaults: SUCCESS (0.000s)
[311.007632] [096/156] (712s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[311.088484] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[311.091984] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[311.185943] [097/156] (712s left) kms_content_protection (atomic-hdcp14)
[311.307700] Starting subtest: atomic-hdcp14
[311.311508] Subtest atomic-hdcp14: SKIP (0.000s)
[311.422238] [098/156] (712s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[311.496359] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[313.991698] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.499s)
[315.203058] [099/156] (708s left) kms_cursor_crc (cursor-offscreen-64x21)
[315.366782] Starting subtest: cursor-offscreen-64x21
[315.412591] Subtest cursor-offscreen-64x21: SKIP (0.041s)
[315.642654] [100/156] (708s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[315.741296] Starting subtest: 2x-long-cursor-vs-flip-atomic
[315.745921] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[315.881150] [101/156] (708s left) syncobj_basic (bad-flags-fd-to-handle)
[315.932778] Starting subtest: bad-flags-fd-to-handle
[315.935027] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[316.044586] [102/156] (707s left) gem_fence_thrash (bo-write-verify-x)
[316.080342] Starting subtest: bo-write-verify-x
[316.097944] Subtest bo-write-verify-x: SKIP (0.018s)
[316.154774] [103/156] (707s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[316.239496] Starting subtest: 4-tiled-16bpp-rotate-0
[317.585773] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.346s)
[317.695486] [104/156] (706s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[317.784121] Starting subtest: x-tiled-64bpp-rotate-90
[317.803712] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[317.929451] [105/156] (706s left) syncobj_basic (bad-handle-to-fd)
[317.986786] Starting subtest: bad-handle-to-fd
[317.988689] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[318.097801] [106/156] (706s left) gem_lmem_swapping (parallel-multi)
[318.137186] Subtest parallel-multi: SKIP (0.000s)
[318.180538] [107/156] (705s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[318.264051] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[318.269647] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[318.371822] [108/156] (705s left) kms_atomic_transition (plane-all-transition)
[318.445559] Starting subtest: plane-all-transition
[318.447506] Starting dynamic subtest: pipe-A-eDP-1
[320.939079] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[321.246667] Starting dynamic subtest: pipe-B-eDP-1
[324.514652] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.278s)
[324.817564] Subtest plane-all-transition: SUCCESS (6.370s)
[325.635517] [109/156] (698s left) gen3_render_mixed_blits
[325.758985] [110/156] (698s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[325.834431] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[325.836861] Starting dynamic subtest: pipe-A-eDP-1
[326.274299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[326.287451] Starting dynamic subtest: pipe-B-eDP-1
[327.683716] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[327.695991] Starting dynamic subtest: pipe-C-eDP-1
[329.090196] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[329.101423] Starting dynamic subtest: pipe-D-eDP-1
[330.480491] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.389s)
[330.482516] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.620s)
[331.662699] [111/156] (692s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[331.761052] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[331.763407] Starting dynamic subtest: pipe-A-eDP-1
[331.844570] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[331.857671] Starting dynamic subtest: pipe-B-eDP-1
[333.040357] Dynamic subtest pipe-B-eDP-1: SKIP (1.195s)
[333.044747] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.285s)
[334.332199] [112/156] (690s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc)
[334.426269] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc
[334.430572] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[334.524558] [113/156] (689s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[334.603102] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[334.607090] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[334.719227] [114/156] (689s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[334.805138] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[342.115665] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.314s)
[342.224321] [115/156] (682s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-gtt)
[342.311616] Starting subtest: fbchdr-rgb565-draw-mmap-gtt
[342.315982] Subtest fbchdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[342.398151] [116/156] (682s left) vgem_basic (sysfs)
[342.442367] Starting subtest: sysfs
[342.444331] Subtest sysfs: SUCCESS (0.000s)
[342.495235] [117/156] (682s left) i915_drm_fdinfo (virtual-busy)
[342.530749] Starting subtest: virtual-busy
[342.535052] Subtest virtual-busy: SKIP (0.000s)
[342.595871] [118/156] (682s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-onoff)
[342.672160] Starting subtest: hdr-2p-primscrn-spr-indfb-onoff
[342.676505] Subtest hdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[342.764942] [119/156] (681s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[342.841864] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[346.859504] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.024s)
[348.047218] [120/156] (676s left) gem_exec_balancer (nohangcheck)
[348.317560] Starting subtest: nohangcheck
[349.225501] Subtest nohangcheck: SUCCESS (0.910s)
[349.347868] [121/156] (675s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[349.407199] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[349.514784] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[349.603013] [122/156] (675s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[349.653479] Starting subtest: wait-all-for-submit-delayed-submit
[349.755892] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[349.837064] [123/156] (674s left) perf (per-context-mode-unprivileged)
[349.930467] Starting subtest: per-context-mode-unprivileged
[349.935223] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[349.977589] [124/156] (674s left) gem_exec_schedule (deep)
[350.159513] Starting subtest: deep
[350.162091] Starting dynamic subtest: rcs0
[356.514534] Dynamic subtest rcs0: SKIP (6.351s)
[356.526570] Starting dynamic subtest: vcs0
[367.058108] Dynamic subtest vcs0: SUCCESS (10.545s)
[367.071683] Starting dynamic subtest: vcs1
[377.927863] Dynamic subtest vcs1: SUCCESS (10.868s)
[377.939091] Starting dynamic subtest: vecs0
[388.815590] Dynamic subtest vecs0: SUCCESS (10.886s)
[388.830530] Starting dynamic subtest: ccs0
[400.672762] Dynamic subtest ccs0: SUCCESS (11.855s)
[400.675589] Subtest deep: SUCCESS (50.511s)
[402.496839] [125/156] (622s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[402.592182] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[402.596431] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[402.671341] [126/156] (622s left) kms_pm_lpsp (screens-disabled)
[403.750637] Starting subtest: screens-disabled
[403.755086] Subtest screens-disabled: SKIP (0.000s)
[403.831846] [127/156] (621s left) kms_psr (psr-primary-mmap-gtt)
[403.896065] Starting subtest: psr-primary-mmap-gtt
[403.898276] Starting dynamic subtest: eDP-1
[405.326587] Dynamic subtest eDP-1: SKIP (1.427s)
[405.331632] Subtest psr-primary-mmap-gtt: SKIP (1.429s)
[405.461385] [128/156] (619s left) kms_psr (psr2-cursor-plane-onoff)
[405.532661] Starting subtest: psr2-cursor-plane-onoff
[405.534963] Starting dynamic subtest: eDP-1
[407.234802] Dynamic subtest eDP-1: SUCCESS (1.702s)
[407.237224] Subtest psr2-cursor-plane-onoff: SUCCESS (1.703s)
[408.128427] [129/156] (616s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[408.214728] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[408.217098] Starting dynamic subtest: pipe-A-eDP-1
[414.890020] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.679s)
[414.905264] Starting dynamic subtest: pipe-B-eDP-1
[421.943987] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.050s)
[421.946488] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.733s)
[422.818917] [130/156] (602s left) api_intel_bb (simple-bb-ctx)
[422.878341] Starting subtest: simple-bb-ctx
[422.885925] Subtest simple-bb-ctx: SUCCESS (0.008s)
[423.022371] [131/156] (602s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[423.108618] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[423.113416] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[423.178412] [132/156] (602s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[423.264703] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[423.269045] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[423.373953] [133/156] (601s left) kms_psr (fbc-psr2-primary-blt)
[423.448451] Starting subtest: fbc-psr2-primary-blt
[423.450844] Starting dynamic subtest: eDP-1
[423.455703] Dynamic subtest eDP-1: SKIP (0.000s)
[423.460057] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[423.523360] [134/156] (601s left) gen9_exec_parse (batch-invalid-length)
[423.579442] Subtest batch-invalid-length: SKIP (0.000s)
[423.651155] [135/156] (601s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[423.749400] Starting subtest: basic-flip-after-cursor-varying-size
[424.691251] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.940s)
[425.542951] [136/156] (599s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[425.625187] Starting subtest: y-tiled-8bpp-rotate-270
[425.629866] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[425.727343] [137/156] (599s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[425.810165] Starting subtest: 4-tiled-32bpp-rotate-270
[425.829379] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s)
[425.949682] [138/156] (599s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[426.033593] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[426.037767] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[426.135433] [139/156] (599s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[426.217666] Starting subtest: fbc-tiling-linear
[429.941968] Subtest fbc-tiling-linear: SUCCESS (3.730s)
[431.153667] [140/156] (594s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[431.251175] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[431.255769] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[431.346847] [141/156] (594s left) kms_plane_scaling (planes-downscale-factor-0-5)
[431.435092] Starting subtest: planes-downscale-factor-0-5
[431.437682] Starting dynamic subtest: pipe-A
[431.458191] Dynamic subtest pipe-A: SKIP (0.018s)
[431.469190] Starting dynamic subtest: pipe-B
[431.489830] Dynamic subtest pipe-B: SKIP (0.030s)
[431.500167] Starting dynamic subtest: pipe-C
[431.520687] Dynamic subtest pipe-C: SKIP (0.031s)
[431.530887] Starting dynamic subtest: pipe-D
[431.551411] Dynamic subtest pipe-D: SKIP (0.031s)
[431.555096] Subtest planes-downscale-factor-0-5: SKIP (0.113s)
[431.654282] [142/156] (593s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[431.738511] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[431.742576] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[431.827597] [143/156] (593s left) i915_selftest (mock)
[436.504817] Starting subtest: mock
[436.510912] Starting dynamic subtest: sanitycheck
[437.196429] Dynamic subtest sanitycheck: SUCCESS (0.691s)
[437.206209] Starting dynamic subtest: shmem
[437.853545] Dynamic subtest shmem: SUCCESS (0.654s)
[437.866047] Starting dynamic subtest: fence
[445.386618] Dynamic subtest fence: SUCCESS (7.529s)
[445.397620] Starting dynamic subtest: scatterlist
[447.050974] Dynamic subtest scatterlist: SUCCESS (1.663s)
[447.060472] Starting dynamic subtest: syncmap
[450.231489] Dynamic subtest syncmap: SUCCESS (3.177s)
[450.241843] Starting dynamic subtest: uncore
[450.898453] Dynamic subtest uncore: SUCCESS (0.665s)
[450.909437] Starting dynamic subtest: ring
[451.584311] Dynamic subtest ring: SUCCESS (0.684s)
[451.594970] Starting dynamic subtest: engine
[452.254215] Dynamic subtest engine: SUCCESS (0.668s)
[452.264829] Starting dynamic subtest: timelines
[456.010924] Dynamic subtest timelines: SUCCESS (3.754s)
[456.021925] Starting dynamic subtest: requests
[460.520043] Dynamic subtest requests: SUCCESS (4.507s)
[460.530533] Starting dynamic subtest: objects
[461.306573] Dynamic subtest objects: SUCCESS (0.785s)
[461.316569] Starting dynamic subtest: phys
[462.055237] Dynamic subtest phys: SUCCESS (0.747s)
[462.072270] Starting dynamic subtest: dmabuf
[462.846210] Dynamic subtest dmabuf: SUCCESS (0.789s)
[462.854931] Starting dynamic subtest: vma
[468.444048] Dynamic subtest vma: SUCCESS (5.594s)
[468.452581] Starting dynamic subtest: evict
[469.806636] Dynamic subtest evict: SUCCESS (1.361s)
[469.819735] Starting dynamic subtest: gtt
[473.407242] Dynamic subtest gtt: SUCCESS (3.599s)
[473.417043] Starting dynamic subtest: hugepages
[474.279930] Dynamic subtest hugepages: SUCCESS (0.871s)
[474.289717] Starting dynamic subtest: memory_region
[476.805117] Dynamic subtest memory_region: SUCCESS (2.523s)
[476.807689] Subtest mock: SUCCESS (40.300s)
[476.836951] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[476.837674] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[476.840724] [144/156] (548s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)
[478.378758] Starting subtest: hdr-rgb565-draw-mmap-cpu
[478.383151] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[478.494139] [FACT kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[478.495222] [FACT kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[478.498972] [145/156] (547s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[478.588281] Starting subtest: yf-tiled-64bpp-rotate-90
[478.592512] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[478.681916] [146/156] (547s left) kms_psr (psr-primary-page-flip)
[478.758244] Starting subtest: psr-primary-page-flip
[478.760502] Starting dynamic subtest: eDP-1
[480.514961] Dynamic subtest eDP-1: SUCCESS (1.757s)
[480.517387] Subtest psr-primary-page-flip: SUCCESS (1.758s)
[481.398488] [147/156] (544s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[481.480440] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[481.484397] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[481.588986] [148/156] (544s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[481.667576] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[481.671965] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[481.775688] [149/156] (544s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[481.835496] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[481.839690] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[482.014830] [150/156] (543s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[482.089225] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[482.091492] Starting dynamic subtest: pipe-A-eDP-1
[482.113895] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[482.125577] Starting dynamic subtest: pipe-B-eDP-1
[482.147100] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[482.155949] Starting dynamic subtest: pipe-C-eDP-1
[482.177441] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[482.185603] Starting dynamic subtest: pipe-D-eDP-1
[482.207778] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[482.212211] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[484.348186] [151/156] (541s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[484.429841] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[484.434056] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[484.529380] [152/156] (541s left) gem_exec_schedule (implicit-write-read)
[484.591693] Starting subtest: implicit-write-read
[484.594104] Starting dynamic subtest: rcs0
[484.687890] Dynamic subtest rcs0: SUCCESS (0.104s)
[484.700703] Starting dynamic subtest: vcs0
[484.766784] Dynamic subtest vcs0: SUCCESS (0.078s)
[484.777742] Starting dynamic subtest: vcs1
[484.847087] Dynamic subtest vcs1: SUCCESS (0.080s)
[484.857264] Starting dynamic subtest: vecs0
[484.924072] Dynamic subtest vecs0: SUCCESS (0.075s)
[484.938675] Starting dynamic subtest: ccs0
[485.005638] Dynamic subtest ccs0: SUCCESS (0.082s)
[485.007983] Subtest implicit-write-read: SUCCESS (0.423s)
[486.308495] [153/156] (539s left) syncobj_timeline (invalid-signal-illegal-point)
[486.358489] Starting subtest: invalid-signal-illegal-point
[486.360912] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[486.462752] [154/156] (539s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[486.544748] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[493.918640] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.380s)
[494.033816] [155/156] (532s left) i915_pm_rps (reset)
[494.108979] Starting subtest: reset
[502.804711] Subtest reset: SUCCESS (8.690s)
[502.908138] [156/156] (523s left) syncobj_basic (test-valid-cycle)
[502.967543] Starting subtest: test-valid-cycle
[502.969761] Subtest test-valid-cycle: SUCCESS (0.000s)
[503.060554] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_chamelium_audio
results: parsing output: 2/ for test: sw_sync
results: parsing output: 3/ for test: gem_reg_read
results: parsing output: 4/ for test: kms_joiner
results: parsing output: 5/ for test: prime_busy
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: gem_fence_thrash
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: prime_vgem
results: parsing output: 13/ for test: kms_dirtyfb
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: dumb_buffer
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: gem_busy
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: core_auth
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_chamelium_frames
results: parsing output: 43/ for test: gem_barrier_race
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ctx_shared
results: parsing output: 51/ for test: kms_universal_plane
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_vrr
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_plane_cursor
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_edge_walk
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_compute
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_mmap_offset
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_feature_discovery
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: kms_invalid_mode
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: i915_pm_freq_mult
results: parsing output: 74/ for test: template
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: api_intel_allocator
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: tools_test
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: drm_read
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: kms_chamelium_hpd
results: parsing output: 92/ for test: gem_render_copy_redux
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: gem_fence_thrash
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_atomic_transition
results: parsing output: 108/ for test: gen3_render_mixed_blits
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_psr2_sf
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: kms_frontbuffer_tracking
results: parsing output: 115/ for test: vgem_basic
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_pm_lpsp
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: api_intel_bb
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr
results: parsing output: 133/ for test: gen9_exec_parse
results: parsing output: 134/ for test: kms_cursor_legacy
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_plane_scaling
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: i915_selftest
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_psr
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_render_copy
results: parsing output: 149/ for test: kms_ccs
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_exec_schedule
results: parsing output: 152/ for test: syncobj_timeline
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: i915_pm_rps
results: parsing output: 155/ for test: syncobj_basic
Done.