[77.694730] Initializing watchdogs
[77.694774]   /dev/watchdog0
[77.708358] [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]
[77.712563] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[77.714791] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[77.718126] [001/131] (960s left) gem_exec_schedule (smoketest)
[77.920500] Starting subtest: smoketest
[77.922715] Starting dynamic subtest: rcs0
[83.473741] Dynamic subtest rcs0: SUCCESS (5.498s)
[83.485938] Starting dynamic subtest: bcs0
[88.978153] Dynamic subtest bcs0: SUCCESS (5.497s)
[88.990861] Starting dynamic subtest: vcs0
[94.464797] Dynamic subtest vcs0: SUCCESS (5.487s)
[94.476360] Starting dynamic subtest: vcs1
[99.946835] Dynamic subtest vcs1: SUCCESS (5.486s)
[99.955035] Starting dynamic subtest: vecs0
[105.439085] Dynamic subtest vecs0: SUCCESS (5.485s)
[105.451139] Starting dynamic subtest: ccs0
[110.929321] Dynamic subtest ccs0: SUCCESS (5.491s)
[110.931692] Subtest smoketest: SUCCESS (32.947s)
[111.122262] [002/131] (927s left) gem_wait (write-wait)
[111.198391] Starting subtest: write-wait
[111.200857] Starting dynamic subtest: all-engines
[112.432413] Dynamic subtest all-engines: SUCCESS (1.233s)
[112.447450] Starting dynamic subtest: rcs0
[113.492475] Dynamic subtest rcs0: SUCCESS (1.060s)
[113.507946] Starting dynamic subtest: bcs0
[114.554657] Dynamic subtest bcs0: SUCCESS (1.060s)
[114.569218] Starting dynamic subtest: vcs0
[115.605490] Dynamic subtest vcs0: SUCCESS (1.050s)
[115.618855] Starting dynamic subtest: vcs1
[116.657478] Dynamic subtest vcs1: SUCCESS (1.051s)
[116.670386] Starting dynamic subtest: vecs0
[117.712179] Dynamic subtest vecs0: SUCCESS (1.054s)
[117.726371] Starting dynamic subtest: ccs0
[118.769502] Dynamic subtest ccs0: SUCCESS (1.056s)
[118.772123] Subtest write-wait: SUCCESS (7.571s)
[118.977784] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[118.980983] [003/131] (919s left) gem_exec_balancer (sliced)
[119.048095] Starting subtest: sliced
[119.052631] Subtest sliced: SKIP (0.000s)
[119.391196] [004/131] (918s left) gem_mmap_offset (close-race)
[119.439697] Starting subtest: close-race
[139.538397] Subtest close-race: SUCCESS (20.098s)
[139.669674] [005/131] (898s left) gem_exec_reloc (basic-gtt-noreloc)
[139.729051] Subtest basic-gtt-noreloc: SKIP (0.000s)
[139.821704] [006/131] (898s left) gem_cs_tlb (engines)
[139.883496] Starting subtest: engines
[139.885540] Starting dynamic subtest: rcs0
[142.037670] Dynamic subtest rcs0: SUCCESS (2.153s)
[142.045078] Starting dynamic subtest: bcs0
[144.193028] Dynamic subtest bcs0: SUCCESS (2.154s)
[144.202868] Starting dynamic subtest: vcs0
[146.346524] Dynamic subtest vcs0: SUCCESS (2.152s)
[146.356317] Starting dynamic subtest: vcs1
[148.497591] Dynamic subtest vcs1: SUCCESS (2.152s)
[148.505328] Starting dynamic subtest: vecs0
[150.648747] Dynamic subtest vecs0: SUCCESS (2.151s)
[150.658328] Starting dynamic subtest: ccs0
[152.801246] Dynamic subtest ccs0: SUCCESS (2.153s)
[152.803985] Subtest engines: SUCCESS (12.916s)
[152.933922] [007/131] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[153.028629] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[153.032793] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[153.162247] [008/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[153.258710] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[153.261013] Starting dynamic subtest: pipe-A-default-mode
[153.552542] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[153.557735] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.293s)
[154.434967] [009/131] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[154.539903] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[154.544048] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[154.678275] [010/131] (883s left) gem_userptr_blits (unsync-overlap)
[154.742555] Subtest unsync-overlap: SKIP (0.000s)
[154.884186] [011/131] (883s left) kms_color (ctm-red-to-blue)
[154.978898] Starting subtest: ctm-red-to-blue
[154.981267] Starting dynamic subtest: pipe-A-eDP-1
[155.696661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[155.703598] Starting dynamic subtest: pipe-B-eDP-1
[157.121848] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[157.133764] Starting dynamic subtest: pipe-C-eDP-1
[158.507513] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[158.516835] Starting dynamic subtest: pipe-D-eDP-1
[159.830730] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[159.833070] Subtest ctm-red-to-blue: SUCCESS (4.853s)
[160.661885] [012/131] (877s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[160.771996] Starting subtest: 2x-flip-vs-cursor-legacy
[160.776463] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[160.940896] [013/131] (877s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[161.042182] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[161.046173] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[161.170948] [014/131] (877s left) gem_render_copy_redux (flink-interruptible)
[161.230611] Starting subtest: flink-interruptible
[161.957192] Subtest flink-interruptible: SUCCESS (0.727s)
[162.126818] [015/131] (876s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[162.221148] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[162.223226] Starting dynamic subtest: pipe-A-eDP-1
[162.242882] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[162.252095] Starting dynamic subtest: pipe-B-eDP-1
[162.269921] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.276802] Starting dynamic subtest: pipe-C-eDP-1
[162.294609] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.301638] Starting dynamic subtest: pipe-D-eDP-1
[162.319804] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.323418] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[164.409906] [016/131] (874s left) gem_ctx_param (invalid-size-set)
[164.460466] Starting subtest: invalid-size-set
[164.462783] Subtest invalid-size-set: SUCCESS (0.001s)
[164.579734] [017/131] (874s left) syncobj_wait (multi-wait-all-submitted-signaled)
[164.631588] Starting subtest: multi-wait-all-submitted-signaled
[164.738376] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[164.822690] [018/131] (874s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[164.917343] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[164.919522] Starting dynamic subtest: pipe-A
[164.938062] Dynamic subtest pipe-A: SKIP (0.017s)
[164.945724] Starting dynamic subtest: pipe-B
[164.968887] Dynamic subtest pipe-B: SKIP (0.030s)
[164.976316] Starting dynamic subtest: pipe-C
[164.998740] Dynamic subtest pipe-C: SKIP (0.029s)
[165.006086] Starting dynamic subtest: pipe-D
[165.027982] Dynamic subtest pipe-D: SKIP (0.030s)
[165.031828] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.107s)
[165.140279] [019/131] (873s left) drm_read (invalid-buffer)
[165.306728] Starting subtest: invalid-buffer
[165.309294] Subtest invalid-buffer: SUCCESS (0.000s)
[165.446393] [020/131] (873s left) prime_vgem (basic-blt)
[165.534890] Starting subtest: basic-blt
[165.569839] Subtest basic-blt: SUCCESS (0.035s)
[165.728348] [021/131] (873s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[165.787062] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[165.861680] [022/131] (873s left) kms_psr (psr-cursor-mmap-gtt)
[165.945900] Starting subtest: psr-cursor-mmap-gtt
[165.947838] Starting dynamic subtest: eDP-1
[167.690050] Dynamic subtest eDP-1: SUCCESS (1.745s)
[167.692367] Subtest psr-cursor-mmap-gtt: SUCCESS (1.746s)
[168.584402] [023/131] (870s left) gem_exec_schedule (independent)
[168.659404] Starting subtest: independent
[168.661649] Starting dynamic subtest: rcs0
[169.941218] Dynamic subtest rcs0: SUCCESS (1.290s)
[169.952659] Starting dynamic subtest: vcs0
[171.969854] Dynamic subtest vcs0: SUCCESS (2.027s)
[171.981373] Starting dynamic subtest: vcs1
[173.921067] Dynamic subtest vcs1: SUCCESS (1.951s)
[173.929879] Starting dynamic subtest: vecs0
[175.894537] Dynamic subtest vecs0: SUCCESS (1.972s)
[175.906041] Starting dynamic subtest: ccs0
[177.878944] Dynamic subtest ccs0: SUCCESS (1.983s)
[177.882056] Subtest independent: SUCCESS (9.228s)
[178.186791] [024/131] (860s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[178.285153] Starting subtest: psr-rgb101010-draw-pwrite
[185.768774] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.486s)
[185.927403] [025/131] (853s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[186.102717] Starting subtest: cursor-rapid-movement-64x64
[186.105081] Starting dynamic subtest: pipe-A-eDP-1
[186.647074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[186.674697] Starting dynamic subtest: pipe-D-eDP-1
[187.844160] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.173s)
[187.846120] Subtest cursor-rapid-movement-64x64: SUCCESS (1.741s)
[188.706636] [026/131] (850s left) gem_userptr_blits (map-fixed-invalidate-busy)
[188.781281] Starting subtest: map-fixed-invalidate-busy
[188.785321] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[188.937194] [027/131] (850s left) i915_suspend (fence-restore-untiled)
[188.993748] Starting subtest: fence-restore-untiled
[188.997707] Subtest fence-restore-untiled: SKIP (0.000s)
[189.110762] [028/131] (850s left) api_intel_allocator (reopen-fork)
[189.174094] Starting subtest: reopen-fork
[192.563796] Subtest reopen-fork: SUCCESS (3.389s)
[192.657856] [029/131] (846s left) i915_pm_rps (min-max-config-loaded)
[192.717083] Starting subtest: min-max-config-loaded
[192.721766] Subtest min-max-config-loaded: SKIP (0.001s)
[192.849958] [030/131] (846s left) gem_eio (wait-wedge-1us)
[193.082598] Starting subtest: wait-wedge-1us
[194.982089] Subtest wait-wedge-1us: SUCCESS (1.901s)
[195.153241] [031/131] (844s left) gem_userptr_blits (sync-overlap)
[195.227301] Starting subtest: sync-overlap
[195.229479] Subtest sync-overlap: SUCCESS (0.000s)
[195.385941] [032/131] (844s left) prime_udl
[195.460757] [033/131] (843s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[195.552358] Starting subtest: y-tiled-32bpp-rotate-180
[195.556609] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[195.692373] [034/131] (843s left) gen3_mixed_blits
[195.819296] [035/131] (843s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[195.937151] Starting subtest: flip-vs-cursor-atomic
[202.921618] Subtest flip-vs-cursor-atomic: SUCCESS (6.983s)
[203.756379] [036/131] (835s left) i915_drm_fdinfo (virtual-busy-hang)
[203.790637] Starting subtest: virtual-busy-hang
[203.795210] Subtest virtual-busy-hang: SKIP (0.000s)
[203.873097] [037/131] (835s left) kms_debugfs (display-off-read-all)
[203.962704] Starting subtest: display-off-read-all
[204.250127] Subtest display-off-read-all: SUCCESS (0.289s)
[205.072510] [038/131] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[205.174045] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[212.044579] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.872s)
[212.192335] [039/131] (827s left) gem_exec_parallel (engines)
[212.262123] Starting subtest: engines
[212.264571] Starting dynamic subtest: basic
[213.937597] Dynamic subtest basic: SUCCESS (1.674s)
[213.948342] Starting dynamic subtest: contexts
[218.313158] Dynamic subtest contexts: SUCCESS (4.375s)
[218.322339] Starting dynamic subtest: fds
[222.110308] Dynamic subtest fds: SUCCESS (3.795s)
[222.122113] Starting dynamic subtest: userptr
[223.944822] Dynamic subtest userptr: SUCCESS (1.833s)
[223.947821] Subtest engines: SUCCESS (11.681s)
[224.144589] [040/131] (815s left) gem_lmem_swapping (verify)
[224.190259] Subtest verify: SKIP (0.000s)
[224.232894] [041/131] (815s left) gem_busy (busy)
[224.292536] Starting subtest: busy
[224.294876] Starting dynamic subtest: all-engines
[224.371044] Dynamic subtest all-engines: SUCCESS (0.078s)
[224.380387] Starting dynamic subtest: rcs0
[225.887754] Dynamic subtest rcs0: SUCCESS (1.515s)
[225.898430] Starting dynamic subtest: bcs0
[225.955396] Dynamic subtest bcs0: SUCCESS (0.066s)
[225.965397] Starting dynamic subtest: vcs0
[225.994831] Dynamic subtest vcs0: SUCCESS (0.039s)
[226.002789] Starting dynamic subtest: vcs1
[227.933780] Dynamic subtest vcs1: SUCCESS (1.936s)
[227.943948] Starting dynamic subtest: vecs0
[229.917966] Dynamic subtest vecs0: SUCCESS (1.983s)
[229.928456] Starting dynamic subtest: ccs0
[231.899752] Dynamic subtest ccs0: SUCCESS (1.981s)
[231.902191] Subtest busy: SUCCESS (7.604s)
[232.284083] [042/131] (807s left) gem_ctx_persistence (process)
[232.342292] Starting subtest: process
[232.586433] Subtest process: SUCCESS (0.244s)
[232.691977] [043/131] (807s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[233.090811] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[233.880165] [044/131] (806s left) kms_flip (2x-flip-vs-wf_vblank)
[233.970273] Starting subtest: 2x-flip-vs-wf_vblank
[233.981071] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[234.108507] [045/131] (805s left) kms_cursor_crc (cursor-offscreen-256x256)
[234.354177] Starting subtest: cursor-offscreen-256x256
[234.356639] Starting dynamic subtest: pipe-A-eDP-1
[236.288934] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[236.319264] Starting dynamic subtest: pipe-D-eDP-1
[238.916416] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.604s)
[238.918299] Subtest cursor-offscreen-256x256: SUCCESS (4.562s)
[239.773602] [046/131] (800s left) syncobj_timeline (host-signal-points)
[239.828427] Starting subtest: host-signal-points
[239.830424] Subtest host-signal-points: SUCCESS (0.004s)
[239.935532] [047/131] (800s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[240.029565] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[240.031906] Starting dynamic subtest: A-eDP1
[248.911811] Dynamic subtest A-eDP1: SUCCESS (8.882s)
[248.922055] Starting dynamic subtest: B-eDP1
[257.841083] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[257.848696] Starting dynamic subtest: C-eDP1
[266.764849] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[266.775785] Starting dynamic subtest: D-eDP1
[275.689614] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[275.695919] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.665s)
[276.928904] [048/131] (763s left) gem_exec_gttfill (basic)
[276.992315] Starting subtest: basic
[279.638196] Subtest basic: SUCCESS (2.644s)
[279.851306] [049/131] (760s left) gem_pxp (fail-invalid-protected-context)
[280.011816] Starting subtest: fail-invalid-protected-context
[280.014312] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[280.128138] [050/131] (760s left) gen9_exec_parse (bb-start-param)
[280.189153] Subtest bb-start-param: SKIP (0.000s)
[280.274771] [051/131] (759s left) kms_dsc (dsc-with-bpc)
[280.364071] Starting subtest: dsc-with-bpc
[280.395327] Subtest dsc-with-bpc: SKIP (0.001s)
[280.443308] [052/131] (759s left) gem_eio (reset-stress)
[280.659310] Starting subtest: reset-stress
[280.661615] Starting dynamic subtest: render
[285.755789] Dynamic subtest render: SUCCESS (5.093s)
[285.771411] Starting dynamic subtest: bsd1
[303.473330] Dynamic subtest bsd1: SUCCESS (17.715s)
[303.493229] Starting dynamic subtest: bsd2
[321.484927] Dynamic subtest bsd2: SUCCESS (18.011s)
[321.500855] Starting dynamic subtest: blt
[321.505263] Dynamic subtest blt: SKIP (0.000s)
[321.513613] Starting dynamic subtest: vebox
[339.454348] Dynamic subtest vebox: SUCCESS (17.968s)
[339.456708] Subtest reset-stress: SUCCESS (58.791s)
[340.951453] [053/131] (699s left) perf (global-sseu-config-invalid)
[341.116535] Starting subtest: global-sseu-config-invalid
[341.120630] Subtest global-sseu-config-invalid: SKIP (0.000s)
[341.178532] [054/131] (699s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[341.278804] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[341.280639] Starting dynamic subtest: pipe-A-eDP-1
[341.723842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[341.734514] Starting dynamic subtest: pipe-B-eDP-1
[343.105091] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[343.116326] Starting dynamic subtest: pipe-C-eDP-1
[344.521718] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s)
[344.532786] Starting dynamic subtest: pipe-D-eDP-1
[345.846715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[345.848686] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.541s)
[347.062267] [055/131] (693s left) gem_softpin (allocator-nopin)
[347.118478] Starting subtest: allocator-nopin
[347.198706] Subtest allocator-nopin: SUCCESS (0.080s)
[347.364900] [056/131] (693s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[347.447935] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[347.450263] Starting dynamic subtest: pipe-A-eDP-1
[347.459362] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.467796] Starting dynamic subtest: pipe-B-eDP-1
[347.476727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.485061] Starting dynamic subtest: pipe-C-eDP-1
[347.493600] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[347.501651] Starting dynamic subtest: pipe-D-eDP-1
[347.510306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[347.514653] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[349.701373] [057/131] (690s left) gem_ppgtt (shrink-vs-evict-pinned)
[349.755436] Starting subtest: shrink-vs-evict-pinned
[355.899558] Subtest shrink-vs-evict-pinned: SUCCESS (6.141s)
[356.016452] [058/131] (684s left) kms_invalid_mode (zero-clock)
[356.126252] Starting subtest: zero-clock
[356.128528] Starting dynamic subtest: pipe-A-eDP-1
[356.412082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[356.421434] Starting dynamic subtest: pipe-B-eDP-1
[356.423751] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[356.432195] Starting dynamic subtest: pipe-C-eDP-1
[356.434526] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[356.442129] Starting dynamic subtest: pipe-D-eDP-1
[356.444049] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[356.446060] Subtest zero-clock: SUCCESS (0.289s)
[357.240144] [059/131] (683s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[357.348648] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[357.352947] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[357.482284] [060/131] (683s left) syncobj_timeline (invalid-signal-zero-handles)
[357.529202] Starting subtest: invalid-signal-zero-handles
[357.531088] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[357.639278] [061/131] (682s left) kms_frontbuffer_tracking (psr-2p-rte)
[357.731154] Starting subtest: psr-2p-rte
[357.735082] Subtest psr-2p-rte: SKIP (0.000s)
[357.864371] [062/131] (682s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[362.895107] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[362.897451] Starting dynamic subtest: pipe-A-eDP-1
[374.612876] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.714s)
[374.622917] Starting dynamic subtest: pipe-B-eDP-1
[386.342044] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.727s)
[386.344412] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.446s)
[387.213326] [063/131] (653s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[387.315506] Starting subtest: fbc-psr2-cursor-mmap-cpu
[387.317864] Starting dynamic subtest: eDP-1
[387.322309] Dynamic subtest eDP-1: SKIP (0.000s)
[387.326699] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[387.400490] [064/131] (653s left) gem_exec_balancer (bonded-true-hang)
[387.665650] Starting subtest: bonded-true-hang
[387.670393] Subtest bonded-true-hang: SKIP (0.000s)
[387.788774] [065/131] (652s left) gem_exec_reloc (basic-wc-active)
[387.856152] Subtest basic-wc-active: SKIP (0.000s)
[387.929684] [066/131] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[388.034080] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[388.038325] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[388.139879] [067/131] (652s left) kms_async_flips (test-time-stamp-atomic)
[388.246328] Starting subtest: test-time-stamp-atomic
[388.617395] Starting dynamic subtest: pipe-A-eDP-1
[389.876684] Dynamic subtest pipe-A-eDP-1: FAIL (0.779s)
[389.887656] Starting dynamic subtest: pipe-B-eDP-1
[390.778357] Dynamic subtest pipe-B-eDP-1: FAIL (0.740s)
[390.887458] Starting dynamic subtest: pipe-C-eDP-1
[391.655539] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[392.019211] Starting dynamic subtest: pipe-D-eDP-1
[392.784137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[392.786527] Subtest test-time-stamp-atomic: FAIL (4.537s)
[393.961333] [068/131] (646s left) kms_selftest (drm_cmdline_parser)
[394.000962] Starting subtest: drm_cmdline_parser
[394.023058] Starting dynamic subtest: drm_test_cmdline_force_d_only
[394.150319] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.126s)
[394.158623] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[394.279054] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.126s)
[394.289621] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[394.419391] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.139s)
[394.429286] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[394.565462] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.146s)
[394.575391] Starting dynamic subtest: drm_test_cmdline_force_e_only
[394.715792] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.148s)
[394.725639] Starting dynamic subtest: drm_test_cmdline_res
[394.849408] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.131s)
[394.859077] Starting dynamic subtest: drm_test_cmdline_res_vesa
[394.982163] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.131s)
[394.991973] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[395.120263] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.137s)
[395.129918] Starting dynamic subtest: drm_test_cmdline_res_rblank
[395.259440] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.138s)
[395.269331] Starting dynamic subtest: drm_test_cmdline_res_bpp
[395.372292] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.114s)
[395.382302] Starting dynamic subtest: drm_test_cmdline_res_refresh
[395.515273] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.141s)
[395.523414] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[395.630435] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.115s)
[395.638696] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[395.758803] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.128s)
[395.766517] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[395.882387] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.124s)
[395.890219] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[396.031214] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.148s)
[396.040778] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[396.169301] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.135s)
[396.179778] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[396.282564] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.114s)
[396.290809] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[396.408914] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.126s)
[396.417398] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[396.540902] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.128s)
[396.549090] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[396.688264] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.147s)
[396.696209] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[396.809793] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.121s)
[396.819342] Starting dynamic subtest: drm_test_cmdline_name
[396.955374] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.144s)
[396.963867] Starting dynamic subtest: drm_test_cmdline_name_bpp
[397.099220] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.143s)
[397.106994] Starting dynamic subtest: drm_test_cmdline_name_option
[397.243141] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.143s)
[397.251165] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[397.395303] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.151s)
[397.405530] Starting dynamic subtest: drm_test_cmdline_rotate_0
[397.546910] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.151s)
[397.556904] Starting dynamic subtest: drm_test_cmdline_rotate_90
[397.695101] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.149s)
[397.703108] Starting dynamic subtest: drm_test_cmdline_rotate_180
[397.838071] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.142s)
[397.845834] Starting dynamic subtest: drm_test_cmdline_rotate_270
[397.983317] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.144s)
[397.990991] Starting dynamic subtest: drm_test_cmdline_hmirror
[398.065481] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.082s)
[398.073525] Starting dynamic subtest: drm_test_cmdline_vmirror
[398.204838] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.138s)
[398.213097] Starting dynamic subtest: drm_test_cmdline_margin_options
[398.351149] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.146s)
[398.358901] Starting dynamic subtest: drm_test_cmdline_multiple_options
[398.481077] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.128s)
[398.489122] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[398.624045] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.143s)
[398.631821] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[398.763704] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.138s)
[398.771818] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[398.869433] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.106s)
[398.877567] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[399.004244] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.132s)
[399.014347] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[399.122552] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.117s)
[399.132719] Starting dynamic subtest: drm_test_cmdline_invalid
[399.260696] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.139s)
[399.268830] Starting dynamic subtest: drm_test_cmdline_tv_options
[399.439101] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.170s)
[399.443216] Subtest drm_cmdline_parser: SUCCESS (5.431s)
[399.668024] [069/131] (641s left) kms_vblank (query-busy-hang)
[399.772809] Starting subtest: query-busy-hang
[399.774916] Starting dynamic subtest: pipe-A-eDP-1
[426.654578] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.880s)
[426.669843] Starting dynamic subtest: pipe-D-eDP-1
[451.663640] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.005s)
[451.665960] Subtest query-busy-hang: SUCCESS (51.889s)
[452.518237] [070/131] (588s left) gem_exercise_blt (fast-copy)
[452.582301] Starting subtest: fast-copy
[452.584686] Starting dynamic subtest: linear-smem-smem
[452.605110] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[452.615978] Starting dynamic subtest: xmajor-smem-smem
[452.622235] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[452.630500] Starting dynamic subtest: tile4-smem-smem
[452.639307] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[452.647488] Starting dynamic subtest: tile64-smem-smem
[452.656792] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[452.659044] Subtest fast-copy: SUCCESS (0.075s)
[452.799292] [071/131] (588s left) gem_exec_flush (basic-wb-prw-default)
[452.851443] Starting subtest: basic-wb-prw-default
[458.308257] Subtest basic-wb-prw-default: SUCCESS (5.457s)
[458.509048] [072/131] (582s left) gem_tiled_fence_blits (basic)
[458.574560] Subtest basic: SKIP (0.000s)
[458.637456] [073/131] (582s left) sysfs_heartbeat_interval (precise)
[458.702359] Starting subtest: precise
[458.704655] Starting dynamic subtest: vecs0
[465.956420] Dynamic subtest vecs0: SUCCESS (7.253s)
[465.970942] Starting dynamic subtest: ccs0
[467.115780] Dynamic subtest ccs0: SUCCESS (1.156s)
[467.125794] Starting dynamic subtest: vcs0
[474.912042] Dynamic subtest vcs0: SUCCESS (7.792s)
[474.924374] Starting dynamic subtest: bcs0
[476.053568] Dynamic subtest bcs0: SUCCESS (1.141s)
[476.063965] Starting dynamic subtest: rcs0
[477.217979] Dynamic subtest rcs0: SUCCESS (1.163s)
[477.227771] Starting dynamic subtest: vcs1
[484.895087] Dynamic subtest vcs1: SUCCESS (7.672s)
[484.897521] Subtest precise: SUCCESS (26.190s)
[484.983270] [074/131] (556s left) kms_flip (2x-flip-vs-fences)
[485.085722] Starting subtest: 2x-flip-vs-fences
[485.090075] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[485.227260] [075/131] (555s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[490.271410] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[490.273756] Starting dynamic subtest: pipe-A-eDP-1
[491.046527] Dynamic subtest pipe-A-eDP-1: SKIP (0.770s)
[491.055592] Starting dynamic subtest: pipe-B-eDP-1
[492.188431] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[492.192689] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.915s)
[493.385147] [076/131] (547s left) kms_lease (simple-lease)
[493.481873] Starting subtest: simple-lease
[493.484147] Starting dynamic subtest: pipe-A-eDP-1
[494.007087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.526s)
[494.018476] Starting dynamic subtest: pipe-B-eDP-1
[495.420723] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[495.431425] Starting dynamic subtest: pipe-C-eDP-1
[496.818978] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[496.828601] Starting dynamic subtest: pipe-D-eDP-1
[498.235043] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.414s)
[498.237447] Subtest simple-lease: SUCCESS (4.753s)
[499.042700] [077/131] (542s left) gem_exec_schedule (u-submit-late-slice)
[499.106249] Starting subtest: u-submit-late-slice
[499.108150] Starting dynamic subtest: rcs0
[499.136743] Dynamic subtest rcs0: SUCCESS (0.036s)
[499.148162] Starting dynamic subtest: bcs0
[499.170265] Dynamic subtest bcs0: SUCCESS (0.033s)
[499.178912] Starting dynamic subtest: vcs0
[499.202055] Dynamic subtest vcs0: SUCCESS (0.031s)
[499.214067] Starting dynamic subtest: vcs1
[499.231221] Dynamic subtest vcs1: SUCCESS (0.029s)
[499.239812] Starting dynamic subtest: vecs0
[499.263863] Dynamic subtest vecs0: SUCCESS (0.032s)
[499.273831] Starting dynamic subtest: ccs0
[499.302459] Dynamic subtest ccs0: SUCCESS (0.038s)
[499.304628] Subtest u-submit-late-slice: SUCCESS (0.202s)
[501.006456] [078/131] (540s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[501.137446] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[501.141842] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[501.278483] [079/131] (540s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[501.360170] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[501.362579] Starting dynamic subtest: pipe-A-eDP-1
[501.385130] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[501.396127] Starting dynamic subtest: pipe-B-eDP-1
[501.417683] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[501.426252] Starting dynamic subtest: pipe-C-eDP-1
[501.448123] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[501.457414] Starting dynamic subtest: pipe-D-eDP-1
[501.479478] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[501.483884] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[503.535824] [080/131] (537s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[503.630481] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[504.467815] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[504.695860] [081/131] (536s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[504.799296] Starting subtest: 4-tiled-32bpp-rotate-180
[506.233998] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.434s)
[506.402885] [082/131] (535s left) kms_plane_multiple (tiling-yf)
[506.498052] Starting subtest: tiling-yf
[506.501730] Subtest tiling-yf: SKIP (0.000s)
[506.583509] [083/131] (534s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[506.678088] Starting subtest: async-flip-with-page-flip-events-linear
[507.068914] Starting dynamic subtest: pipe-A-eDP-1
[508.268591] Dynamic subtest pipe-A-eDP-1: FAIL (0.734s)
[508.279029] Starting dynamic subtest: pipe-B-eDP-1
[509.205615] Dynamic subtest pipe-B-eDP-1: FAIL (0.743s)
[509.320642] Starting dynamic subtest: pipe-C-eDP-1
[512.065903] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.750s)
[512.426104] Starting dynamic subtest: pipe-D-eDP-1
[515.191946] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[515.194221] Subtest async-flip-with-page-flip-events-linear: FAIL (8.515s)
[516.388163] [084/131] (525s left) kms_lease (possible-crtcs-filtering)
[516.488549] Starting subtest: possible-crtcs-filtering
[516.493097] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[516.642716] [085/131] (524s left) gem_userptr_blits (coherency-sync)
[516.725284] Starting subtest: coherency-sync
[516.916615] Subtest coherency-sync: SKIP (0.156s)
[517.026116] [086/131] (524s left) gem_userptr_blits (map-fixed-invalidate)
[517.129864] Starting subtest: map-fixed-invalidate
[517.134531] Subtest map-fixed-invalidate: SKIP (0.000s)
[517.298528] [087/131] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[517.415495] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[523.936354] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.522s)
[524.108578] [088/131] (517s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[524.219807] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[524.222090] Starting dynamic subtest: pipe-A
[524.240070] Dynamic subtest pipe-A: SKIP (0.017s)
[524.249068] Starting dynamic subtest: pipe-B
[524.270087] Dynamic subtest pipe-B: SKIP (0.029s)
[524.279302] Starting dynamic subtest: pipe-C
[524.300075] Dynamic subtest pipe-C: SKIP (0.029s)
[524.308830] Starting dynamic subtest: pipe-D
[524.329112] Dynamic subtest pipe-D: SKIP (0.029s)
[524.333209] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.106s)
[524.461532] [089/131] (517s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[524.526741] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[524.633839] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[524.723866] [090/131] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[524.810505] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[532.024368] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.216s)
[532.194221] [091/131] (509s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[532.251590] Starting subtest: single-wait-all-for-submit-available-submitted
[532.253574] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[532.371546] [092/131] (509s left) kms_flip (flip-vs-suspend-interruptible)
[532.473250] Starting subtest: flip-vs-suspend-interruptible
[532.475362] Starting dynamic subtest: A-eDP1
[582.011312] Dynamic subtest A-eDP1: SUCCESS (5.348s)
[582.026916] Starting dynamic subtest: B-eDP1
[631.013832] Dynamic subtest B-eDP1: SUCCESS (4.350s)
[631.024400] Starting dynamic subtest: C-eDP1
[680.012663] Dynamic subtest C-eDP1: SUCCESS (4.356s)
[680.026210] Starting dynamic subtest: D-eDP1
[729.030394] Dynamic subtest D-eDP1: SUCCESS (4.387s)
[729.033621] Subtest flip-vs-suspend-interruptible: SUCCESS (18.452s)
[730.281247] [093/131] (311s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[730.384515] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[730.387326] Starting dynamic subtest: pipe-A-eDP-1
[730.417494] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[730.428486] Starting dynamic subtest: pipe-B-eDP-1
[730.458404] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[730.468660] Starting dynamic subtest: pipe-C-eDP-1
[730.497522] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[730.508258] Starting dynamic subtest: pipe-D-eDP-1
[730.539383] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[730.544623] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[732.682179] [094/131] (309s left) kms_psr (fbc-pr-cursor-plane-move)
[732.780921] Starting subtest: fbc-pr-cursor-plane-move
[732.786484] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[732.868000] [095/131] (309s left) syncobj_wait (single-wait-all-signaled)
[732.929241] Starting subtest: single-wait-all-signaled
[732.931793] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[733.055861] [096/131] (308s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[733.105651] Starting subtest: y-tiled-to-vebox-x-tiled
[733.111294] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[733.302282] [097/131] (308s left) kms_rotation_crc (exhaust-fences)
[733.393371] Starting subtest: exhaust-fences
[733.398886] Subtest exhaust-fences: SKIP (0.000s)
[733.478820] [098/131] (308s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[733.578228] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[737.833926] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.225s)
[739.028816] [099/131] (303s left) kms_prop_blob (blob-prop-lifetime)
[739.084273] Starting subtest: blob-prop-lifetime
[739.087052] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[739.219861] [100/131] (302s left) gem_ctx_persistence (engines-hostile)
[739.273389] Starting subtest: engines-hostile
[739.276451] Starting dynamic subtest: rcs0
[739.425853] Dynamic subtest rcs0: SUCCESS (0.151s)
[739.439388] Starting dynamic subtest: bcs0
[739.523918] Dynamic subtest bcs0: SUCCESS (0.095s)
[739.536700] Starting dynamic subtest: vcs0
[739.629848] Dynamic subtest vcs0: SUCCESS (0.103s)
[739.643432] Starting dynamic subtest: vcs1
[739.736127] Dynamic subtest vcs1: SUCCESS (0.104s)
[739.748419] Starting dynamic subtest: vecs0
[739.862096] Dynamic subtest vecs0: SUCCESS (0.123s)
[739.873107] Starting dynamic subtest: ccs0
[739.969499] Dynamic subtest ccs0: SUCCESS (0.105s)
[739.972239] Subtest engines-hostile: SUCCESS (0.695s)
[740.061965] [101/131] (302s left) syncobj_wait (wait-all-for-submit-snapshot)
[740.122398] Starting subtest: wait-all-for-submit-snapshot
[740.203398] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[740.306099] [102/131] (301s left) kms_atomic_transition (plane-all-modeset-transition)
[740.410245] Starting subtest: plane-all-modeset-transition
[740.414358] Subtest plane-all-modeset-transition: SKIP (0.000s)
[740.497870] [103/131] (301s left) vgem_basic (debugfs)
[740.536901] Starting subtest: debugfs
[740.538690] Subtest debugfs: SUCCESS (0.000s)
[740.603444] [104/131] (301s left) syncobj_basic (bad-destroy-pad)
[740.657487] Starting subtest: bad-destroy-pad
[740.660425] Subtest bad-destroy-pad: SUCCESS (0.000s)
[740.781065] [105/131] (301s left) kms_psr (pr-sprite-blt)
[740.884115] Starting subtest: pr-sprite-blt
[740.888403] Subtest pr-sprite-blt: SKIP (0.000s)
[740.981102] [106/131] (301s left) syncobj_wait (single-wait-all-for-submit-submitted)
[741.038351] Starting subtest: single-wait-all-for-submit-submitted
[741.138335] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[741.227812] [107/131] (301s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[741.323270] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[748.069465] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.730s)
[748.218279] [108/131] (294s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[748.312457] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[748.315469] Starting dynamic subtest: pipe-A-default-mode
[749.511235] Dynamic subtest pipe-A-default-mode: SKIP (1.193s)
[749.516420] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.195s)
[749.667954] [109/131] (292s left) perf (blocking)
[749.783673] Starting subtest: blocking
[749.785722] Starting dynamic subtest: 0-rcs0
[759.807980] Dynamic subtest 0-rcs0: SUCCESS (10.015s)
[759.818454] Starting dynamic subtest: 1-vcs0
[769.827353] Dynamic subtest 1-vcs0: SUCCESS (10.018s)
[769.829690] Subtest blocking: SUCCESS (20.035s)
[769.880036] [110/131] (272s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[769.981174] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[769.986639] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[770.101989] [111/131] (272s left) gem_exec_fence (syncobj-timeline-export)
[770.630601] Starting subtest: syncobj-timeline-export
[770.634798] Subtest syncobj-timeline-export: SUCCESS (0.009s)
[771.979677] [112/131] (270s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[772.076646] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[772.082046] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[772.216302] [113/131] (270s left) device_reset (unbind-cold-reset-rebind)
[772.265581] Starting subtest: unbind-cold-reset-rebind
[772.270635] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[772.347409] [114/131] (270s left) kms_psr (fbc-psr-cursor-blt)
[772.443433] Starting subtest: fbc-psr-cursor-blt
[772.445876] Starting dynamic subtest: eDP-1
[772.450639] Dynamic subtest eDP-1: SKIP (0.000s)
[772.455469] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[772.525187] [115/131] (270s left) perf_pmu (render-node-busy-idle)
[772.611055] Starting subtest: render-node-busy-idle
[772.613675] Starting dynamic subtest: rcs0
[773.334820] Dynamic subtest rcs0: SUCCESS (0.724s)
[773.348509] Starting dynamic subtest: bcs0
[774.007190] Dynamic subtest bcs0: SUCCESS (0.670s)
[774.020913] Starting dynamic subtest: vcs0
[775.831887] Dynamic subtest vcs0: SUCCESS (1.821s)
[775.843693] Starting dynamic subtest: vcs1
[777.815024] Dynamic subtest vcs1: SUCCESS (1.980s)
[777.826659] Starting dynamic subtest: vecs0
[779.800028] Dynamic subtest vecs0: SUCCESS (1.981s)
[779.813627] Starting dynamic subtest: ccs0
[780.480628] Dynamic subtest ccs0: SUCCESS (0.678s)
[780.483614] Subtest render-node-busy-idle: SUCCESS (7.870s)
[780.575138] [116/131] (262s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[780.681511] Starting subtest: x-tiled-16bpp-rotate-180
[781.929761] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.246s)
[782.090306] [117/131] (260s left) api_intel_bb (destroy-bb)
[782.147366] Starting subtest: destroy-bb
[782.154870] Subtest destroy-bb: SUCCESS (0.009s)
[782.311006] [118/131] (260s left) kms_pm_lpsp (kms-lpsp)
[783.413533] Starting subtest: kms-lpsp
[783.416165] Starting dynamic subtest: pipe-A-eDP-1
[783.550111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[783.849390] Subtest kms-lpsp: SUCCESS (0.436s)
[784.730590] [119/131] (258s left) kms_vblank (wait-forked-busy)
[784.828521] Starting subtest: wait-forked-busy
[784.831261] Starting dynamic subtest: pipe-A-eDP-1
[786.704162] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[786.721288] Starting dynamic subtest: pipe-D-eDP-1
[789.281480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.572s)
[789.284159] Subtest wait-forked-busy: SUCCESS (4.451s)
[790.100045] [120/131] (252s left) kms_chamelium_frames (dp-crc-fast)
[790.490036] Subtest dp-crc-fast: SKIP (0.000s)
[791.299973] [121/131] (251s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[791.361611] Starting subtest: multi-wait-available-submitted-signaled
[791.364449] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[791.475881] [122/131] (251s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[791.577819] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[799.137763] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.559s)
[799.275414] [123/131] (243s left) gem_eio (kms)
[799.533530] Starting subtest: kms
[818.098524] Subtest kms: SUCCESS (18.559s)
[819.285355] [124/131] (223s left) i915_module_load (reload-with-fault-injection)
[819.320148] Starting subtest: reload-with-fault-injection
[848.127893] Subtest reload-with-fault-injection: SUCCESS (28.815s)
[848.159055] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[848.159802] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[848.163438] [125/131] (195s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[850.029976] Starting subtest: cursorA-vs-flipB-atomic
[850.035642] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[850.187723] [FACT kms_cursor_legacy (cursora-vs-flipb-atomic)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[850.188928] [FACT kms_cursor_legacy (cursora-vs-flipb-atomic)] new: kernel.kmod_is_loaded.i915: true
[850.192852] [126/131] (193s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[850.304418] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[854.561772] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.263s)
[855.716901] [127/131] (187s left) gem_ctx_exec (basic)
[855.779431] Starting subtest: basic
[855.786445] Subtest basic: SUCCESS (0.009s)
[855.920759] [128/131] (187s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[856.122026] Starting subtest: cursor-rapid-movement-128x128
[856.127951] Starting dynamic subtest: pipe-A-eDP-1
[856.688323] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[856.725627] Starting dynamic subtest: pipe-D-eDP-1
[857.901160] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.189s)
[857.905325] Subtest cursor-rapid-movement-128x128: SUCCESS (1.779s)
[858.763855] [129/131] (184s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[858.860348] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[858.865411] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[858.956985] [130/131] (184s left) template (a)
[859.011236] Starting subtest: A
[859.013407] Subtest A: SUCCESS (0.000s)
[859.120211] [131/131] (184s left) kms_big_fb (linear-16bpp-rotate-180)
[859.220170] Starting subtest: linear-16bpp-rotate-180
[860.597363] Subtest linear-16bpp-rotate-180: SUCCESS (1.379s)
[860.745603] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_wait
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_cs_tlb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_color
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_render_copy_redux
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_ctx_param
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: drm_read
results: parsing output: 19/ for test: prime_vgem
results: parsing output: 20/ for test: gem_fenced_exec_thrash
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: api_intel_allocator
results: parsing output: 28/ for test: i915_pm_rps
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: prime_udl
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gen3_mixed_blits
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: kms_debugfs
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_parallel
results: parsing output: 39/ for test: gem_lmem_swapping
results: parsing output: 40/ for test: gem_busy
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_chamelium_hpd
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_gttfill
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_dsc
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_ppgtt
results: parsing output: 57/ for test: kms_invalid_mode
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: kms_selftest
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: gem_exercise_blt
results: parsing output: 70/ for test: gem_exec_flush
results: parsing output: 71/ for test: gem_tiled_fence_blits
results: parsing output: 72/ for test: sysfs_heartbeat_interval
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_plane_multiple
results: parsing output: 82/ for test: kms_async_flips
results: parsing output: 83/ for test: kms_lease
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_prop_blob
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: syncobj_basic
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: device_reset
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_pm_lpsp
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: kms_chamelium_frames
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: i915_module_load
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_ctx_exec
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: template
results: parsing output: 130/ for test: kms_big_fb
Done.