[58.938197] Initializing watchdogs
[58.938320]   /dev/watchdog0
[58.953601] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.958446] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.960974] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.964394] [001/133] (960s left) kms_flip (flip-vs-expired-vblank-interruptible)
[59.097470] Starting subtest: flip-vs-expired-vblank-interruptible
[59.099748] Starting dynamic subtest: A-eDP1
[67.834197] Dynamic subtest A-eDP1: SUCCESS (8.737s)
[67.842530] Starting dynamic subtest: B-eDP1
[76.473950] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[76.483756] Starting dynamic subtest: C-eDP1
[85.094942] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[85.105719] Starting dynamic subtest: D-eDP1
[93.718479] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[93.720378] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.626s)
[94.878180] [002/133] (924s left) kms_pm_rpm (modeset-lpsp)
[97.116650] Starting subtest: modeset-lpsp
[98.565164] Subtest modeset-lpsp: SUCCESS (1.452s)
[98.663111] [003/133] (920s left) gem_exec_schedule (preempt-user)
[98.741841] Starting subtest: preempt-user
[98.744047] Starting dynamic subtest: rcs0
[98.764142] Dynamic subtest rcs0: SUCCESS (0.025s)
[98.771868] Starting dynamic subtest: bcs0
[98.783799] Dynamic subtest bcs0: SUCCESS (0.019s)
[98.792164] Starting dynamic subtest: vcs0
[98.812904] Dynamic subtest vcs0: SUCCESS (0.029s)
[98.820378] Starting dynamic subtest: vcs1
[98.833041] Dynamic subtest vcs1: SUCCESS (0.020s)
[98.840470] Starting dynamic subtest: vecs0
[98.853475] Dynamic subtest vecs0: SUCCESS (0.020s)
[98.860849] Starting dynamic subtest: ccs0
[98.875195] Dynamic subtest ccs0: SUCCESS (0.021s)
[98.877468] Subtest preempt-user: SUCCESS (0.136s)
[99.994488] [004/133] (919s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[100.053993] Starting subtest: single-wait-for-submit-available-submitted
[100.056278] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[100.144930] [005/133] (919s left) kms_cursor_crc (cursor-random-128x42)
[100.378580] Starting subtest: cursor-random-128x42
[100.424708] Subtest cursor-random-128x42: SKIP (0.043s)
[100.634349] [006/133] (919s left) gem_tiled_wc
[100.760877] [007/133] (918s left) kms_plane (pixel-format-yf-tiled-modifier)
[100.849186] Starting subtest: pixel-format-yf-tiled-modifier
[100.853510] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[100.920219] [008/133] (918s left) kms_psr (psr2-cursor-mmap-cpu)
[101.019554] Starting subtest: psr2-cursor-mmap-cpu
[101.021626] Starting dynamic subtest: eDP-1
[102.701348] Dynamic subtest eDP-1: SUCCESS (1.681s)
[102.703263] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.681s)
[103.501290] [009/133] (916s left) gem_exec_reloc (basic-cpu-read-noreloc)
[103.561247] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[103.631759] [010/133] (916s left) perf_pmu (invalid-open)
[103.674940] Starting subtest: invalid-open
[103.677187] Subtest invalid-open: SUCCESS (0.000s)
[103.781700] [011/133] (916s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[103.902030] Starting subtest: cursorA-vs-flipA-atomic
[115.030359] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.126s)
[115.830570] [012/133] (904s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[115.936905] Starting subtest: 4-tiled-8bpp-rotate-270
[115.956595] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[116.084563] [013/133] (903s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[116.181503] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[116.185698] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[116.259378] [014/133] (903s left) sysfs_heartbeat_interval (idempotent)
[116.324985] Starting subtest: idempotent
[116.327432] Starting dynamic subtest: vecs0
[116.329662] Dynamic subtest vecs0: SUCCESS (0.001s)
[116.338069] Starting dynamic subtest: ccs0
[116.340605] Dynamic subtest ccs0: SUCCESS (0.001s)
[116.352536] Starting dynamic subtest: vcs0
[116.354500] Dynamic subtest vcs0: SUCCESS (0.000s)
[116.364858] Starting dynamic subtest: bcs0
[116.366866] Dynamic subtest bcs0: SUCCESS (0.000s)
[116.378875] Starting dynamic subtest: rcs0
[116.380928] Dynamic subtest rcs0: SUCCESS (0.000s)
[116.391518] Starting dynamic subtest: vcs1
[116.393706] Dynamic subtest vcs1: SUCCESS (0.000s)
[116.395890] Subtest idempotent: SUCCESS (0.005s)
[116.444385] [015/133] (903s left) prime_vgem (sync)
[116.558679] Starting subtest: sync
[116.560594] Starting dynamic subtest: rcs0
[116.590187] Dynamic subtest rcs0: SUCCESS (0.034s)
[116.597839] Starting dynamic subtest: bcs0
[116.647530] Dynamic subtest bcs0: SUCCESS (0.057s)
[116.654984] Starting dynamic subtest: vcs0
[116.695762] Dynamic subtest vcs0: SUCCESS (0.048s)
[116.703069] Starting dynamic subtest: vcs1
[116.742622] Dynamic subtest vcs1: SUCCESS (0.046s)
[116.749950] Starting dynamic subtest: vecs0
[116.789819] Dynamic subtest vecs0: SUCCESS (0.047s)
[116.796859] Starting dynamic subtest: ccs0
[116.836158] Dynamic subtest ccs0: SUCCESS (0.046s)
[116.837944] Subtest sync: SUCCESS (0.280s)
[116.945716] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[116.948466] [016/133] (903s left) gem_flink_basic (basic)
[117.006311] Starting subtest: basic
[117.008203] Subtest basic: SUCCESS (0.000s)
[117.115463] [017/133] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[117.211295] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[117.214826] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[117.305216] [018/133] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[117.415038] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[117.418680] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[117.518217] [019/133] (902s left) core_getversion (basic)
[117.556930] Starting subtest: basic
[117.560613] Subtest basic: SUCCESS (0.000s)
[117.618719] [020/133] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[117.708676] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[117.711993] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[117.796674] [021/133] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[117.890450] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[125.298140] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.410s)
[125.421699] [022/133] (894s left) syncobj_timeline (invalid-signal-bad-pad)
[125.491361] Starting subtest: invalid-signal-bad-pad
[125.493731] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[125.594454] [023/133] (894s left) kms_psr (fbc-psr2-primary-blt)
[125.684078] Starting subtest: fbc-psr2-primary-blt
[125.686046] Starting dynamic subtest: eDP-1
[125.690202] Dynamic subtest eDP-1: SKIP (0.000s)
[125.694290] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[125.753991] [024/133] (894s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[125.873032] Starting subtest: basic-busy-flip-before-cursor-legacy
[125.877623] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[126.018887] [025/133] (894s left) fbdev (write)
[126.056871] Starting subtest: write
[126.725369] Subtest write: SUCCESS (0.666s)
[126.808678] [026/133] (893s left) gem_ppgtt (shrink-vs-evict-any)
[126.875571] Starting subtest: shrink-vs-evict-any
[132.906852] Subtest shrink-vs-evict-any: SUCCESS (6.030s)
[132.999741] [027/133] (887s left) perf (global-sseu-config)
[133.117966] Starting subtest: global-sseu-config
[133.122061] Subtest global-sseu-config: SKIP (0.000s)
[133.170518] [028/133] (887s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[133.283483] Starting subtest: x-tiled-64bpp-rotate-90
[133.304308] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[133.417356] [029/133] (887s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[133.541414] Starting subtest: flip-vs-cursor-crc-legacy
[134.213560] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.672s)
[135.027119] [030/133] (885s left) gem_ctx_isolation (clean)
[135.088733] Starting subtest: clean
[135.091128] Starting dynamic subtest: rcs0
[135.140879] Dynamic subtest rcs0: SUCCESS (0.052s)
[135.151235] Starting dynamic subtest: bcs0
[135.196083] Dynamic subtest bcs0: SUCCESS (0.054s)
[135.206241] Starting dynamic subtest: vcs0
[135.278461] Dynamic subtest vcs0: SUCCESS (0.082s)
[135.289060] Starting dynamic subtest: vcs1
[136.949069] Dynamic subtest vcs1: SUCCESS (1.670s)
[136.958553] Starting dynamic subtest: vecs0
[138.901913] Dynamic subtest vecs0: SUCCESS (1.952s)
[138.912206] Starting dynamic subtest: ccs0
[140.890517] Dynamic subtest ccs0: SUCCESS (1.988s)
[140.892907] Subtest clean: SUCCESS (5.802s)
[141.140313] [031/133] (879s left) gem_pxp (reject-modify-context-protection-off-3)
[141.272397] Starting subtest: reject-modify-context-protection-off-3
[141.274927] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[141.379983] [032/133] (879s left) api_intel_bb (intel-bb-blit-x)
[141.431772] Starting subtest: intel-bb-blit-x
[144.973081] Subtest intel-bb-blit-x: SUCCESS (3.540s)
[145.088546] [033/133] (875s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[145.180355] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[145.184800] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[145.278863] [034/133] (875s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[145.389996] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[154.067216] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.681s)
[154.179167] [035/133] (866s left) vgem_basic (dmabuf-fence-before)
[154.221213] Starting subtest: dmabuf-fence-before
[154.223087] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[154.277204] [036/133] (866s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[154.368272] Starting subtest: plane-lut1d-pre-ctm3x4
[154.493686] Starting dynamic subtest: pipe-A-plane-0
[154.842248] Dynamic subtest pipe-A-plane-0: FAIL (0.177s)
[154.851996] Starting dynamic subtest: pipe-A-plane-1
[155.056833] Dynamic subtest pipe-A-plane-1: FAIL (0.164s)
[155.066298] Starting dynamic subtest: pipe-A-plane-2
[155.277441] Dynamic subtest pipe-A-plane-2: FAIL (0.167s)
[156.233583] Starting dynamic subtest: pipe-B-plane-0
[156.659720] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[156.669595] Starting dynamic subtest: pipe-B-plane-1
[156.973667] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[156.985252] Starting dynamic subtest: pipe-B-plane-2
[157.280559] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[157.947520] Starting dynamic subtest: pipe-C-plane-0
[158.459291] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[158.470120] Starting dynamic subtest: pipe-C-plane-1
[158.872149] Dynamic subtest pipe-C-plane-1: FAIL (0.616s)
[158.881643] Starting dynamic subtest: pipe-C-plane-2
[159.250732] Dynamic subtest pipe-C-plane-2: FAIL (0.163s)
[160.101801] Starting dynamic subtest: pipe-D-plane-0
[160.699114] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[160.708641] Starting dynamic subtest: pipe-D-plane-1
[161.161730] Dynamic subtest pipe-D-plane-1: FAIL (0.600s)
[161.171980] Starting dynamic subtest: pipe-D-plane-2
[161.612576] Dynamic subtest pipe-D-plane-2: FAIL (0.565s)
[161.717105] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.349s)
[162.556865] [037/133] (858s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[162.641868] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[162.646388] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[163.814445] [038/133] (857s left) gem_exec_fence (syncobj-unused-fence)
[164.256114] Starting subtest: syncobj-unused-fence
[164.260712] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[165.989959] [039/133] (854s left) syncobj_wait (signal)
[166.042420] Starting subtest: signal
[166.044771] Subtest signal: SUCCESS (0.000s)
[166.137041] [040/133] (854s left) kms_plane (plane-panning-top-left)
[166.221802] Starting subtest: plane-panning-top-left
[166.224154] Starting dynamic subtest: pipe-A
[167.929529] Dynamic subtest pipe-A: SUCCESS (1.704s)
[167.939259] Starting dynamic subtest: pipe-B
[170.307597] Dynamic subtest pipe-B: SUCCESS (2.377s)
[170.309483] Subtest plane-panning-top-left: SUCCESS (4.083s)
[171.107304] [041/133] (849s left) api_intel_allocator (reserve-simple)
[171.158863] Starting subtest: reserve-simple
[171.161258] Subtest reserve-simple: SUCCESS (0.003s)
[171.295298] [042/133] (849s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[171.413966] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[171.418372] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[171.558087] [043/133] (849s left) gem_eio (in-flight-contexts-10ms)
[171.791370] Starting subtest: in-flight-contexts-10ms
[184.941508] Subtest in-flight-contexts-10ms: SUCCESS (13.149s)
[185.074331] [044/133] (836s left) gem_ctx_sseu (invalid-args)
[185.136792] Subtest invalid-args: SKIP (0.000s)
[185.214896] [045/133] (836s left) kms_plane_cursor (primary)
[185.301961] Starting subtest: primary
[185.306420] Starting dynamic subtest: pipe-A-eDP-1-size-64
[187.866082] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.564s)
[187.890067] Starting dynamic subtest: pipe-A-eDP-1-size-128
[190.434143] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[190.457166] Starting dynamic subtest: pipe-A-eDP-1-size-256
[192.979235] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s)
[193.290970] Starting dynamic subtest: pipe-B-eDP-1-size-64
[196.596493] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.314s)
[196.620241] Starting dynamic subtest: pipe-B-eDP-1-size-128
[199.163847] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[199.187486] Starting dynamic subtest: pipe-B-eDP-1-size-256
[201.721078] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[202.034942] Starting dynamic subtest: pipe-C-eDP-1-size-64
[205.011040] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.987s)
[205.037285] Starting dynamic subtest: pipe-C-eDP-1-size-128
[207.245319] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[207.271382] Starting dynamic subtest: pipe-C-eDP-1-size-256
[209.490516] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[209.814348] Starting dynamic subtest: pipe-D-eDP-1-size-64
[212.662116] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.858s)
[212.688155] Starting dynamic subtest: pipe-D-eDP-1-size-128
[214.873024] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[214.898882] Starting dynamic subtest: pipe-D-eDP-1-size-256
[217.084287] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[217.391342] Subtest primary: SUCCESS (32.088s)
[218.246456] [046/133] (803s left) kms_vblank (ts-continuation-idle)
[218.343266] Starting subtest: ts-continuation-idle
[218.345479] Starting dynamic subtest: pipe-A-eDP-1
[218.768331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[218.782385] Starting dynamic subtest: pipe-D-eDP-1
[219.824818] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.053s)
[219.827087] Subtest ts-continuation-idle: SUCCESS (1.484s)
[220.693072] [047/133] (800s left) kms_atomic_interruptible (legacy-cursor)
[220.800990] Starting subtest: legacy-cursor
[220.803318] Starting dynamic subtest: pipe-A-eDP-1
[228.202273] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.401s)
[228.204695] Subtest legacy-cursor: SUCCESS (7.403s)
[229.087920] [048/133] (792s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[229.205851] Starting subtest: flip-vs-cursor-busy-crc-atomic
[230.018397] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.813s)
[230.871426] [049/133] (790s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[230.963771] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[230.966062] Starting dynamic subtest: pipe-A-eDP-1
[230.988086] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.997105] Starting dynamic subtest: pipe-B-eDP-1
[231.017793] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.026221] Starting dynamic subtest: pipe-C-eDP-1
[231.046758] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.056822] Starting dynamic subtest: pipe-D-eDP-1
[231.078144] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.082350] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[233.244251] [050/133] (788s left) kms_big_fb (linear-64bpp-rotate-270)
[233.355807] Starting subtest: linear-64bpp-rotate-270
[233.377307] Subtest linear-64bpp-rotate-270: SKIP (0.021s)
[233.506093] [051/133] (788s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[233.581193] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[233.585593] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[233.767346] [052/133] (787s left) kms_psr (fbc-pr-basic)
[233.867525] Starting subtest: fbc-pr-basic
[233.871781] Subtest fbc-pr-basic: SKIP (0.000s)
[233.940636] [053/133] (787s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[234.041241] Starting subtest: async-flip-with-page-flip-events-tiled
[234.422718] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[237.197994] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[237.208633] Starting dynamic subtest: pipe-A-eDP-1-4
[239.383787] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[239.392729] Starting dynamic subtest: pipe-A-eDP-1-4
[241.393623] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[241.402413] Starting dynamic subtest: pipe-A-eDP-1-x
[243.584643] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[243.955791] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[246.732847] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[246.741680] Starting dynamic subtest: pipe-B-eDP-1-4
[248.918989] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[248.930599] Starting dynamic subtest: pipe-B-eDP-1-4
[250.929535] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[250.938607] Starting dynamic subtest: pipe-B-eDP-1-x
[253.140990] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.211s)
[253.505959] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[256.259707] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[256.269744] Starting dynamic subtest: pipe-C-eDP-1-4
[258.435031] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[258.446054] Starting dynamic subtest: pipe-C-eDP-1-4
[260.445351] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[260.454678] Starting dynamic subtest: pipe-C-eDP-1-x
[262.624297] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[263.012541] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[265.794892] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[265.804344] Starting dynamic subtest: pipe-D-eDP-1-4
[267.969988] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[267.979152] Starting dynamic subtest: pipe-D-eDP-1-4
[269.980784] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[269.990088] Starting dynamic subtest: pipe-D-eDP-1-x
[272.181354] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.199s)
[272.183973] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.138s)
[273.385365] [054/133] (748s left) kms_properties (connector-properties-atomic)
[273.468301] Starting subtest: connector-properties-atomic
[273.470534] Starting dynamic subtest: pipe-A-eDP-1
[281.212875] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.742s)
[281.221874] Starting dynamic subtest: pipe-None-DP-1
[281.226130] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[281.233835] Starting dynamic subtest: pipe-None-HDMI-A-1
[281.237691] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[281.246088] Starting dynamic subtest: pipe-None-DP-2
[281.250337] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[281.258331] Starting dynamic subtest: pipe-None-HDMI-A-2
[281.262677] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[281.270810] Starting dynamic subtest: pipe-None-DP-3
[281.275233] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[281.283245] Starting dynamic subtest: pipe-None-DP-4
[281.287616] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[281.289832] Subtest connector-properties-atomic: SUCCESS (7.755s)
[282.084919] [055/133] (739s left) kms_psr (psr-suspend)
[282.170504] Starting subtest: psr-suspend
[282.172872] Starting dynamic subtest: eDP-1
[299.831248] Dynamic subtest eDP-1: SUCCESS (3.012s)
[299.833336] Subtest psr-suspend: SUCCESS (3.013s)
[300.695370] [056/133] (721s left) kms_chamelium_edid (dp-mode-timings)
[301.108010] Subtest dp-mode-timings: SKIP (0.000s)
[301.926425] [057/133] (719s left) kms_hdr (static-toggle-suspend)
[302.035507] Starting subtest: static-toggle-suspend
[302.042046] Subtest static-toggle-suspend: SKIP (0.000s)
[302.109238] [058/133] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[302.207237] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[309.310034] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.106s)
[309.436369] [059/133] (712s left) kms_flip (wf_vblank-ts-check-interruptible)
[309.538176] Starting subtest: wf_vblank-ts-check-interruptible
[309.540420] Starting dynamic subtest: A-eDP1
[318.406204] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[318.419794] Starting dynamic subtest: B-eDP1
[327.336806] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[327.349099] Starting dynamic subtest: C-eDP1
[336.262805] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[336.272326] Starting dynamic subtest: D-eDP1
[345.197081] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[345.201973] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.662s)
[346.445713] [060/133] (675s left) gem_media_vme
[346.593974] [061/133] (675s left) gem_wait (write-busy)
[346.672215] Starting subtest: write-busy
[346.674594] Starting dynamic subtest: all-engines
[347.256961] Dynamic subtest all-engines: SUCCESS (0.584s)
[347.273301] Starting dynamic subtest: rcs0
[347.815849] Dynamic subtest rcs0: SUCCESS (0.557s)
[347.833356] Starting dynamic subtest: bcs0
[348.366685] Dynamic subtest bcs0: SUCCESS (0.550s)
[348.384326] Starting dynamic subtest: vcs0
[349.580103] Dynamic subtest vcs0: SUCCESS (1.211s)
[349.596503] Starting dynamic subtest: vcs1
[351.563238] Dynamic subtest vcs1: SUCCESS (1.980s)
[351.581089] Starting dynamic subtest: vecs0
[353.547198] Dynamic subtest vecs0: SUCCESS (1.980s)
[353.564416] Starting dynamic subtest: ccs0
[354.100114] Dynamic subtest ccs0: SUCCESS (0.551s)
[354.102685] Subtest write-busy: SUCCESS (7.428s)
[354.300959] [062/133] (667s left) gem_gpgpu_fill (offset-16x16)
[354.369927] Starting subtest: offset-16x16
[354.381677] Subtest offset-16x16: SUCCESS (0.013s)
[354.544629] [063/133] (667s left) gem_shrink (reclaim)
[354.614946] Starting subtest: reclaim
[357.084925] Subtest reclaim: SUCCESS (2.466s)
[357.235106] [064/133] (664s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[357.332577] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[361.474468] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.144s)
[362.642334] [065/133] (659s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[362.735339] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[362.737688] Starting dynamic subtest: pipe-A-eDP-1
[362.759166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[362.770448] Starting dynamic subtest: pipe-B-eDP-1
[362.790964] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[362.800229] Starting dynamic subtest: pipe-C-eDP-1
[362.820832] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[362.830036] Starting dynamic subtest: pipe-D-eDP-1
[362.849557] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[362.851811] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[364.917259] [066/133] (657s left) gen3_render_linear_blits
[365.035891] [067/133] (657s left) kms_hdr (bpc-switch-dpms)
[365.148095] Starting subtest: bpc-switch-dpms
[366.174053] Starting dynamic subtest: pipe-A-eDP-1
[370.582803] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.411s)
[370.585013] Subtest bpc-switch-dpms: SUCCESS (5.437s)
[370.684168] [068/133] (651s left) i915_pm_freq_api (freq-reset)
[370.754207] Starting subtest: freq-reset
[370.756512] Starting dynamic subtest: gt0
[370.927068] Dynamic subtest gt0: SUCCESS (0.173s)
[370.936529] Starting dynamic subtest: gt1
[371.087182] Dynamic subtest gt1: SUCCESS (0.159s)
[371.089720] Subtest freq-reset: SUCCESS (0.335s)
[371.165487] [069/133] (651s left) gem_userptr_blits (access-control)
[371.252812] Starting subtest: access-control
[371.257356] Subtest access-control: SKIP (0.000s)
[371.370912] [070/133] (650s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[371.461857] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[371.466487] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.553025] [071/133] (650s left) gem_mmap_offset (mmap-unmap)
[371.615830] Starting subtest: mmap-unmap
[371.618005] Starting dynamic subtest: smem0
[395.387663] Dynamic subtest smem0: SUCCESS (23.771s)
[395.390402] Subtest mmap-unmap: SUCCESS (23.772s)
[395.495398] [072/133] (626s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[395.551996] Starting subtest: legacy-engines-hostile-preempt
[395.554321] Starting dynamic subtest: render
[395.613378] Dynamic subtest render: SUCCESS (0.061s)
[395.624693] Starting dynamic subtest: bsd1
[397.553921] Dynamic subtest bsd1: SUCCESS (1.936s)
[397.565961] Starting dynamic subtest: bsd2
[399.537213] Dynamic subtest bsd2: SUCCESS (1.980s)
[399.549487] Starting dynamic subtest: blt
[399.606613] Dynamic subtest blt: SUCCESS (0.067s)
[399.621773] Starting dynamic subtest: vebox
[401.545831] Dynamic subtest vebox: SUCCESS (1.935s)
[401.548440] Subtest legacy-engines-hostile-preempt: SUCCESS (5.994s)
[401.639618] [073/133] (620s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[401.764266] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[410.952507] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.188s)
[411.769491] [074/133] (610s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[411.887573] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[412.943510] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.057s)
[413.056176] [075/133] (609s left) syncobj_basic (bad-pad-fd-to-handle)
[413.108706] Starting subtest: bad-pad-fd-to-handle
[413.110346] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[413.213707] [076/133] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[413.318247] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[416.807797] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.491s)
[417.973638] [077/133] (604s left) kms_flip_event_leak (basic)
[418.072481] Starting subtest: basic
[418.074485] Starting dynamic subtest: pipe-A-eDP-1
[418.493843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[418.503749] Starting dynamic subtest: pipe-B-eDP-1
[419.587034] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[419.596642] Starting dynamic subtest: pipe-C-eDP-1
[420.694681] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[420.705077] Starting dynamic subtest: pipe-D-eDP-1
[421.826957] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[421.829188] Subtest basic: SUCCESS (3.757s)
[422.699164] [078/133] (599s left) kms_atomic_transition (modeset-transition)
[422.802215] Starting subtest: modeset-transition
[422.804526] Starting dynamic subtest: 1x-outputs
[433.639804] Dynamic subtest 1x-outputs: SUCCESS (10.838s)
[433.642423] Subtest modeset-transition: SUCCESS (10.840s)
[434.490478] [079/133] (588s left) kms_content_protection (atomic-hdcp14)
[434.642929] Starting subtest: atomic-hdcp14
[434.647524] Subtest atomic-hdcp14: SKIP (0.000s)
[434.782275] [080/133] (587s left) kms_prop_blob (blob-prop-lifetime)
[434.831522] Starting subtest: blob-prop-lifetime
[434.833712] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[434.926910] [081/133] (587s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[435.314119] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[436.107533] [082/133] (586s left) gem_tiled_blits (interruptible)
[436.169170] Subtest interruptible: SKIP (0.000s)
[436.257105] [083/133] (586s left) syncobj_wait (wait-for-submit-complex)
[436.315863] Starting subtest: wait-for-submit-complex
[436.376576] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[436.453894] [084/133] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[436.542154] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[443.450944] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.907s)
[443.601287] [085/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[443.697952] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[443.702138] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[443.796139] [086/133] (579s left) gem_create (create-ext-cpu-access-sanity-check)
[443.958981] Starting subtest: create-ext-cpu-access-sanity-check
[443.964411] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[444.039318] [087/133] (579s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[444.087344] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[444.089546] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[444.204032] [088/133] (578s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[444.264445] Starting subtest: etime-single-wait-available-unsubmitted
[444.367975] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s)
[444.446051] [089/133] (578s left) i915_query (query-regions-garbage-items)
[444.509056] Starting subtest: query-regions-garbage-items
[444.511364] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[444.603897] [090/133] (578s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[444.728170] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[462.183650] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.454s)
[462.983049] [091/133] (560s left) gem_exec_schedule (noreorder)
[463.160824] Starting subtest: noreorder
[463.163179] Starting dynamic subtest: rcs0
[463.235794] Dynamic subtest rcs0: SUCCESS (0.076s)
[463.253397] Starting dynamic subtest: vcs0
[464.589551] Dynamic subtest vcs0: SUCCESS (1.350s)
[464.602093] Starting dynamic subtest: vcs1
[466.545740] Dynamic subtest vcs1: SUCCESS (1.953s)
[466.561354] Starting dynamic subtest: vecs0
[468.551475] Dynamic subtest vecs0: SUCCESS (2.003s)
[468.563959] Starting dynamic subtest: ccs0
[468.632862] Dynamic subtest ccs0: SUCCESS (0.080s)
[468.635550] Subtest noreorder: SUCCESS (5.475s)
[468.823209] [092/133] (554s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[468.941034] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[468.943348] Starting dynamic subtest: pipe-A
[468.965188] Dynamic subtest pipe-A: SKIP (0.018s)
[468.974682] Starting dynamic subtest: pipe-B
[468.995287] Dynamic subtest pipe-B: SKIP (0.031s)
[469.004493] Starting dynamic subtest: pipe-C
[469.026547] Dynamic subtest pipe-C: SKIP (0.031s)
[469.035500] Starting dynamic subtest: pipe-D
[469.055143] Dynamic subtest pipe-D: SKIP (0.030s)
[469.059413] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.112s)
[469.156506] [093/133] (554s left) kms_lease (multimaster-lease)
[469.247528] Starting subtest: multimaster-lease
[469.249638] Subtest multimaster-lease: SUCCESS (0.003s)
[469.359492] [094/133] (553s left) kms_pm_dc (dc6-psr)
[470.455943] Starting subtest: dc6-psr
[473.346313] Subtest dc6-psr: SUCCESS (2.889s)
[474.214843] [095/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[474.309238] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[474.313200] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[474.404826] [096/133] (549s left) gem_exec_capture (pi)
[474.462192] Starting subtest: pi
[474.464529] Starting dynamic subtest: rcs0
[478.777733] Dynamic subtest rcs0: SUCCESS (4.317s)
[478.789968] Starting dynamic subtest: bcs0
[482.735958] Dynamic subtest bcs0: SUCCESS (3.956s)
[482.745590] Starting dynamic subtest: vcs0
[486.649663] Dynamic subtest vcs0: SUCCESS (3.911s)
[486.661944] Starting dynamic subtest: vcs1
[490.564029] Dynamic subtest vcs1: SUCCESS (3.914s)
[490.573987] Starting dynamic subtest: vecs0
[494.495800] Dynamic subtest vecs0: SUCCESS (3.929s)
[494.507813] Starting dynamic subtest: ccs0
[498.488341] Dynamic subtest ccs0: SUCCESS (3.991s)
[498.490541] Subtest pi: SUCCESS (24.029s)
[498.569049] [097/133] (524s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[498.681078] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[498.683796] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[498.757130] [098/133] (524s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[498.813007] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[498.815337] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[498.919067] [099/133] (524s left) kms_panel_fitting (legacy)
[499.025104] Starting subtest: legacy
[499.027415] Starting dynamic subtest: pipe-A-eDP-1
[499.585894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[499.614022] Starting dynamic subtest: pipe-B-eDP-1
[501.170362] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s)
[501.200437] Starting dynamic subtest: pipe-C-eDP-1
[502.689253] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.497s)
[502.716540] Starting dynamic subtest: pipe-D-eDP-1
[504.202164] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.493s)
[504.204496] Subtest legacy: SUCCESS (5.179s)
[505.437256] [100/133] (518s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[505.542198] Starting subtest: pr-cursor-plane-move-continuous-sf
[505.546931] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[505.610639] [101/133] (518s left) kms_flip (2x-modeset-vs-vblank-race)
[505.709116] Starting subtest: 2x-modeset-vs-vblank-race
[505.720321] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[505.799658] [102/133] (517s left) sw_sync (sync_multi_producer_single_consumer)
[505.840977] Starting subtest: sync_multi_producer_single_consumer
[506.912273] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[506.973508] [103/133] (516s left) i915_pm_rpm (gem-execbuf)
[508.716580] Starting subtest: gem-execbuf
[508.718772] Starting dynamic subtest: smem0
[510.249960] Dynamic subtest smem0: SUCCESS (1.535s)
[510.252251] Subtest gem-execbuf: SUCCESS (1.537s)
[510.339801] [104/133] (513s left) kms_flip (dpms-vs-vblank-race)
[510.442927] Starting subtest: dpms-vs-vblank-race
[510.445130] Starting dynamic subtest: A-eDP1
[515.388798] Dynamic subtest A-eDP1: SUCCESS (4.943s)
[515.398602] Starting dynamic subtest: B-eDP1
[518.898305] Dynamic subtest B-eDP1: SUCCESS (3.509s)
[518.908224] Starting dynamic subtest: C-eDP1
[523.505267] Dynamic subtest C-eDP1: SUCCESS (4.603s)
[523.515926] Starting dynamic subtest: D-eDP1
[528.137069] Dynamic subtest D-eDP1: SUCCESS (4.626s)
[528.139509] Subtest dpms-vs-vblank-race: SUCCESS (17.695s)
[529.015894] [105/133] (494s left) gem_spin_batch (resubmit-all)
[529.084041] Starting subtest: resubmit-all
[529.086417] Starting dynamic subtest: rcs0
[529.094448] Dynamic subtest rcs0: SUCCESS (0.010s)
[529.106155] Starting dynamic subtest: bcs0
[529.108536] Dynamic subtest bcs0: SUCCESS (0.002s)
[529.118362] Starting dynamic subtest: vcs0
[529.120278] Dynamic subtest vcs0: SUCCESS (0.002s)
[529.129377] Starting dynamic subtest: vcs1
[529.131280] Dynamic subtest vcs1: SUCCESS (0.002s)
[529.140571] Starting dynamic subtest: vecs0
[529.142521] Dynamic subtest vecs0: SUCCESS (0.002s)
[529.151536] Starting dynamic subtest: ccs0
[529.153457] Dynamic subtest ccs0: SUCCESS (0.002s)
[529.155380] Subtest resubmit-all: SUCCESS (0.025s)
[530.611648] [106/133] (493s left) gem_exec_balancer (full)
[530.671521] Starting subtest: full
[535.449787] Subtest full: SUCCESS (4.778s)
[535.760741] [107/133] (488s left) gem_exec_fence (syncobj-channel)
[536.224106] Starting subtest: syncobj-channel
[537.245213] Subtest syncobj-channel: SUCCESS (1.017s)
[537.635988] [108/133] (486s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[537.756956] Starting subtest: flip-vs-cursor-atomic
[544.961825] Subtest flip-vs-cursor-atomic: SUCCESS (7.201s)
[545.757302] [109/133] (478s left) gem_madvise (dontneed-after-mmap)
[545.796808] Starting subtest: dontneed-after-mmap
[545.821199] Subtest dontneed-after-mmap: SUCCESS (0.026s)
[545.922053] [110/133] (478s left) i915_query (query-topology-matches-eu-total)
[545.974295] Starting subtest: query-topology-matches-eu-total
[545.976205] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[546.057660] [111/133] (478s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[546.155489] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[546.159931] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[546.260275] [112/133] (477s left) i915_drm_fdinfo (memory-info-active)
[546.313445] Starting subtest: memory-info-active
[546.315746] Starting dynamic subtest: smem0
[549.128594] Dynamic subtest smem0: SUCCESS (2.814s)
[549.131253] Subtest memory-info-active: SUCCESS (2.816s)
[549.204545] [113/133] (474s left) kms_cursor_edge_walk (128x128-right-edge)
[549.305303] Starting subtest: 128x128-right-edge
[549.307202] Starting dynamic subtest: pipe-A-eDP-1
[552.743151] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[552.757775] Starting dynamic subtest: pipe-D-eDP-1
[555.871425] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[555.873739] Subtest 128x128-right-edge: SUCCESS (6.566s)
[556.666131] [114/133] (467s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[556.759019] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[556.851019] [115/133] (467s left) kms_cursor_crc (cursor-offscreen-32x32)
[556.999627] Starting subtest: cursor-offscreen-32x32
[557.048738] Subtest cursor-offscreen-32x32: SKIP (0.045s)
[557.362119] [116/133] (466s left) gem_exec_reloc (basic-gtt-read)
[557.426731] Subtest basic-gtt-read: SKIP (0.000s)
[557.498819] [117/133] (466s left) gem_exec_flush (basic-wb-rw-before-default)
[557.559198] Starting subtest: basic-wb-rw-before-default
[563.011532] Subtest basic-wb-rw-before-default: SUCCESS (5.453s)
[563.220730] [118/133] (461s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[563.335571] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[563.339661] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[563.451166] [119/133] (460s left) kms_feature_discovery (display-4x)
[563.545212] Starting subtest: display-4x
[563.549624] Subtest display-4x: SKIP (0.000s)
[563.619098] [120/133] (460s left) sw_sync (alloc_timeline)
[563.659505] Starting subtest: alloc_timeline
[563.661794] Subtest alloc_timeline: SUCCESS (0.000s)
[563.721136] [121/133] (460s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[563.820783] Starting subtest: fbc-psr-sprite-mmap-gtt
[563.823025] Starting dynamic subtest: eDP-1
[563.827044] Dynamic subtest eDP-1: SKIP (0.000s)
[563.831076] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[563.898382] [122/133] (460s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[563.948514] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[564.055829] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[564.133153] [123/133] (460s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[564.229952] Starting subtest: y-tiled-32bpp-rotate-270
[564.234059] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[564.326207] [124/133] (460s left) kms_chamelium_audio (dp-audio)
[564.719926] Subtest dp-audio: SKIP (0.000s)
[565.581099] [125/133] (459s left) kms_sequence (queue-busy)
[565.681281] Starting subtest: queue-busy
[565.683507] Starting dynamic subtest: pipe-A-eDP-1
[567.616701] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[567.628369] Starting dynamic subtest: pipe-B-eDP-1
[570.170413] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.552s)
[570.181590] Starting dynamic subtest: pipe-C-eDP-1
[572.807968] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.636s)
[572.819233] Starting dynamic subtest: pipe-D-eDP-1
[575.337473] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.528s)
[575.339820] Subtest queue-busy: SUCCESS (9.658s)
[576.227173] [126/133] (448s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[576.325683] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[583.336739] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.012s)
[583.438217] [127/133] (441s left) gen9_exec_parse (allowed-all)
[583.508397] Subtest allowed-all: SKIP (0.000s)
[583.587311] [128/133] (441s left) gem_exec_whisper (basic-fds-forked-all)
[583.655939] Starting subtest: basic-fds-forked-all
[604.176686] Subtest basic-fds-forked-all: SUCCESS (20.518s)
[604.362697] [129/133] (420s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[604.457938] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[604.460142] Starting dynamic subtest: pipe-A-eDP-1
[604.484949] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[604.498432] Starting dynamic subtest: pipe-B-eDP-1
[604.522034] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[604.531541] Starting dynamic subtest: pipe-C-eDP-1
[604.556096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[604.566983] Starting dynamic subtest: pipe-D-eDP-1
[604.589950] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[604.594037] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[606.627094] [130/133] (418s left) kms_pipe_crc_basic (suspend-read-crc)
[606.720207] Starting subtest: suspend-read-crc
[606.722442] Starting dynamic subtest: pipe-A-eDP-1
[624.332159] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.578s)
[624.343178] Starting dynamic subtest: pipe-B-eDP-1
[642.330831] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.101s)
[642.341635] Starting dynamic subtest: pipe-C-eDP-1
[660.267001] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.110s)
[660.278509] Starting dynamic subtest: pipe-D-eDP-1
[678.286865] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.101s)
[678.289283] Subtest suspend-read-crc: SUCCESS (11.896s)
[679.100816] [131/133] (345s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[679.204104] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[679.206630] Starting dynamic subtest: pipe-A-eDP-1
[679.228154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[679.241252] Starting dynamic subtest: pipe-B-eDP-1
[679.260577] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[679.271458] Starting dynamic subtest: pipe-C-eDP-1
[679.291039] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[679.304125] Starting dynamic subtest: pipe-D-eDP-1
[679.325389] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[679.327736] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[681.483998] [132/133] (343s left) kms_psr (psr-cursor-plane-onoff)
[681.581631] Starting subtest: psr-cursor-plane-onoff
[681.583899] Starting dynamic subtest: eDP-1
[683.283163] Dynamic subtest eDP-1: SUCCESS (1.699s)
[683.285664] Subtest psr-cursor-plane-onoff: SUCCESS (1.700s)
[684.159040] [133/133] (340s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[684.255394] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[691.772601] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.514s)
[691.916836] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_tiled_wc
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: sysfs_heartbeat_interval
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: gem_flink_basic
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: core_getversion
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: fbdev
results: parsing output: 25/ for test: gem_ppgtt
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_ctx_isolation
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: kms_color_pipeline
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: api_intel_allocator
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: gem_ctx_sseu
results: parsing output: 44/ for test: kms_plane_cursor
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: kms_atomic_interruptible
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_async_flips
results: parsing output: 53/ for test: kms_properties
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_chamelium_edid
results: parsing output: 56/ for test: kms_hdr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_media_vme
results: parsing output: 60/ for test: gem_wait
results: parsing output: 61/ for test: gem_gpgpu_fill
results: parsing output: 62/ for test: gem_shrink
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gen3_render_linear_blits
results: parsing output: 66/ for test: kms_hdr
results: parsing output: 67/ for test: i915_pm_freq_api
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: syncobj_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_flip_event_leak
results: parsing output: 77/ for test: kms_atomic_transition
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: kms_prop_blob
results: parsing output: 80/ for test: kms_chamelium_hpd
results: parsing output: 81/ for test: gem_tiled_blits
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_create
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: i915_query
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: kms_pm_dc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_capture
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_panel_fitting
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: i915_pm_rpm
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_madvise
results: parsing output: 109/ for test: i915_query
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: i915_drm_fdinfo
results: parsing output: 112/ for test: kms_cursor_edge_walk
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: gem_exec_flush
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_feature_discovery
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_chamelium_audio
results: parsing output: 124/ for test: kms_sequence
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_pipe_crc_basic
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.