[58.154780] Initializing watchdogs
[58.154830]   /dev/watchdog0
[58.170714] [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.175632] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.177855] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.180103] [001/156] (960s left) syncobj_wait (wait-zero-handles)
[58.246466] Starting subtest: wait-zero-handles
[58.247633] Subtest wait-zero-handles: SUCCESS (0.000s)
[58.349450] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[58.455993] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[58.457683] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[58.537537] [003/156] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[58.633181] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[59.328911] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.693s)
[59.494122] [004/156] (959s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[59.588251] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[59.589926] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[59.677428] [005/156] (959s left) gem_softpin (allocator-basic-reserve)
[59.727508] Starting subtest: allocator-basic-reserve
[59.803057] Subtest allocator-basic-reserve: SUCCESS (0.075s)
[59.931025] [006/156] (958s left) core_setmaster (master-drop-set-user)
[60.030430] Starting subtest: master-drop-set-user
[60.044325] Subtest master-drop-set-user: SUCCESS (0.014s)
[60.072838] [007/156] (958s left) gem_ctx_isolation (preservation)
[60.133387] Starting subtest: preservation
[60.134518] Starting dynamic subtest: rcs0
[60.292017] Dynamic subtest rcs0: SUCCESS (0.157s)
[60.300986] Starting dynamic subtest: bcs0
[60.468264] Dynamic subtest bcs0: SUCCESS (0.176s)
[60.478871] Starting dynamic subtest: vcs0
[60.632733] Dynamic subtest vcs0: SUCCESS (0.164s)
[60.639894] Starting dynamic subtest: vcs1
[62.439872] Dynamic subtest vcs1: SUCCESS (1.799s)
[62.446682] Starting dynamic subtest: vecs0
[64.470983] Dynamic subtest vecs0: SUCCESS (2.026s)
[64.479296] Starting dynamic subtest: ccs0
[66.486492] Dynamic subtest ccs0: SUCCESS (2.011s)
[66.488050] Subtest preservation: SUCCESS (6.335s)
[66.714611] [008/156] (952s left) gem_exec_params (secure-non-root)
[66.764600] Starting subtest: secure-non-root
[66.766791] Subtest secure-non-root: SKIP (0.000s)
[66.852452] [009/156] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[66.949649] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[74.550475] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.595s)
[74.656267] [010/156] (944s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[74.744400] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[74.756368] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[74.824154] [011/156] (944s left) perf (invalid-oa-exponent)
[74.941057] Starting subtest: invalid-oa-exponent
[74.954387] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[74.987388] [012/156] (944s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[75.092834] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[75.094487] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[75.178286] [013/156] (943s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[75.264921] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[75.266797] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[75.360795] [014/156] (943s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[75.456700] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[75.458598] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[75.525705] [015/156] (943s left) gem_exec_params (rsvd2-dirt)
[75.576993] Starting subtest: rsvd2-dirt
[75.578970] Subtest rsvd2-dirt: SKIP (0.000s)
[75.686782] [016/156] (943s left) perf_pmu (all-busy-check-all)
[75.719290] Starting subtest: all-busy-check-all
[77.353428] Subtest all-busy-check-all: SUCCESS (1.625s)
[77.426866] [017/156] (941s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[77.536091] Starting subtest: 2x-flip-vs-cursor-legacy
[77.538907] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[77.675786] [018/156] (941s left) gem_workarounds (reset-context)
[77.738466] Starting subtest: reset-context
[77.901570] Subtest reset-context: SUCCESS (0.163s)
[78.043675] [019/156] (941s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[78.125161] Starting subtest: fbc-psr-sprite-mmap-cpu
[78.126031] Starting dynamic subtest: eDP-1
[78.127787] Dynamic subtest eDP-1: SKIP (0.000s)
[78.129331] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[78.190711] [020/156] (941s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[78.279939] Starting subtest: flip-vs-dpms-off-vs-modeset
[78.280921] Starting dynamic subtest: A-eDP1
[82.186370] Dynamic subtest A-eDP1: SUCCESS (3.903s)
[82.195264] Starting dynamic subtest: B-eDP1
[85.580189] Dynamic subtest B-eDP1: SUCCESS (3.393s)
[85.589199] Starting dynamic subtest: C-eDP1
[88.806266] Dynamic subtest C-eDP1: SUCCESS (3.223s)
[88.814965] Starting dynamic subtest: D-eDP1
[92.036022] Dynamic subtest D-eDP1: SUCCESS (3.228s)
[92.038527] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.755s)
[92.832045] [021/156] (926s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[92.920507] Starting subtest: fbc-rgb565-draw-pwrite
[97.639066] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.719s)
[98.857508] [022/156] (920s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[98.955962] Starting subtest: 4-tiled-16bpp-rotate-270
[98.976424] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[99.082618] [023/156] (920s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[99.178584] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[99.180621] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[99.277465] [024/156] (920s left) syncobj_timeline (single-wait-for-submit-signaled)
[99.322395] Starting subtest: single-wait-for-submit-signaled
[99.323265] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[99.387889] [025/156] (920s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[99.475612] Starting subtest: fbc-pr-cursor-mmap-cpu
[99.477476] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[99.544294] [026/156] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[99.644217] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[99.645868] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[99.742184] [027/156] (919s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[99.833987] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[99.835871] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[99.934287] [028/156] (919s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[100.033278] Starting subtest: y-tiled-16bpp-rotate-270
[100.034986] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[100.115392] [029/156] (919s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[100.238023] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[100.239960] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[100.386657] [030/156] (919s left) kms_setmode (basic)
[100.434304] Starting subtest: basic
[100.761031] Starting dynamic subtest: pipe-A-eDP-1
[102.875621] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s)
[103.228903] Starting dynamic subtest: pipe-B-eDP-1
[105.306093] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.075s)
[105.611094] Subtest basic: SUCCESS (5.176s)
[106.432463] [031/156] (913s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[106.524515] Starting subtest: nonblocking-crc-frame-sequence
[106.525508] Starting dynamic subtest: pipe-A-eDP-1
[107.308230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s)
[107.316183] Starting dynamic subtest: pipe-B-eDP-1
[108.767516] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s)
[108.776138] Starting dynamic subtest: pipe-C-eDP-1
[110.128944] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[110.138199] Starting dynamic subtest: pipe-D-eDP-1
[111.557250] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.427s)
[111.558246] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.033s)
[112.360223] [032/156] (907s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[112.415349] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[112.417787] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[112.610174] [033/156] (907s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[112.698927] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[112.700867] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[112.765064] [034/156] (906s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[112.851963] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[115.366930] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.516s)
[116.558323] [035/156] (903s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[116.598558] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[116.599621] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[116.677798] [036/156] (903s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[116.762900] Starting subtest: hdr-1p-pri-indfb-multidraw
[116.764612] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[116.864766] [037/156] (902s left) api_intel_allocator (open-vm)
[116.912478] Starting subtest: open-vm
[116.915055] Subtest open-vm: SUCCESS (0.003s)
[117.025484] [038/156] (902s left) kms_lease (lease-again)
[117.115127] Starting subtest: lease-again
[117.116107] Starting dynamic subtest: pipe-A-eDP-1
[117.119084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[117.128776] Starting dynamic subtest: pipe-B-eDP-1
[117.129625] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[117.137408] Starting dynamic subtest: pipe-C-eDP-1
[117.138264] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[117.145456] Starting dynamic subtest: pipe-D-eDP-1
[117.146322] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[117.147116] Subtest lease-again: SUCCESS (0.011s)
[117.224249] [039/156] (902s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[117.311041] Starting subtest: yf-tiled-8bpp-rotate-90
[117.312840] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[117.409386] [040/156] (902s left) kms_vrr (seamless-rr-switch-vrr)
[117.496416] Starting subtest: seamless-rr-switch-vrr
[117.498716] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[117.560433] [041/156] (902s left) kms_psr (psr-cursor-mmap-gtt)
[117.638253] Starting subtest: psr-cursor-mmap-gtt
[117.639519] Starting dynamic subtest: eDP-1
[119.349853] Dynamic subtest eDP-1: SUCCESS (1.711s)
[119.351089] Subtest psr-cursor-mmap-gtt: SUCCESS (1.712s)
[120.210856] [042/156] (899s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[120.308459] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[120.310419] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[120.402739] [043/156] (899s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[120.458522] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[120.565022] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[120.634564] [044/156] (899s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[120.752159] Starting subtest: basic-busy-flip-before-cursor-varying-size
[120.753879] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[120.897655] [045/156] (899s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[120.953521] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[120.995367] [046/156] (899s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[121.082497] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[121.084276] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[121.177945] [047/156] (898s left) gem_ctx_persistence (heartbeat-hostile)
[121.234518] Starting subtest: heartbeat-hostile
[121.236776] Subtest heartbeat-hostile: SKIP (0.000s)
[121.322082] [048/156] (898s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[121.416143] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[121.417912] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[121.505048] [049/156] (898s left) gem_flink_basic (double-flink)
[121.548365] Starting subtest: double-flink
[121.549295] Subtest double-flink: SUCCESS (0.000s)
[121.654081] [050/156] (898s left) perf (invalid-oa-metric-set-id)
[121.726909] Starting subtest: invalid-oa-metric-set-id
[121.738258] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[121.773355] [051/156] (898s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[121.875042] Starting subtest: hdr-indfb-scaledprimary
[121.876998] Subtest hdr-indfb-scaledprimary: SKIP (0.000s)
[121.963210] [052/156] (898s left) kms_cursor_crc (cursor-offscreen-256x256)
[122.182468] Starting subtest: cursor-offscreen-256x256
[122.187289] Starting dynamic subtest: pipe-A-eDP-1
[124.151634] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.965s)
[124.181971] Starting dynamic subtest: pipe-D-eDP-1
[126.736609] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[126.737561] Subtest cursor-offscreen-256x256: SUCCESS (4.554s)
[127.582427] [053/156] (892s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[127.690398] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[127.949842] Subtest linear-max-hw-stride-32bpp-rotate-0: FAIL (0.040s)
[127.976969] [054/156] (892s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[128.033590] Starting subtest: invalid-single-wait-unsubmitted
[128.034655] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[128.116613] [055/156] (892s left) gem_linear_blits (basic)
[128.429672] Starting subtest: basic
[128.439121] Subtest basic: SUCCESS (0.010s)
[128.575029] [056/156] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[128.714367] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[128.716025] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[128.805553] [057/156] (891s left) syncobj_wait (reset-during-wait-for-submit)
[128.868452] Starting subtest: reset-during-wait-for-submit
[128.971048] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[129.055715] [058/156] (891s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[129.140541] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[129.141464] Starting dynamic subtest: pipe-A
[130.189613] Dynamic subtest pipe-A: SUCCESS (1.050s)
[130.198397] Starting dynamic subtest: pipe-B
[132.289312] Dynamic subtest pipe-B: SUCCESS (2.099s)
[132.298402] Starting dynamic subtest: pipe-C
[133.493832] Dynamic subtest pipe-C: SUCCESS (1.204s)
[133.503202] Starting dynamic subtest: pipe-D
[134.721072] Dynamic subtest pipe-D: SUCCESS (1.226s)
[134.722100] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.582s)
[135.904294] [059/156] (884s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[135.994242] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[135.995085] Starting dynamic subtest: pipe-A-eDP-1
[136.004265] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[136.012535] Starting dynamic subtest: pipe-B-eDP-1
[136.022335] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[136.030748] Starting dynamic subtest: pipe-C-eDP-1
[136.039828] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[136.047627] Starting dynamic subtest: pipe-D-eDP-1
[136.055869] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[136.057375] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[138.251514] [060/156] (882s left) gem_sync (basic-many-each)
[138.308251] Starting subtest: basic-many-each
[140.598255] Subtest basic-many-each: SUCCESS (2.290s)
[140.789664] [061/156] (879s left) gem_mmap (pf-nonblock)
[140.850737] Subtest pf-nonblock: SKIP (0.000s)
[140.907524] [062/156] (879s left) fbdev (unaligned-write)
[140.945600] Starting subtest: unaligned-write
[141.048766] Subtest unaligned-write: SUCCESS (0.102s)
[141.105527] [063/156] (879s left) kms_color (ctm-signed)
[141.204139] Starting subtest: ctm-signed
[141.205253] Starting dynamic subtest: pipe-A-eDP-1
[143.338382] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.134s)
[143.349088] Starting dynamic subtest: pipe-B-eDP-1
[146.221057] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.881s)
[146.229975] Starting dynamic subtest: pipe-C-eDP-1
[148.914575] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.693s)
[148.923547] Starting dynamic subtest: pipe-D-eDP-1
[151.585757] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.670s)
[151.586720] Subtest ctm-signed: SUCCESS (10.382s)
[152.400462] [064/156] (868s left) gem_ctx_param (invalid-size-set)
[152.450523] Starting subtest: invalid-size-set
[152.451302] Subtest invalid-size-set: SUCCESS (0.001s)
[152.534994] [065/156] (868s left) kms_psr (pr-sprite-blt)
[152.632841] Starting subtest: pr-sprite-blt
[152.634386] Subtest pr-sprite-blt: SKIP (0.000s)
[152.703194] [066/156] (868s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[152.815046] Starting subtest: short-busy-flip-before-cursor-toggle
[152.816991] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[152.966231] [067/156] (867s left) gen9_exec_parse (bb-start-param)
[153.016973] Subtest bb-start-param: SKIP (0.000s)
[153.069197] [068/156] (867s left) kms_addfb_basic (bad-pitch-1024)
[153.110633] Starting subtest: bad-pitch-1024
[153.111610] Subtest bad-pitch-1024: SUCCESS (0.000s)
[153.246824] [069/156] (867s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[153.288534] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[153.396617] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[153.479745] [070/156] (867s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[153.602171] Starting subtest: multiplane-atomic-fence-wait
[153.835425] Subtest multiplane-atomic-fence-wait: SUCCESS (0.233s)
[154.951524] [071/156] (865s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[155.189837] Starting subtest: cursor-rapid-movement-256x256
[155.194145] Starting dynamic subtest: pipe-A-eDP-1
[155.757554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[155.788953] Starting dynamic subtest: pipe-D-eDP-1
[156.966039] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.185s)
[156.966933] Subtest cursor-rapid-movement-256x256: SUCCESS (1.777s)
[157.803187] [072/156] (863s left) i915_query (engine-info-invalid)
[157.862692] Starting subtest: engine-info-invalid
[157.863577] Subtest engine-info-invalid: SUCCESS (0.000s)
[157.957459] [073/156] (863s left) kms_plane_scaling (planes-downscale-factor-0-5)
[158.040493] Starting subtest: planes-downscale-factor-0-5
[158.041429] Starting dynamic subtest: pipe-A
[158.061094] Dynamic subtest pipe-A: SKIP (0.018s)
[158.069640] Starting dynamic subtest: pipe-B
[158.093558] Dynamic subtest pipe-B: SKIP (0.033s)
[158.102074] Starting dynamic subtest: pipe-C
[158.127174] Dynamic subtest pipe-C: SKIP (0.033s)
[158.135577] Starting dynamic subtest: pipe-D
[158.160283] Dynamic subtest pipe-D: SKIP (0.032s)
[158.161867] Subtest planes-downscale-factor-0-5: SKIP (0.119s)
[158.264439] [074/156] (862s left) prime_busy (after)
[158.318287] Starting subtest: after
[158.321641] Starting dynamic subtest: rcs0
[158.356877] Dynamic subtest rcs0: SUCCESS (0.035s)
[158.365125] Starting dynamic subtest: bcs0
[158.398269] Dynamic subtest bcs0: SUCCESS (0.040s)
[158.407841] Starting dynamic subtest: vcs0
[158.436899] Dynamic subtest vcs0: SUCCESS (0.038s)
[158.444876] Starting dynamic subtest: vcs1
[158.475674] Dynamic subtest vcs1: SUCCESS (0.037s)
[158.485962] Starting dynamic subtest: vecs0
[158.514748] Dynamic subtest vecs0: SUCCESS (0.039s)
[158.523487] Starting dynamic subtest: ccs0
[158.555832] Dynamic subtest ccs0: SUCCESS (0.040s)
[158.663177] Subtest after: SUCCESS (0.344s)
[158.732849] [075/156] (862s left) gem_eio (wait-wedge-10ms)
[158.966374] Starting subtest: wait-wedge-10ms
[160.435436] Subtest wait-wedge-10ms: SUCCESS (1.470s)
[160.575297] [076/156] (860s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[160.661289] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[160.663275] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[160.738859] [077/156] (860s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[160.841605] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[160.842455] Starting dynamic subtest: pipe-A-eDP-1
[171.537465] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.696s)
[171.548291] Starting dynamic subtest: pipe-B-eDP-1
[182.938746] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.399s)
[182.939709] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.098s)
[183.786072] [078/156] (837s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[183.839119] Starting subtest: yf-tiled-ccs-to-yf-tiled
[183.840930] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[184.015373] [079/156] (837s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[184.117344] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[184.118953] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[184.205158] [080/156] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[184.290689] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[184.292434] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[184.379269] [081/156] (836s left) kms_prop_blob (invalid-set-prop-any)
[184.429057] Starting subtest: invalid-set-prop-any
[184.429968] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[184.511985] [082/156] (836s left) gem_exec_alignment (forked)
[184.557653] Starting subtest: forked
[224.897853] Subtest forked: SUCCESS (40.292s)
[224.969540] [083/156] (796s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[225.115208] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[225.116056] Starting dynamic subtest: pipe-A-eDP-1
[225.124561] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.133396] Starting dynamic subtest: pipe-B-eDP-1
[225.141822] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.150528] Starting dynamic subtest: pipe-C-eDP-1
[225.159198] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.168086] Starting dynamic subtest: pipe-D-eDP-1
[225.176992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.178632] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[227.460138] [084/156] (793s left) gem_mmap_offset (isolation)
[227.513476] Starting subtest: isolation
[227.520919] Subtest isolation: SUCCESS (0.006s)
[227.611740] [085/156] (793s left) gem_exec_fence (syncobj-timeline-signal)
[228.244392] Starting subtest: syncobj-timeline-signal
[228.245475] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[229.422829] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[229.425334] [086/156] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[229.522734] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[229.524687] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[229.635285] [087/156] (791s left) kms_fbcon_fbt (fbc-suspend)
[229.691445] Starting subtest: fbc-suspend
[278.881180] Subtest fbc-suspend: SUCCESS (19.891s)
[280.263200] [088/156] (741s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[280.358666] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[280.361491] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[280.435536] [089/156] (741s left) api_intel_bb (simple-bb)
[280.484325] Starting subtest: simple-bb
[280.489267] Subtest simple-bb: SUCCESS (0.006s)
[280.600204] [090/156] (740s left) kms_async_flips (async-flip-dpms)
[280.687409] Starting subtest: async-flip-dpms
[281.059747] Starting dynamic subtest: pipe-A-eDP-1
[284.929765] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.835s)
[285.302592] Starting dynamic subtest: pipe-B-eDP-1
[288.121871] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.813s)
[288.514858] Starting dynamic subtest: pipe-C-eDP-1
[291.319169] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.803s)
[291.698877] Starting dynamic subtest: pipe-D-eDP-1
[294.507816] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.810s)
[294.508897] Subtest async-flip-dpms: SUCCESS (13.748s)
[295.684744] [091/156] (725s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[295.771054] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[295.772112] Starting dynamic subtest: pipe-A-eDP-1
[295.780819] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[295.791136] Starting dynamic subtest: pipe-B-eDP-1
[295.800868] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[295.811248] Starting dynamic subtest: pipe-C-eDP-1
[295.819515] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[295.829062] Starting dynamic subtest: pipe-D-eDP-1
[295.836919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[295.838428] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[298.103230] [092/156] (723s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[298.190071] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[298.191706] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.279949] [093/156] (723s left) gem_eio (in-flight-suspend)
[298.505157] Starting subtest: in-flight-suspend
[341.028000] Subtest in-flight-suspend: SUCCESS (13.533s)
[348.168297] [094/156] (680s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[348.287972] Starting subtest: yf-tiled-32bpp-rotate-90
[348.289481] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[348.376874] [095/156] (680s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[348.463957] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[348.465638] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[348.561992] [096/156] (680s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[348.653973] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[348.655815] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[348.727669] [097/156] (680s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[348.820370] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[348.822023] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[348.920512] [098/156] (679s left) i915_drm_fdinfo (isolation)
[348.956380] Starting subtest: isolation
[348.957261] Starting dynamic subtest: rcs0
[348.988485] Dynamic subtest rcs0: SKIP (0.032s)
[349.002806] Starting dynamic subtest: bcs0
[349.004685] Dynamic subtest bcs0: SKIP (0.001s)
[349.014535] Starting dynamic subtest: vcs0
[349.016344] Dynamic subtest vcs0: SKIP (0.000s)
[349.026120] Starting dynamic subtest: vcs1
[349.027979] Dynamic subtest vcs1: SKIP (0.000s)
[349.037781] Starting dynamic subtest: vecs0
[349.039600] Dynamic subtest vecs0: SKIP (0.000s)
[349.049200] Starting dynamic subtest: ccs0
[349.050868] Dynamic subtest ccs0: SKIP (0.000s)
[349.052802] Subtest isolation: SKIP (0.042s)
[349.084403] [099/156] (679s left) kms_selftest (drm_format)
[349.120298] Starting subtest: drm_format
[349.128054] Starting dynamic subtest: drm_test_format_block_width_invalid
[349.218559] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.090s)
[349.230265] Starting dynamic subtest: drm_test_format_block_width_one_plane
[349.321342] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.103s)
[349.331807] Starting dynamic subtest: drm_test_format_block_width_two_plane
[349.412346] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.090s)
[349.423902] Starting dynamic subtest: drm_test_format_block_width_three_plane
[349.504628] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.088s)
[349.517820] Starting dynamic subtest: drm_test_format_block_width_tiled
[349.597759] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.092s)
[349.609985] Starting dynamic subtest: drm_test_format_block_height_invalid
[349.677677] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.078s)
[349.689649] Starting dynamic subtest: drm_test_format_block_height_one_plane
[349.775852] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.097s)
[349.786503] Starting dynamic subtest: drm_test_format_block_height_two_plane
[349.861439] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.085s)
[349.873016] Starting dynamic subtest: drm_test_format_block_height_three_plane
[349.958631] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.095s)
[349.968370] Starting dynamic subtest: drm_test_format_block_height_tiled
[350.053799] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.094s)
[350.064288] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[350.138198] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.082s)
[350.149735] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[350.218573] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.080s)
[350.229804] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[350.308084] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.087s)
[350.319662] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[350.411494] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.102s)
[350.422163] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[350.517564] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.106s)
[350.528900] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[350.601970] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.084s)
[350.611862] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[350.688850] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.085s)
[350.701599] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[350.777645] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.085s)
[350.778703] Subtest drm_format: SUCCESS (1.652s)
[350.919833] [100/156] (678s left) gem_exec_balancer (persistence)
[351.202877] Starting subtest: persistence
[352.151207] Subtest persistence: SUCCESS (0.944s)
[352.260659] [101/156] (676s left) gem_exec_balancer (hang)
[352.524517] Starting subtest: hang
[354.632977] Subtest hang: SUCCESS (2.102s)
[354.750157] [102/156] (674s left) kms_vblank (wait-forked-hang)
[354.853003] Starting subtest: wait-forked-hang
[354.853779] Starting dynamic subtest: pipe-A-eDP-1
[381.396673] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.494s)
[381.409427] Starting dynamic subtest: pipe-D-eDP-1
[405.387575] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.963s)
[405.388576] Subtest wait-forked-hang: SUCCESS (50.461s)
[406.278909] [103/156] (622s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[406.376514] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[406.378186] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[406.464283] [104/156] (622s left) gem_exec_whisper (basic-sync)
[406.516843] Starting subtest: basic-sync
[415.351191] Subtest basic-sync: SUCCESS (8.816s)
[415.536610] [105/156] (613s left) gem_exec_schedule (pi-common)
[415.726180] Starting subtest: pi-common
[415.727219] Starting dynamic subtest: rcs0
[415.750463] Dynamic subtest rcs0: SUCCESS (0.032s)
[415.761674] Starting dynamic subtest: bcs0
[415.782453] Dynamic subtest bcs0: SUCCESS (0.031s)
[415.792606] Starting dynamic subtest: vcs0
[415.813063] Dynamic subtest vcs0: SUCCESS (0.030s)
[415.823289] Starting dynamic subtest: vcs1
[415.845500] Dynamic subtest vcs1: SUCCESS (0.031s)
[415.855829] Starting dynamic subtest: vecs0
[415.876086] Dynamic subtest vecs0: SUCCESS (0.030s)
[415.886278] Starting dynamic subtest: ccs0
[415.907794] Dynamic subtest ccs0: SUCCESS (0.031s)
[415.908820] Subtest pi-common: SUCCESS (0.190s)
[416.135292] [106/156] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[416.237212] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[416.238979] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[416.333870] [107/156] (612s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[416.419253] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[423.417253] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.994s)
[423.574663] [108/156] (605s left) gem_userptr_blits (set-cache-level)
[423.634590] Starting subtest: set-cache-level
[423.636469] Subtest set-cache-level: SKIP (0.000s)
[423.772614] [109/156] (605s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[423.862066] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[431.350415] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.484s)
[431.471454] [110/156] (597s left) kms_rotation_crc (bad-pixel-format)
[431.572339] Starting subtest: bad-pixel-format
[431.574161] Subtest bad-pixel-format: SKIP (0.001s)
[431.644145] [111/156] (597s left) gem_mmap_gtt (basic-copy)
[431.702850] Subtest basic-copy: SKIP (0.000s)
[431.761671] [112/156] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[431.850888] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[455.340221] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.476s)
[455.482501] [113/156] (573s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[455.592684] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[455.594447] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[455.682908] [114/156] (573s left) perf_pmu (interrupts-sync)
[455.716964] Starting subtest: interrupts-sync
[456.801883] Subtest interrupts-sync: SUCCESS (1.074s)
[456.907705] [115/156] (572s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[456.998879] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[457.000805] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[457.111825] [116/156] (572s left) i915_pm_rpm (reg-read-ioctl)
[458.751543] Starting subtest: reg-read-ioctl
[461.039667] Subtest reg-read-ioctl: SUCCESS (2.286s)
[461.442798] [117/156] (568s left) sw_sync (sync_multi_timeline_wait)
[461.473008] Starting subtest: sync_multi_timeline_wait
[461.473813] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[461.530029] [118/156] (568s left) gem_exec_reloc (basic-write-cpu-active)
[461.576041] Subtest basic-write-cpu-active: SKIP (0.000s)
[461.639134] [119/156] (567s left) kms_busy (basic)
[461.725251] Starting subtest: basic
[461.726142] Starting dynamic subtest: flip
[462.303410] Dynamic subtest flip: SUCCESS (0.577s)
[462.314335] Starting dynamic subtest: modeset
[466.002058] Dynamic subtest modeset: SUCCESS (3.695s)
[466.003140] Subtest basic: SUCCESS (4.275s)
[466.809847] [120/156] (562s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[466.900007] Starting subtest: psrhdr-rgb565-draw-render
[466.901698] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[466.994114] [121/156] (562s left) kms_flip (2x-plain-flip-ts-check)
[467.091201] Starting subtest: 2x-plain-flip-ts-check
[467.101316] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[467.194725] [122/156] (562s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[467.240593] Starting subtest: etime-single-wait-for-submit-unsubmitted
[467.358376] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[467.420504] [123/156] (562s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[467.511741] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[467.513903] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[467.601840] [124/156] (562s left) gem_close_race (multigpu-basic-process)
[467.670158] Starting subtest: multigpu-basic-process
[467.671806] Subtest multigpu-basic-process: SKIP (0.000s)
[467.886135] [125/156] (561s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[467.977349] Starting subtest: random-ccs-data-y-tiled-ccs
[467.978363] Starting dynamic subtest: pipe-A-eDP-1
[467.987335] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.997975] Starting dynamic subtest: pipe-B-eDP-1
[468.006824] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[468.017041] Starting dynamic subtest: pipe-C-eDP-1
[468.025575] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[468.035259] Starting dynamic subtest: pipe-D-eDP-1
[468.044251] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[468.045840] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[470.279040] [126/156] (559s left) gem_exec_store (basic)
[470.338751] Starting subtest: basic
[470.449386] Subtest basic: SUCCESS (0.111s)
[470.640834] [127/156] (559s left) gem_exec_schedule (u-fairslice-all)
[470.699386] Starting subtest: u-fairslice-all
[472.758420] Subtest u-fairslice-all: SUCCESS (2.059s)
[473.056824] [128/156] (556s left) kms_psr (psr-sprite-mmap-gtt)
[473.153120] Starting subtest: psr-sprite-mmap-gtt
[473.154019] Starting dynamic subtest: eDP-1
[474.595435] Dynamic subtest eDP-1: SKIP (1.431s)
[474.597471] Subtest psr-sprite-mmap-gtt: SKIP (1.433s)
[474.719881] [129/156] (555s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[474.802224] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[474.803119] Starting dynamic subtest: pipe-A-eDP-1
[474.826286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[474.837707] Starting dynamic subtest: pipe-B-eDP-1
[474.849330] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[474.860970] Starting dynamic subtest: pipe-C-eDP-1
[474.873047] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[474.884727] Starting dynamic subtest: pipe-D-eDP-1
[474.896393] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[474.897287] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[477.193308] [130/156] (552s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[477.293954] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[482.320467] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.026s)
[483.481534] [131/156] (546s left) kms_pm_dc (dc5-dpms)
[484.582443] Starting subtest: dc5-dpms
[486.658762] Subtest dc5-dpms: SUCCESS (2.067s)
[486.726483] [132/156] (543s left) gem_exec_suspend (basic)
[486.787739] Starting subtest: basic
[486.788748] Starting dynamic subtest: smem
[488.586783] Dynamic subtest smem: SUCCESS (1.788s)
[488.588279] Subtest basic: SUCCESS (1.790s)
[488.765765] [133/156] (541s left) gem_partial_pwrite_pread (reads)
[488.813483] Subtest reads: SKIP (0.000s)
[488.886600] [134/156] (541s left) kms_pm_rpm (modeset-pc8-residency-stress)
[490.723154] Starting subtest: modeset-pc8-residency-stress
[490.724912] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[491.134985] [135/156] (539s left) gem_exec_params (invalid-flag)
[491.185129] Starting subtest: invalid-flag
[491.186104] Subtest invalid-flag: SUCCESS (0.000s)
[491.284122] [136/156] (538s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[491.383630] Starting subtest: fbcpsr-rgb101010-draw-blt
[496.241433] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.857s)
[496.389795] [137/156] (533s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[496.475135] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[496.476728] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[496.565977] [138/156] (533s left) prime_mmap (test_forked_cpu_write)
[496.611956] Starting subtest: test_forked_cpu_write
[496.612779] Starting dynamic subtest: test_forked_cpu_write-smem
[496.617643] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s)
[496.618494] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[496.748992] [139/156] (533s left) kms_psr (fbc-psr2-no-drrs)
[496.839227] Starting subtest: fbc-psr2-no-drrs
[496.840095] Starting dynamic subtest: eDP-1
[496.841751] Dynamic subtest eDP-1: SKIP (0.000s)
[496.843630] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[496.915248] [140/156] (533s left) kms_invalid_mode (zero-vdisplay)
[496.994883] Starting subtest: zero-vdisplay
[496.995850] Starting dynamic subtest: pipe-A-eDP-1
[497.283434] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[497.293683] Starting dynamic subtest: pipe-B-eDP-1
[497.294765] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[497.304218] Starting dynamic subtest: pipe-C-eDP-1
[497.305097] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[497.314737] Starting dynamic subtest: pipe-D-eDP-1
[497.315582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[497.316424] Subtest zero-vdisplay: SUCCESS (0.293s)
[498.100870] [141/156] (532s left) kms_flip (2x-flip-vs-dpms)
[498.188962] Starting subtest: 2x-flip-vs-dpms
[498.198226] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[498.275639] [142/156] (532s left) gem_tiled_blits (normal)
[498.328240] Subtest normal: SKIP (0.000s)
[498.403417] [143/156] (532s left) gem_exec_flush (basic-batch-kernel-default-wb)
[498.455523] Starting subtest: basic-batch-kernel-default-wb
[505.817031] Subtest basic-batch-kernel-default-wb: SUCCESS (7.357s)
[506.007252] [144/156] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[506.098610] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[509.825817] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.727s)
[511.010955] [145/156] (519s left) kms_tv_load_detect (load-detect)
[511.062984] Subtest load-detect: SKIP (0.000s)
[511.115433] [146/156] (519s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[511.205016] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[511.206790] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[511.300076] [147/156] (519s left) kms_chamelium_hpd (hdmi-hpd)
[511.679006] Subtest hdmi-hpd: SKIP (0.000s)
[512.496862] [148/156] (518s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[512.588759] Starting subtest: psr-rgb101010-draw-blt
[520.061340] Subtest psr-rgb101010-draw-blt: SUCCESS (7.470s)
[520.195869] [149/156] (510s left) perf_pmu (gt-awake)
[520.232332] Starting subtest: gt-awake
[528.588698] Subtest gt-awake: SUCCESS (8.343s)
[528.701320] [150/156] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[528.793744] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[528.795480] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[528.885339] [151/156] (501s left) syncobj_timeline (multi-wait-signaled)
[528.928326] Starting subtest: multi-wait-signaled
[528.929800] Subtest multi-wait-signaled: SUCCESS (0.000s)
[529.026780] [152/156] (501s left) gem_exec_fence (syncobj-wait)
[529.445528] Starting subtest: syncobj-wait
[530.654879] Subtest syncobj-wait: SUCCESS (1.198s)
[530.985071] [153/156] (499s left) kms_content_protection (dp-mst-lic-type-1)
[531.125784] Starting subtest: dp-mst-lic-type-1
[531.127940] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[531.250260] [154/156] (499s left) i915_hangman (engine-engine-hang)
[531.305354] Starting subtest: engine-engine-hang
[531.306263] Starting dynamic subtest: rcs0
[532.585234] Dynamic subtest rcs0: SUCCESS (1.268s)
[532.596826] Starting dynamic subtest: bcs0
[534.568120] Dynamic subtest bcs0: SUCCESS (1.979s)
[534.580115] Starting dynamic subtest: vcs0
[536.553735] Dynamic subtest vcs0: SUCCESS (1.982s)
[536.568605] Starting dynamic subtest: vcs1
[538.601340] Dynamic subtest vcs1: SUCCESS (2.044s)
[538.618843] Starting dynamic subtest: vecs0
[540.586209] Dynamic subtest vecs0: SUCCESS (1.981s)
[540.597084] Starting dynamic subtest: ccs0
[542.569751] Dynamic subtest ccs0: SUCCESS (1.991s)
[542.571087] Subtest engine-engine-hang: SUCCESS (11.261s)
[542.643063] [155/156] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[542.741348] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[549.552259] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.832s)
[549.665642] [156/156] (481s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[550.033522] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[550.837972] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: core_setmaster
results: parsing output: 6/ for test: gem_ctx_isolation
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_workarounds
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_setmode
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_vrr
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_flink_basic
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_linear_blits
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_sync
results: parsing output: 60/ for test: gem_mmap
results: parsing output: 61/ for test: fbdev
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_explicit_fence
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: i915_query
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: prime_busy
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_prop_blob
results: parsing output: 81/ for test: gem_exec_alignment
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_fbcon_fbt
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_async_flips
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: kms_selftest
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_close_race
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_exec_store
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_pm_dc
results: parsing output: 131/ for test: gem_exec_suspend
results: parsing output: 132/ for test: gem_partial_pwrite_pread
results: parsing output: 133/ for test: kms_pm_rpm
results: parsing output: 134/ for test: gem_exec_params
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: prime_mmap
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_invalid_mode
results: parsing output: 140/ for test: kms_flip
results: parsing output: 141/ for test: gem_tiled_blits
results: parsing output: 142/ for test: gem_exec_flush
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_tv_load_detect
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_chamelium_hpd
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: perf_pmu
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: syncobj_timeline
results: parsing output: 151/ for test: gem_exec_fence
results: parsing output: 152/ for test: kms_content_protection
results: parsing output: 153/ for test: i915_hangman
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_chamelium_edid
Done.