[54.417909] Initializing watchdogs
[54.417953]   /dev/watchdog0
[54.440600] [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]
[54.444649] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.446711] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.449915] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[54.570785] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[54.575051] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[54.676243] [002/131] (960s left) i915_drm_fdinfo (virtual-busy-hang-all)
[54.715587] Starting subtest: virtual-busy-hang-all
[54.719873] Subtest virtual-busy-hang-all: SKIP (0.000s)
[54.782150] [003/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[54.879076] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[59.128596] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.253s)
[60.267901] [004/131] (954s left) kms_addfb_basic (bad-pitch-128)
[60.332141] Starting subtest: bad-pitch-128
[60.334443] Subtest bad-pitch-128: SUCCESS (0.000s)
[60.466816] [005/131] (954s left) kms_prop_blob (basic)
[60.523442] Starting subtest: basic
[60.525668] Subtest basic: SUCCESS (0.000s)
[60.626601] [006/131] (954s left) gem_mmap_offset (perf)
[60.677711] Starting subtest: perf
[60.679958] Starting dynamic subtest: smem0
[61.014301] Dynamic subtest smem0: SUCCESS (0.335s)
[61.016699] Subtest perf: SUCCESS (0.335s)
[61.150476] [007/131] (954s left) gem_create (create-invalid-size)
[61.204029] Starting subtest: create-invalid-size
[61.206370] Subtest create-invalid-size: SUCCESS (0.000s)
[61.383029] [008/131] (953s left) core_hotunplug (unbind-rebind)
[61.458572] Starting subtest: unbind-rebind
[67.515674] Subtest unbind-rebind: SUCCESS (6.058s)
[67.549984] [009/131] (947s left) i915_drm_fdinfo (context-close-stress)
[67.595148] Starting subtest: context-close-stress
[78.340156] Subtest context-close-stress: SUCCESS (10.744s)
[78.407445] [010/131] (936s left) kms_scaling_modes (scaling-mode-center)
[78.684146] Starting subtest: scaling-mode-center
[78.686504] Starting dynamic subtest: pipe-A-eDP-1
[78.820851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[78.830651] Starting dynamic subtest: pipe-B-eDP-1
[80.034552] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[80.041676] Starting dynamic subtest: pipe-C-eDP-1
[81.140282] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[81.147525] Starting dynamic subtest: pipe-D-eDP-1
[82.263542] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[82.265925] Subtest scaling-mode-center: SUCCESS (3.579s)
[83.416661] [011/131] (931s left) api_intel_bb (delta-check)
[83.467176] Starting subtest: delta-check
[83.469494] Subtest delta-check: SUCCESS (0.005s)
[83.604180] [012/131] (931s left) sw_sync (sync_multi_consumer_producer)
[83.636516] Starting subtest: sync_multi_consumer_producer
[83.947654] Subtest sync_multi_consumer_producer: SUCCESS (0.311s)
[84.001271] [013/131] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[84.102126] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[91.509928] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.411s)
[91.663407] [014/131] (923s left) gem_exec_balancer (nohangcheck)
[91.925710] Starting subtest: nohangcheck
[92.788905] Subtest nohangcheck: SUCCESS (0.862s)
[92.914978] [015/131] (922s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[93.021949] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[93.023984] Starting dynamic subtest: pipe-A-eDP-1
[93.461316] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[93.471448] Starting dynamic subtest: pipe-B-eDP-1
[93.492771] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[93.500497] Starting dynamic subtest: pipe-C-eDP-1
[93.520789] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[93.529178] Starting dynamic subtest: pipe-D-eDP-1
[93.552717] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[93.556697] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.452s)
[95.695793] [016/131] (919s left) kms_cursor_crc (cursor-offscreen-32x10)
[95.850825] Starting subtest: cursor-offscreen-32x10
[95.890851] Subtest cursor-offscreen-32x10: SKIP (0.038s)
[96.139206] [017/131] (919s left) prime_busy (before)
[96.195566] Starting subtest: before
[96.198247] Starting dynamic subtest: rcs0
[96.252747] Dynamic subtest rcs0: SUCCESS (0.056s)
[96.262584] Starting dynamic subtest: bcs0
[96.312994] Dynamic subtest bcs0: SUCCESS (0.059s)
[96.325926] Starting dynamic subtest: vcs0
[96.353753] Dynamic subtest vcs0: SUCCESS (0.041s)
[96.360805] Starting dynamic subtest: vcs1
[96.392868] Dynamic subtest vcs1: SUCCESS (0.039s)
[96.400104] Starting dynamic subtest: vecs0
[96.432696] Dynamic subtest vecs0: SUCCESS (0.039s)
[96.439856] Starting dynamic subtest: ccs0
[96.472733] Dynamic subtest ccs0: SUCCESS (0.040s)
[96.578526] Subtest before: SUCCESS (0.383s)
[96.660535] [018/131] (918s left) kms_flip (plain-flip-interruptible)
[96.762160] Starting subtest: plain-flip-interruptible
[96.764449] Starting dynamic subtest: A-eDP1
[98.418511] Dynamic subtest A-eDP1: SUCCESS (1.655s)
[98.428255] Starting dynamic subtest: B-eDP1
[100.040809] Dynamic subtest B-eDP1: SUCCESS (1.621s)
[100.050987] Starting dynamic subtest: C-eDP1
[101.656445] Dynamic subtest C-eDP1: SUCCESS (1.615s)
[101.665392] Starting dynamic subtest: D-eDP1
[103.297458] Dynamic subtest D-eDP1: SUCCESS (1.640s)
[103.302517] Subtest plain-flip-interruptible: SUCCESS (6.541s)
[104.469790] [019/131] (911s left) fbdev (read)
[104.503706] Starting subtest: read
[105.031762] Subtest read: SUCCESS (0.526s)
[105.122181] [020/131] (910s left) kms_lease (lease-get)
[105.219585] Starting subtest: lease-get
[105.221907] Starting dynamic subtest: pipe-A-eDP-1
[105.224193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[105.231744] Starting dynamic subtest: pipe-B-eDP-1
[105.233971] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[105.241304] Starting dynamic subtest: pipe-C-eDP-1
[105.243482] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[105.250935] Starting dynamic subtest: pipe-D-eDP-1
[105.253183] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[105.255334] Subtest lease-get: SUCCESS (0.007s)
[105.338046] [021/131] (910s left) api_intel_allocator (gem-pool)
[105.393942] Starting subtest: gem-pool
[105.402256] Subtest gem-pool: SUCCESS (0.011s)
[105.527331] [022/131] (910s left) gem_mmap_wc (write)
[105.585500] Subtest write: SKIP (0.000s)
[105.649778] [023/131] (910s left) gem_spin_batch (user-each)
[105.724481] Starting subtest: user-each
[108.986825] Subtest user-each: SUCCESS (3.258s)
[110.989818] [024/131] (904s left) kms_cursor_crc (cursor-onscreen-256x256)
[111.241605] Starting subtest: cursor-onscreen-256x256
[111.243926] Starting dynamic subtest: pipe-A-eDP-1
[113.330302] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s)
[113.359090] Starting dynamic subtest: pipe-D-eDP-1
[116.139863] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.786s)
[116.141807] Subtest cursor-onscreen-256x256: SUCCESS (4.897s)
[116.939753] [025/131] (898s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[117.061236] Starting subtest: basic-flip-before-cursor-atomic
[117.986935] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.925s)
[118.778607] [026/131] (897s left) kms_properties (plane-properties-legacy)
[118.871163] Starting subtest: plane-properties-legacy
[118.873403] Starting dynamic subtest: pipe-A-eDP-1
[119.435864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[119.444968] Starting dynamic subtest: pipe-B-eDP-1
[120.668461] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[120.677475] Starting dynamic subtest: pipe-C-eDP-1
[121.904378] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[121.914058] Starting dynamic subtest: pipe-D-eDP-1
[123.148807] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[123.151243] Subtest plane-properties-legacy: SUCCESS (4.276s)
[123.946755] [027/131] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[124.037412] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[124.041539] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[124.135069] [028/131] (891s left) kms_plane (plane-position-covered)
[124.227774] Starting subtest: plane-position-covered
[124.730708] Starting dynamic subtest: pipe-A-plane-1
[125.995496] Dynamic subtest pipe-A-plane-1: SUCCESS (1.264s)
[126.004541] Starting dynamic subtest: pipe-A-plane-2
[127.225299] Dynamic subtest pipe-A-plane-2: SUCCESS (1.232s)
[127.235130] Starting dynamic subtest: pipe-A-plane-3
[128.459487] Dynamic subtest pipe-A-plane-3: SUCCESS (1.234s)
[128.469923] Starting dynamic subtest: pipe-A-plane-4
[129.696860] Dynamic subtest pipe-A-plane-4: SUCCESS (1.235s)
[129.706793] Starting dynamic subtest: pipe-A-plane-5
[129.720674] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[130.846036] Starting dynamic subtest: pipe-B-plane-1
[132.062707] Dynamic subtest pipe-B-plane-1: SUCCESS (1.223s)
[132.073221] Starting dynamic subtest: pipe-B-plane-2
[133.299646] Dynamic subtest pipe-B-plane-2: SUCCESS (1.235s)
[133.308612] Starting dynamic subtest: pipe-B-plane-3
[134.553140] Dynamic subtest pipe-B-plane-3: SUCCESS (1.253s)
[134.561023] Starting dynamic subtest: pipe-B-plane-4
[135.781224] Dynamic subtest pipe-B-plane-4: SUCCESS (1.229s)
[135.793089] Starting dynamic subtest: pipe-B-plane-5
[135.804409] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[135.806744] Subtest plane-position-covered: SUCCESS (11.576s)
[136.591133] [029/131] (879s left) kms_plane_lowres (tiling-y)
[136.685724] Starting subtest: tiling-y
[136.689951] Subtest tiling-y: SKIP (0.000s)
[136.752094] [030/131] (879s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[136.842733] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[144.026149] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.185s)
[144.168836] [031/131] (871s left) gem_mmap_wc (fault-concurrent)
[144.231121] Subtest fault-concurrent: SKIP (0.000s)
[144.295114] [032/131] (871s left) gem_create (create-ext-placement-each)
[144.459800] Starting subtest: create-ext-placement-each
[144.463028] Subtest create-ext-placement-each: SUCCESS (0.000s)
[144.551229] [033/131] (871s left) kms_psr (fbc-psr-suspend)
[144.641166] Starting subtest: fbc-psr-suspend
[144.643296] Starting dynamic subtest: eDP-1
[144.647622] Dynamic subtest eDP-1: SKIP (0.000s)
[144.651982] Subtest fbc-psr-suspend: SKIP (0.001s)
[144.718821] [034/131] (871s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[144.763816] Starting subtest: multi-wait-all-for-submit-unsubmitted
[144.872401] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[144.941039] [035/131] (871s left) gem_pxp (reject-modify-context-protection-off-3)
[145.063065] Starting subtest: reject-modify-context-protection-off-3
[145.065375] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[145.185413] [036/131] (871s left) gem_exec_balancer (full-late-pulse)
[145.252181] Starting subtest: full-late-pulse
[149.750841] Subtest full-late-pulse: SUCCESS (4.498s)
[150.086944] [037/131] (866s left) kms_chamelium_frames (dp-crc-multiple)
[150.492222] Subtest dp-crc-multiple: SKIP (0.000s)
[151.336464] [038/131] (864s left) kms_setmode (invalid-clone-exclusive-crtc)
[151.389631] Starting subtest: invalid-clone-exclusive-crtc
[151.396170] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[151.498362] [039/131] (864s left) kms_psr (pr-primary-page-flip)
[151.589073] Starting subtest: pr-primary-page-flip
[151.593416] Subtest pr-primary-page-flip: SKIP (0.000s)
[151.659167] [040/131] (864s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[151.753638] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[151.755450] Starting dynamic subtest: pipe-A-eDP-1
[152.479744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[152.488149] Starting dynamic subtest: pipe-B-eDP-1
[154.286601] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.806s)
[154.296854] Starting dynamic subtest: pipe-C-eDP-1
[156.014418] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.727s)
[156.023398] Starting dynamic subtest: pipe-D-eDP-1
[157.769072] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.754s)
[157.770941] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.009s)
[158.910173] [041/131] (857s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[159.022266] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[159.026225] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[159.143500] [042/131] (857s left) gem_ctx_shared (create-shared-gtt)
[159.212057] Starting subtest: create-shared-gtt
[161.365240] Subtest create-shared-gtt: SUCCESS (2.152s)
[162.067374] [043/131] (854s left) kms_hdmi_inject (inject-audio)
[162.405296] Starting subtest: inject-audio
[162.659642] Subtest inject-audio: SUCCESS (0.255s)
[163.268471] [044/131] (853s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[163.365145] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[163.367421] Starting dynamic subtest: pipe-A-eDP-1
[163.390118] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[163.398612] Starting dynamic subtest: pipe-B-eDP-1
[163.419186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[163.427081] Starting dynamic subtest: pipe-C-eDP-1
[163.448108] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[163.455616] Starting dynamic subtest: pipe-D-eDP-1
[163.476627] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[163.480599] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[165.642380] [045/131] (850s left) gem_exec_whisper (basic-normal-all)
[165.702925] Starting subtest: basic-normal-all
[167.989119] Subtest basic-normal-all: SUCCESS (2.285s)
[168.166048] [046/131] (848s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[168.260316] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[169.050543] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[169.230352] [047/131] (847s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[169.292274] Starting subtest: multi-wait-for-submit-available-signaled
[169.294228] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[169.385951] [048/131] (847s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[169.956601] Starting subtest: syncobj-timeline-multiple-ext-nodes
[169.959085] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[170.981322] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[170.984520] [049/131] (845s left) kms_atomic (plane-overlay-legacy)
[171.078108] Starting subtest: plane-overlay-legacy
[171.080356] Starting dynamic subtest: pipe-A-eDP-1
[171.512402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s)
[171.514326] Subtest plane-overlay-legacy: SUCCESS (0.432s)
[172.345078] [050/131] (844s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[172.451449] Starting subtest: yf-tiled-32bpp-rotate-180
[172.455678] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[172.547898] [051/131] (844s left) gem_mmap_gtt (big-bo-tiledx)
[172.593638] Subtest big-bo-tiledX: SKIP (0.000s)
[172.653057] [052/131] (844s left) sw_sync (sync_multi_timeline_wait)
[172.689213] Starting subtest: sync_multi_timeline_wait
[172.691153] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[172.744165] [053/131] (844s left) gem_exec_flush (basic-uc-set-default)
[172.796733] Starting subtest: basic-uc-set-default
[178.244821] Subtest basic-uc-set-default: SUCCESS (5.449s)
[178.429391] [054/131] (838s left) syncobj_wait (wait-all-interrupted)
[178.497783] Starting subtest: wait-all-interrupted
[178.601542] Subtest wait-all-interrupted: SUCCESS (0.101s)
[178.680382] [055/131] (838s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[178.742300] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[178.848133] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s)
[178.922837] [056/131] (838s left) gem_exec_schedule (u-independent)
[178.984837] Starting subtest: u-independent
[178.987132] Starting dynamic subtest: rcs0
[180.885307] Dynamic subtest rcs0: SUCCESS (1.908s)
[180.895943] Starting dynamic subtest: vcs0
[182.978081] Dynamic subtest vcs0: SUCCESS (2.091s)
[182.991065] Starting dynamic subtest: vcs1
[184.953225] Dynamic subtest vcs1: SUCCESS (1.973s)
[184.965458] Starting dynamic subtest: vecs0
[186.926066] Dynamic subtest vecs0: SUCCESS (1.971s)
[186.937396] Starting dynamic subtest: ccs0
[188.883829] Dynamic subtest ccs0: SUCCESS (1.956s)
[188.886741] Subtest u-independent: SUCCESS (9.907s)
[189.182886] [057/131] (827s left) syncobj_timeline (transfer-timeline-point)
[189.236732] Starting subtest: transfer-timeline-point
[189.239139] Subtest transfer-timeline-point: SUCCESS (0.001s)
[189.331356] [058/131] (827s left) kms_writeback (writeback-check-output)
[189.422131] Subtest writeback-check-output: SKIP (0.000s)
[189.468127] [059/131] (827s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[189.561732] Starting subtest: fbcpsr-rgb565-draw-blt
[196.500856] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.941s)
[196.625668] [060/131] (820s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[196.714510] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[196.718882] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[196.804193] [061/131] (820s left) gem_lmem_swapping (parallel-random-engines)
[196.844045] Subtest parallel-random-engines: SKIP (0.000s)
[196.893851] [062/131] (820s left) gem_exec_reloc (basic-wc-read)
[196.953612] Subtest basic-wc-read: SKIP (0.000s)
[197.030502] [063/131] (820s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[197.123064] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[197.125241] Starting dynamic subtest: pipe-A-eDP-1
[197.182378] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[197.192325] Starting dynamic subtest: pipe-B-eDP-1
[197.249470] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[197.259817] Starting dynamic subtest: pipe-C-eDP-1
[197.319101] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[197.327335] Starting dynamic subtest: pipe-D-eDP-1
[197.386762] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[197.391111] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[199.333928] [064/131] (817s left) gem_userptr_blits (create-destroy-sync)
[199.403456] Starting subtest: create-destroy-sync
[204.420807] Subtest create-destroy-sync: SUCCESS (5.015s)
[204.567945] [065/131] (812s left) kms_addfb_basic (no-handle)
[204.623673] Starting subtest: no-handle
[204.625689] Subtest no-handle: SUCCESS (0.000s)
[204.760641] [066/131] (812s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[204.825392] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[204.829724] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[205.004055] [067/131] (812s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[210.005891] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[210.008335] Starting dynamic subtest: pipe-A-eDP-1
[210.794089] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s)
[210.802367] Starting dynamic subtest: pipe-B-eDP-1
[211.986050] Dynamic subtest pipe-B-eDP-1: SKIP (1.192s)
[211.990538] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.979s)
[213.148467] [068/131] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[213.249098] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[213.253313] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[213.353954] [069/131] (804s left) gem_fenced_exec_thrash (no-spare-fences)
[213.413726] Subtest no-spare-fences: SKIP (0.000s)
[213.505949] [070/131] (804s left) i915_query (query-topology-kernel-writes)
[213.561913] Starting subtest: query-topology-kernel-writes
[213.564254] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[213.661081] [071/131] (803s left) gem_ppgtt (blt-vs-render-ctxn)
[213.723984] Starting subtest: blt-vs-render-ctxN
[246.758771] Subtest blt-vs-render-ctxN: SUCCESS (33.032s)
[246.896475] [072/131] (770s left) gem_ctx_isolation (preservation)
[246.989331] Starting subtest: preservation
[246.991606] Starting dynamic subtest: rcs0
[247.142099] Dynamic subtest rcs0: SUCCESS (0.150s)
[247.154447] Starting dynamic subtest: bcs0
[247.289647] Dynamic subtest bcs0: SUCCESS (0.148s)
[247.298793] Starting dynamic subtest: vcs0
[247.485265] Dynamic subtest vcs0: SUCCESS (0.195s)
[247.494220] Starting dynamic subtest: vcs1
[249.068406] Dynamic subtest vcs1: SUCCESS (1.582s)
[249.078586] Starting dynamic subtest: vecs0
[251.037263] Dynamic subtest vecs0: SUCCESS (1.968s)
[251.049044] Starting dynamic subtest: ccs0
[253.041608] Dynamic subtest ccs0: SUCCESS (2.003s)
[253.043941] Subtest preservation: SUCCESS (6.052s)
[253.296042] [073/131] (764s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[253.404529] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[253.408699] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.527460] [074/131] (764s left) kms_pm_lpsp (kms-lpsp)
[254.627328] Starting subtest: kms-lpsp
[254.629191] Starting dynamic subtest: pipe-A-eDP-1
[254.801645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.177s)
[255.109591] Subtest kms-lpsp: SUCCESS (0.484s)
[255.942277] [075/131] (761s left) gem_mmap_gtt (basic-read-write-distinct)
[256.005447] Subtest basic-read-write-distinct: SKIP (0.000s)
[256.072964] [076/131] (761s left) perf_pmu (busy-check-all)
[256.110296] Starting subtest: busy-check-all
[256.112606] Starting dynamic subtest: rcs0
[256.672949] Dynamic subtest rcs0: SUCCESS (0.564s)
[256.684636] Starting dynamic subtest: bcs0
[257.220966] Dynamic subtest bcs0: SUCCESS (0.546s)
[257.233075] Starting dynamic subtest: vcs0
[258.898951] Dynamic subtest vcs0: SUCCESS (1.674s)
[258.911227] Starting dynamic subtest: vcs1
[260.884548] Dynamic subtest vcs1: SUCCESS (1.983s)
[260.896559] Starting dynamic subtest: vecs0
[262.932521] Dynamic subtest vecs0: SUCCESS (2.045s)
[262.944759] Starting dynamic subtest: ccs0
[263.489447] Dynamic subtest ccs0: SUCCESS (0.556s)
[263.492049] Subtest busy-check-all: SUCCESS (7.382s)
[263.592350] [077/131] (754s left) kms_flip (2x-plain-flip-fb-recreate)
[263.693296] Starting subtest: 2x-plain-flip-fb-recreate
[263.702841] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[263.777882] [078/131] (754s left) kms_frontbuffer_tracking (basic)
[263.876379] Starting subtest: basic
[266.931196] Subtest basic: SUCCESS (3.060s)
[267.045975] [079/131] (750s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[267.145473] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[267.147429] Starting dynamic subtest: pipe-A-default-mode
[267.433724] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[267.438286] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.286s)
[268.234754] [080/131] (749s left) i915_pm_rps (min-max-config-idle)
[268.290344] Starting subtest: min-max-config-idle
[268.295076] Subtest min-max-config-idle: SKIP (0.000s)
[268.371571] [081/131] (749s left) gem_exec_schedule (preempt-self)
[268.459751] Starting subtest: preempt-self
[268.461789] Starting dynamic subtest: rcs0
[268.470602] Dynamic subtest rcs0: SUCCESS (0.018s)
[268.479733] Starting dynamic subtest: bcs0
[268.486533] Dynamic subtest bcs0: SUCCESS (0.015s)
[268.495140] Starting dynamic subtest: vcs0
[268.501676] Dynamic subtest vcs0: SUCCESS (0.015s)
[268.510344] Starting dynamic subtest: vcs1
[268.519231] Dynamic subtest vcs1: SUCCESS (0.017s)
[268.527756] Starting dynamic subtest: vecs0
[268.537315] Dynamic subtest vecs0: SUCCESS (0.017s)
[268.546040] Starting dynamic subtest: ccs0
[268.559434] Dynamic subtest ccs0: SUCCESS (0.022s)
[268.561666] Subtest preempt-self: SUCCESS (0.108s)
[270.009706] [082/131] (748s left) gem_ctx_param (get-priority-new-ctx)
[270.062171] Starting subtest: get-priority-new-ctx
[270.064427] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[270.165936] [083/131] (747s left) gem_ctx_persistence (engines-hostile-preempt)
[270.220307] Starting subtest: engines-hostile-preempt
[270.222590] Starting dynamic subtest: rcs0
[270.322366] Dynamic subtest rcs0: SUCCESS (0.102s)
[270.332247] Starting dynamic subtest: bcs0
[270.407693] Dynamic subtest bcs0: SUCCESS (0.083s)
[270.418527] Starting dynamic subtest: vcs0
[271.921382] Dynamic subtest vcs0: SUCCESS (1.510s)
[271.933040] Starting dynamic subtest: vcs1
[273.961117] Dynamic subtest vcs1: SUCCESS (2.038s)
[273.972528] Starting dynamic subtest: vecs0
[275.925599] Dynamic subtest vecs0: SUCCESS (1.963s)
[275.937766] Starting dynamic subtest: ccs0
[275.955420] Dynamic subtest ccs0: SUCCESS (0.029s)
[275.957807] Subtest engines-hostile-preempt: SUCCESS (5.736s)
[276.096282] [084/131] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[276.197210] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[276.201619] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[276.311182] [085/131] (741s left) kms_psr (psr2-sprite-blt)
[276.411445] Starting subtest: psr2-sprite-blt
[276.413769] Starting dynamic subtest: eDP-1
[278.097245] Dynamic subtest eDP-1: SUCCESS (1.686s)
[278.099766] Subtest psr2-sprite-blt: SUCCESS (1.687s)
[278.932234] [086/131] (739s left) kms_getfb (getfb-reject-nv12)
[279.030215] Starting subtest: getfb-reject-nv12
[279.032468] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[279.135812] [087/131] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[279.237293] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[279.241707] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[279.356868] [088/131] (738s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[279.460421] Starting subtest: x-tiled-16bpp-rotate-90
[279.479582] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[279.605462] [089/131] (738s left) kms_draw_crc (draw-method-pwrite)
[279.700780] Starting subtest: draw-method-pwrite
[279.702784] Starting dynamic subtest: xrgb8888-untiled
[280.288087] Dynamic subtest xrgb8888-untiled: SUCCESS (0.590s)
[280.297757] Starting dynamic subtest: rgb565-untiled
[280.721358] Dynamic subtest rgb565-untiled: SUCCESS (0.433s)
[280.730523] Starting dynamic subtest: xrgb2101010-untiled
[281.277320] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[281.285995] Starting dynamic subtest: xbgr16161616f-untiled
[282.021452] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.744s)
[282.030718] Starting dynamic subtest: xrgb8888-xtiled
[283.788081] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.766s)
[283.797428] Starting dynamic subtest: rgb565-xtiled
[284.877074] Dynamic subtest rgb565-xtiled: SUCCESS (1.088s)
[284.885768] Starting dynamic subtest: xrgb2101010-xtiled
[286.643504] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.766s)
[286.652891] Starting dynamic subtest: xbgr16161616f-xtiled
[289.877781] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.233s)
[289.886651] Starting dynamic subtest: xrgb8888-4tiled
[290.988383] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.109s)
[290.997045] Starting dynamic subtest: rgb565-4tiled
[291.556932] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[291.565196] Starting dynamic subtest: xrgb2101010-4tiled
[292.644307] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.088s)
[292.653374] Starting dynamic subtest: xbgr16161616f-4tiled
[295.599645] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.954s)
[295.601944] Subtest draw-method-pwrite: SUCCESS (15.901s)
[295.692253] [090/131] (722s left) kms_big_fb (4-tiled-addfb-size-overflow)
[295.791410] Starting subtest: 4-tiled-addfb-size-overflow
[295.793618] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[295.884809] [091/131] (722s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[298.000541] Starting subtest: gem-execbuf-stress-pc8
[298.042503] Subtest gem-execbuf-stress-pc8: SKIP (0.038s)
[298.373872] [092/131] (720s left) kms_vblank (query-forked-busy-hang)
[298.475851] Starting subtest: query-forked-busy-hang
[298.477722] Starting dynamic subtest: pipe-A-eDP-1
[324.689089] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.213s)
[324.710333] Starting dynamic subtest: pipe-D-eDP-1
[349.657027] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.964s)
[349.659202] Subtest query-forked-busy-hang: SUCCESS (51.181s)
[350.521280] [093/131] (667s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[350.582381] Starting subtest: etime-single-wait-for-submit-submitted
[350.688510] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[350.762852] [094/131] (667s left) kms_psr2_su (page_flip-nv12)
[350.811871] Subtest page_flip-NV12: SKIP (0.000s)
[350.877831] [095/131] (667s left) gen9_exec_parse (batch-without-end)
[350.942709] Subtest batch-without-end: SKIP (0.000s)
[351.019906] [096/131] (667s left) gem_eio (hibernate)
[351.217741] Starting subtest: hibernate
[365.817649] Subtest hibernate: SUCCESS (14.598s)
[373.003811] [097/131] (652s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[378.116751] Starting subtest: pr-overlay-plane-update-continuous-sf
[378.121382] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.003s)
[378.921943] [098/131] (646s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[379.019675] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[385.869805] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.849s)
[385.993772] [099/131] (639s left) gem_softpin (allocator-basic)
[386.061083] Starting subtest: allocator-basic
[386.127066] Subtest allocator-basic: SUCCESS (0.066s)
[386.271350] [100/131] (639s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[386.376757] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[386.379018] Starting dynamic subtest: pipe-A-eDP-1
[386.387666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[386.398837] Starting dynamic subtest: pipe-B-eDP-1
[386.407555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.417549] Starting dynamic subtest: pipe-C-eDP-1
[386.426081] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.435972] Starting dynamic subtest: pipe-D-eDP-1
[386.444742] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[386.449205] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[388.630617] [101/131] (637s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[388.714032] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[388.716349] Starting dynamic subtest: pipe-A-default-mode
[389.001463] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[389.006054] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s)
[389.829698] [102/131] (636s left) kms_color (invalid-ctm-matrix-sizes)
[389.926374] Starting subtest: invalid-ctm-matrix-sizes
[389.928559] Starting dynamic subtest: pipe-A
[389.930777] Dynamic subtest pipe-A: SUCCESS (0.002s)
[389.940510] Starting dynamic subtest: pipe-B
[389.942731] Dynamic subtest pipe-B: SUCCESS (0.003s)
[389.952248] Starting dynamic subtest: pipe-C
[389.954484] Dynamic subtest pipe-C: SUCCESS (0.003s)
[389.964937] Starting dynamic subtest: pipe-D
[389.967147] Dynamic subtest pipe-D: SUCCESS (0.003s)
[389.969293] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[390.009725] [103/131] (635s left) kms_atomic (plane-immutable-zpos)
[390.107223] Starting subtest: plane-immutable-zpos
[390.109541] Starting dynamic subtest: pipe-A-eDP-1
[390.749228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[390.751522] Subtest plane-immutable-zpos: SUCCESS (0.644s)
[391.624393] [104/131] (634s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[391.725688] Starting subtest: psr-rgb565-draw-mmap-wc
[398.364792] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.642s)
[398.502064] [105/131] (627s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[398.602174] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[398.604321] Starting dynamic subtest: pipe-A
[398.668297] Dynamic subtest pipe-A: SUCCESS (0.068s)
[398.679547] Starting dynamic subtest: pipe-B
[399.815511] Dynamic subtest pipe-B: SUCCESS (1.147s)
[399.826082] Starting dynamic subtest: pipe-C
[400.907518] Dynamic subtest pipe-C: SUCCESS (1.090s)
[400.919052] Starting dynamic subtest: pipe-D
[402.014261] Dynamic subtest pipe-D: SUCCESS (1.105s)
[402.016550] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.415s)
[403.223068] [106/131] (622s left) gem_exec_schedule (manyslice)
[403.302974] Starting subtest: manyslice
[403.305172] Starting dynamic subtest: rcs0
[407.917214] Dynamic subtest rcs0: SUCCESS (4.621s)
[407.931816] Starting dynamic subtest: bcs0
[414.030659] Dynamic subtest bcs0: SUCCESS (6.112s)
[414.048371] Starting dynamic subtest: vcs0
[419.095925] Dynamic subtest vcs0: SUCCESS (5.064s)
[419.106503] Starting dynamic subtest: vcs1
[425.167834] Dynamic subtest vcs1: SUCCESS (6.069s)
[425.181496] Starting dynamic subtest: vecs0
[431.239889] Dynamic subtest vecs0: SUCCESS (6.071s)
[431.250181] Starting dynamic subtest: ccs0
[437.933659] Dynamic subtest ccs0: SUCCESS (6.692s)
[437.936743] Subtest manyslice: SUCCESS (34.637s)
[438.237650] [107/131] (587s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[438.382165] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[469.167992] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.785s)
[470.015843] [108/131] (556s left) kms_cursor_crc (cursor-sliding-256x256)
[470.251617] Starting subtest: cursor-sliding-256x256
[470.256737] Starting dynamic subtest: pipe-A-eDP-1
[473.466130] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.211s)
[473.495164] Starting dynamic subtest: pipe-D-eDP-1
[477.355774] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.870s)
[477.357876] Subtest cursor-sliding-256x256: SUCCESS (7.104s)
[478.209932] [109/131] (547s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[478.317555] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[478.322182] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[478.462449] [110/131] (547s left) gem_exec_reloc (basic-gtt-active)
[478.519259] Subtest basic-gtt-active: SKIP (0.000s)
[478.605606] [111/131] (547s left) gem_exec_capture (userptr)
[478.664200] Starting subtest: userptr
[479.494839] Subtest userptr: SUCCESS (0.827s)
[479.631239] [112/131] (546s left) kms_cursor_edge_walk (256x256-top-edge)
[479.717197] Starting subtest: 256x256-top-edge
[479.719391] Starting dynamic subtest: pipe-A-eDP-1
[483.141377] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.423s)
[483.151708] Starting dynamic subtest: pipe-D-eDP-1
[486.340107] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.198s)
[486.342268] Subtest 256x256-top-edge: SUCCESS (6.623s)
[487.221409] [113/131] (539s left) kms_legacy_colorkey (basic)
[487.315274] Starting subtest: basic
[487.317551] Starting dynamic subtest: pipe-A
[487.360628] Dynamic subtest pipe-A: SUCCESS (0.045s)
[487.372498] Starting dynamic subtest: pipe-B
[487.374654] Dynamic subtest pipe-B: SUCCESS (0.001s)
[487.384105] Starting dynamic subtest: pipe-C
[487.385961] Dynamic subtest pipe-C: SUCCESS (0.001s)
[487.394950] Starting dynamic subtest: pipe-D
[487.396845] Dynamic subtest pipe-D: SUCCESS (0.001s)
[487.398731] Subtest basic: SUCCESS (0.053s)
[487.434642] [114/131] (538s left) gem_caching (reads)
[487.497833] Subtest reads: SKIP (0.000s)
[487.550750] [115/131] (538s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[487.646951] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[487.651165] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[487.750785] [116/131] (538s left) perf_pmu (semaphore-wait-idle)
[487.787764] Starting subtest: semaphore-wait-idle
[487.790226] Starting dynamic subtest: rcs0
[488.302054] Dynamic subtest rcs0: SUCCESS (0.513s)
[488.315936] Starting dynamic subtest: bcs0
[488.815048] Dynamic subtest bcs0: SUCCESS (0.511s)
[488.828294] Starting dynamic subtest: vcs0
[489.328040] Dynamic subtest vcs0: SUCCESS (0.510s)
[489.341297] Starting dynamic subtest: vcs1
[489.841061] Dynamic subtest vcs1: SUCCESS (0.510s)
[489.853276] Starting dynamic subtest: vecs0
[490.353769] Dynamic subtest vecs0: SUCCESS (0.511s)
[490.366577] Starting dynamic subtest: ccs0
[490.870398] Dynamic subtest ccs0: SUCCESS (0.512s)
[490.873401] Subtest semaphore-wait-idle: SUCCESS (3.081s)
[491.938154] [117/131] (534s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[492.045316] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[492.049588] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[492.151970] [118/131] (534s left) gem_exec_fence (basic-wait)
[492.334129] Starting subtest: basic-wait
[492.336523] Starting dynamic subtest: rcs0
[492.442985] Dynamic subtest rcs0: SUCCESS (0.109s)
[492.455418] Starting dynamic subtest: bcs0
[492.503238] Dynamic subtest bcs0: SUCCESS (0.058s)
[492.514299] Starting dynamic subtest: vcs0
[492.556057] Dynamic subtest vcs0: SUCCESS (0.051s)
[492.567773] Starting dynamic subtest: vcs1
[492.623239] Dynamic subtest vcs1: SUCCESS (0.065s)
[492.633883] Starting dynamic subtest: vecs0
[492.685240] Dynamic subtest vecs0: SUCCESS (0.060s)
[492.696037] Starting dynamic subtest: ccs0
[492.753707] Dynamic subtest ccs0: SUCCESS (0.067s)
[492.756388] Subtest basic-wait: SUCCESS (0.420s)
[495.011926] [119/131] (531s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[495.071678] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[495.073794] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[495.188828] [120/131] (531s left) gem_basic (bad-close)
[495.234073] Starting subtest: bad-close
[495.238249] Subtest bad-close: SUCCESS (0.000s)
[495.347218] [121/131] (531s left) kms_flip (2x-nonexisting-fb-interruptible)
[495.442853] Starting subtest: 2x-nonexisting-fb-interruptible
[495.453454] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[495.573415] [122/131] (531s left) kms_feature_discovery (display-3x)
[495.670205] Starting subtest: display-3x
[495.674767] Subtest display-3x: SKIP (0.000s)
[495.742517] [123/131] (530s left) kms_psr (fbc-psr2-no-drrs)
[495.835517] Starting subtest: fbc-psr2-no-drrs
[495.837406] Starting dynamic subtest: eDP-1
[495.841460] Dynamic subtest eDP-1: SKIP (0.000s)
[495.845567] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[495.904649] [124/131] (530s left) kms_invalid_mode (bad-hsync-start)
[496.002396] Starting subtest: bad-hsync-start
[496.004430] Starting dynamic subtest: pipe-A-eDP-1
[496.283078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[496.294766] Starting dynamic subtest: pipe-B-eDP-1
[496.296696] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[496.306613] Starting dynamic subtest: pipe-C-eDP-1
[496.308880] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[496.318223] Starting dynamic subtest: pipe-D-eDP-1
[496.320128] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[496.321988] Subtest bad-hsync-start: SUCCESS (0.288s)
[497.110664] [125/131] (529s left) kms_addfb_basic (addfb25-4-tiled)
[497.205916] Starting subtest: addfb25-4-tiled
[497.207766] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[497.309058] [126/131] (529s left) gem_mmap_offset (bad-extensions)
[497.362848] Starting subtest: bad-extensions
[497.365120] Subtest bad-extensions: SUCCESS (0.000s)
[497.480674] [127/131] (529s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[497.579700] Starting subtest: flip-vs-dpms-off-vs-modeset
[497.582064] Starting dynamic subtest: A-eDP1
[501.244291] Dynamic subtest A-eDP1: SUCCESS (3.665s)
[501.266067] Starting dynamic subtest: B-eDP1
[504.534781] Dynamic subtest B-eDP1: SUCCESS (3.290s)
[504.546340] Starting dynamic subtest: C-eDP1
[507.840612] Dynamic subtest C-eDP1: SUCCESS (3.305s)
[507.851753] Starting dynamic subtest: D-eDP1
[511.138628] Dynamic subtest D-eDP1: SUCCESS (3.297s)
[511.140958] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.565s)
[512.013326] [128/131] (514s left) prime_mmap (test_userptr)
[512.071071] Starting subtest: test_userptr
[512.073314] Starting dynamic subtest: test_userptr-smem
[512.075452] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[512.077772] Subtest test_userptr: SUCCESS (0.002s)
[512.180283] [129/131] (514s left) kms_flip (2x-flip-vs-rmfb)
[512.276134] Starting subtest: 2x-flip-vs-rmfb
[512.286711] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[512.398918] [130/131] (514s left) sysfs_preempt_timeout (invalid)
[512.465559] Starting subtest: invalid
[512.467755] Starting dynamic subtest: vecs0
[512.470076] Dynamic subtest vecs0: SUCCESS (0.000s)
[512.481432] Starting dynamic subtest: ccs0
[512.483592] Dynamic subtest ccs0: SUCCESS (0.000s)
[512.493044] Starting dynamic subtest: vcs0
[512.495192] Dynamic subtest vcs0: SUCCESS (0.000s)
[512.504617] Starting dynamic subtest: bcs0
[512.506813] Dynamic subtest bcs0: SUCCESS (0.000s)
[512.516189] Starting dynamic subtest: rcs0
[512.518376] Dynamic subtest rcs0: SUCCESS (0.000s)
[512.527900] Starting dynamic subtest: vcs1
[512.529821] Dynamic subtest vcs1: SUCCESS (0.000s)
[512.531751] Subtest invalid: SUCCESS (0.004s)
[512.580759] [131/131] (514s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[512.972065] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[513.791077] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_prop_blob
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: core_hotunplug
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: kms_scaling_modes
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: sw_sync
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: prime_busy
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: fbdev
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: api_intel_allocator
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_plane_lowres
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: gem_create
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: gem_pxp
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: kms_chamelium_frames
results: parsing output: 37/ for test: kms_setmode
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_ctx_shared
results: parsing output: 42/ for test: kms_hdmi_inject
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: gem_exec_flush
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_writeback
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_fenced_exec_thrash
results: parsing output: 69/ for test: i915_query
results: parsing output: 70/ for test: gem_ppgtt
results: parsing output: 71/ for test: gem_ctx_isolation
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_pm_lpsp
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: i915_pm_rps
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: gem_ctx_param
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_getfb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_draw_crc
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_psr2_su
results: parsing output: 94/ for test: gen9_exec_parse
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_flip_scaled_crc
results: parsing output: 101/ for test: kms_color
results: parsing output: 102/ for test: kms_atomic
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: gem_exec_capture
results: parsing output: 111/ for test: kms_cursor_edge_walk
results: parsing output: 112/ for test: kms_legacy_colorkey
results: parsing output: 113/ for test: gem_caching
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_basic
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_feature_discovery
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_invalid_mode
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: gem_mmap_offset
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: prime_mmap
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: sysfs_preempt_timeout
results: parsing output: 130/ for test: kms_chamelium_hpd
Done.