[58.885885] Initializing watchdogs
[58.885931]   /dev/watchdog0
[58.904963] [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.909261] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.911436] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.914811] [001/133] (960s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[59.038343] Starting subtest: addfb25-yf-tiled-legacy
[59.040557] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[59.143124] [002/133] (960s left) i915_getparams_basic (basic-eu-total)
[59.201750] Starting subtest: basic-eu-total
[59.205817] Subtest basic-eu-total: SUCCESS (0.000s)
[59.307703] [003/133] (960s left) kms_draw_crc (draw-method-mmap-wc)
[59.403962] Starting subtest: draw-method-mmap-wc
[59.405987] Starting dynamic subtest: xrgb8888-untiled
[59.633550] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[59.641311] Starting dynamic subtest: rgb565-untiled
[59.865997] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[59.873862] Starting dynamic subtest: xrgb2101010-untiled
[60.076841] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[60.084287] Starting dynamic subtest: xbgr16161616f-untiled
[60.276623] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s)
[60.284497] Starting dynamic subtest: xrgb8888-xtiled
[60.398827] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[60.405290] Starting dynamic subtest: rgb565-xtiled
[60.520516] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[60.528235] Starting dynamic subtest: xrgb2101010-xtiled
[60.631517] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[60.641121] Starting dynamic subtest: xbgr16161616f-xtiled
[60.753538] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[60.761709] Starting dynamic subtest: xrgb8888-4tiled
[60.908959] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[60.916822] Starting dynamic subtest: rgb565-4tiled
[61.042155] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[61.052518] Starting dynamic subtest: xrgb2101010-4tiled
[61.197353] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[61.203494] Starting dynamic subtest: xbgr16161616f-4tiled
[61.363870] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[61.365932] Subtest draw-method-mmap-wc: SUCCESS (1.966s)
[61.477883] [004/133] (958s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[61.589652] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[61.591745] Starting dynamic subtest: pipe-A-eDP-1
[61.749907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.152s)
[61.758733] Starting dynamic subtest: pipe-B-eDP-1
[61.775710] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[61.782986] Starting dynamic subtest: pipe-C-eDP-1
[61.798894] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[61.805216] Starting dynamic subtest: pipe-D-eDP-1
[61.821087] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[61.823073] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.160s)
[64.067522] [005/133] (955s left) gem_lmem_evict (dontneed-evict-race)
[64.109232] Subtest dontneed-evict-race: SKIP (0.000s)
[64.156781] [006/133] (955s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[64.249211] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[64.251612] Starting dynamic subtest: pipe-A
[64.320650] Dynamic subtest pipe-A: SUCCESS (0.071s)
[64.329831] Starting dynamic subtest: pipe-B
[65.484373] Dynamic subtest pipe-B: SUCCESS (1.164s)
[65.494051] Starting dynamic subtest: pipe-C
[66.608905] Dynamic subtest pipe-C: SUCCESS (1.125s)
[66.615464] Starting dynamic subtest: pipe-D
[67.737750] Dynamic subtest pipe-D: SUCCESS (1.129s)
[67.740225] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.491s)
[69.012625] [007/133] (950s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[69.109738] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[75.913078] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.808s)
[76.068433] [008/133] (943s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[76.166904] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[83.212776] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.053s)
[83.357222] [009/133] (936s left) gem_exec_flush (basic-uc-set-default)
[83.431439] Starting subtest: basic-uc-set-default
[88.879694] Subtest basic-uc-set-default: SUCCESS (5.451s)
[89.089017] [010/133] (930s left) kms_atomic (atomic-plane-damage)
[89.201211] Starting subtest: atomic-plane-damage
[89.250532] Starting dynamic subtest: pipe-A-eDP-1
[89.813058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[89.815412] Subtest atomic-plane-damage: SUCCESS (0.611s)
[90.664321] [011/133] (929s left) gem_exec_whisper (basic-fds-forked-all)
[90.730668] Starting subtest: basic-fds-forked-all
[111.026944] Subtest basic-fds-forked-all: SUCCESS (20.299s)
[111.218366] [012/133] (908s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[111.280854] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[111.336762] [013/133] (908s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[111.443833] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[111.448075] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[111.573936] [014/133] (908s left) kms_flip (flip-vs-blocking-wf-vblank)
[111.670928] Starting subtest: flip-vs-blocking-wf-vblank
[111.673252] Starting dynamic subtest: A-eDP1
[120.584411] Dynamic subtest A-eDP1: SUCCESS (8.914s)
[120.594451] Starting dynamic subtest: B-eDP1
[129.511869] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[129.521877] Starting dynamic subtest: C-eDP1
[138.435256] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[138.445755] Starting dynamic subtest: D-eDP1
[147.372671] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[147.375072] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.705s)
[148.617914] [015/133] (871s left) gen9_exec_parse (unaligned-access)
[148.692069] Subtest unaligned-access: SKIP (0.000s)
[148.761493] [016/133] (871s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[148.819698] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[148.822052] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[148.931107] [017/133] (871s left) gem_exec_schedule (implicit-write-read)
[148.992053] Starting subtest: implicit-write-read
[148.994233] Starting dynamic subtest: rcs0
[149.093109] Dynamic subtest rcs0: SUCCESS (0.111s)
[149.103062] Starting dynamic subtest: vcs0
[149.169606] Dynamic subtest vcs0: SUCCESS (0.076s)
[149.180154] Starting dynamic subtest: vcs1
[149.244049] Dynamic subtest vcs1: SUCCESS (0.074s)
[149.255050] Starting dynamic subtest: vecs0
[149.315725] Dynamic subtest vecs0: SUCCESS (0.071s)
[149.325935] Starting dynamic subtest: ccs0
[149.400123] Dynamic subtest ccs0: SUCCESS (0.084s)
[149.402541] Subtest implicit-write-read: SUCCESS (0.419s)
[151.066196] [018/133] (868s left) syncobj_eventfd (invalid-illegal-eventfd)
[151.121175] Starting subtest: invalid-illegal-eventfd
[151.123579] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[151.233195] [019/133] (868s left) kms_plane (pixel-format-y-tiled-modifier)
[151.337053] Starting subtest: pixel-format-y-tiled-modifier
[151.365454] Starting dynamic subtest: pipe-A-plane-0
[151.370037] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[151.379381] Starting dynamic subtest: pipe-A-plane-3
[151.383962] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[151.391896] Starting dynamic subtest: pipe-A-plane-5
[151.396507] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[152.484249] Starting dynamic subtest: pipe-B-plane-0
[152.488310] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[152.495640] Starting dynamic subtest: pipe-B-plane-3
[152.500413] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[152.507845] Starting dynamic subtest: pipe-B-plane-5
[152.512580] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[152.791148] Subtest pixel-format-y-tiled-modifier: SKIP (1.451s)
[153.670319] [020/133] (866s left) gem_exec_reloc (basic-scanout)
[153.742872] Subtest basic-scanout: SKIP (0.000s)
[153.831817] [021/133] (866s left) gem_ctx_param (set-priority-range)
[153.895745] Starting subtest: set-priority-range
[153.911072] Subtest set-priority-range: SUCCESS (0.015s)
[154.040097] [022/133] (866s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[154.135215] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[154.139329] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[154.271257] [023/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[154.323999] Starting subtest: multi-wait-for-submit-available-submitted
[154.326350] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[154.453470] [024/133] (865s left) kms_cursor_crc (cursor-offscreen-512x170)
[154.718121] Starting subtest: cursor-offscreen-512x170
[154.722074] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[154.878651] [025/133] (865s left) perf_pmu (busy-accuracy-98)
[154.920101] Starting subtest: busy-accuracy-98
[154.921759] Starting dynamic subtest: rcs0
[157.957356] Dynamic subtest rcs0: SUCCESS (3.034s)
[157.967610] Starting dynamic subtest: bcs0
[161.010918] Dynamic subtest bcs0: SUCCESS (3.051s)
[161.020503] Starting dynamic subtest: vcs0
[164.053346] Dynamic subtest vcs0: SUCCESS (3.040s)
[164.061497] Starting dynamic subtest: vcs1
[167.096401] Dynamic subtest vcs1: SUCCESS (3.040s)
[167.106366] Starting dynamic subtest: vecs0
[170.135186] Dynamic subtest vecs0: SUCCESS (3.037s)
[170.145514] Starting dynamic subtest: ccs0
[173.184095] Dynamic subtest ccs0: SUCCESS (3.047s)
[173.187176] Subtest busy-accuracy-98: SUCCESS (18.258s)
[173.306610] [026/133] (847s left) gem_exec_parallel (basic)
[173.377368] Starting subtest: basic
[173.379819] Starting dynamic subtest: rcs0
[174.899321] Dynamic subtest rcs0: SUCCESS (1.521s)
[174.908814] Starting dynamic subtest: bcs0
[176.377036] Dynamic subtest bcs0: SUCCESS (1.476s)
[176.387247] Starting dynamic subtest: vcs0
[177.967282] Dynamic subtest vcs0: SUCCESS (1.587s)
[177.975990] Starting dynamic subtest: vcs1
[179.860834] Dynamic subtest vcs1: SUCCESS (1.891s)
[179.872161] Starting dynamic subtest: vecs0
[181.910158] Dynamic subtest vecs0: SUCCESS (2.047s)
[181.926176] Starting dynamic subtest: ccs0
[183.378977] Dynamic subtest ccs0: SUCCESS (1.469s)
[183.381390] Subtest basic: SUCCESS (10.001s)
[183.576051] [027/133] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[183.682653] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[183.687593] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[183.828857] [028/133] (836s left) kms_chamelium_color (ctm-limited-range)
[183.938253] Subtest ctm-limited-range: SKIP (0.000s)
[183.984863] [029/133] (836s left) kms_plane_multiple (2x-tiling-yf)
[184.088453] Starting subtest: 2x-tiling-yf
[184.092473] Subtest 2x-tiling-yf: SKIP (0.000s)
[184.171149] [030/133] (836s left) gem_pwrite (basic-random)
[184.233422] Subtest basic-random: SKIP (0.000s)
[184.313685] [031/133] (836s left) kms_cursor_crc (cursor-sliding-128x42)
[184.524335] Starting subtest: cursor-sliding-128x42
[184.571865] Subtest cursor-sliding-128x42: SKIP (0.043s)
[184.798981] [032/133] (835s left) gem_mmap_gtt (basic-write-read)
[184.856235] Subtest basic-write-read: SKIP (0.000s)
[184.922962] [033/133] (835s left) gem_exec_capture (capture)
[184.985432] Starting subtest: capture
[184.987134] Starting dynamic subtest: rcs0-smem
[185.824341] Dynamic subtest rcs0-smem: SUCCESS (0.840s)
[185.834442] Starting dynamic subtest: bcs0-smem
[186.653528] Dynamic subtest bcs0-smem: SUCCESS (0.827s)
[186.663266] Starting dynamic subtest: vcs0-smem
[187.475998] Dynamic subtest vcs0-smem: SUCCESS (0.821s)
[187.485119] Starting dynamic subtest: vcs1-smem
[188.795203] Dynamic subtest vcs1-smem: SUCCESS (1.321s)
[188.805658] Starting dynamic subtest: vecs0-smem
[189.685416] Dynamic subtest vecs0-smem: FAIL (0.833s)
[189.695432] Starting dynamic subtest: ccs0-smem
[190.950066] Dynamic subtest ccs0-smem: SUCCESS (1.321s)
[190.952182] Subtest capture: FAIL (5.965s)
[191.101936] [034/133] (829s left) kms_pm_dc (dc5-psr)
[192.209936] Starting subtest: dc5-psr
[195.096357] Subtest dc5-psr: SUCCESS (2.886s)
[195.902907] [035/133] (824s left) gem_watchdog (default-virtual)
[195.971913] Starting subtest: default-virtual
[202.245615] Subtest default-virtual: SUCCESS (6.283s)
[202.335314] [036/133] (818s left) i915_pm_rps (thresholds)
[202.404873] Starting subtest: thresholds
[202.409471] Subtest thresholds: SKIP (0.001s)
[202.487205] [037/133] (818s left) gem_softpin (noreloc-s3)
[202.542370] Starting subtest: noreloc-S3
[223.107165] Subtest noreloc-S3: SUCCESS (5.402s)
[223.258943] [038/133] (797s left) kms_flip (basic-flip-vs-wf_vblank)
[223.387460] Starting subtest: basic-flip-vs-wf_vblank
[223.389786] Starting dynamic subtest: A-eDP1
[225.282791] Dynamic subtest A-eDP1: SUCCESS (1.907s)
[225.294019] Starting dynamic subtest: B-eDP1
[227.208894] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[227.218797] Starting dynamic subtest: C-eDP1
[229.118848] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[229.129226] Starting dynamic subtest: D-eDP1
[231.039834] Dynamic subtest D-eDP1: SUCCESS (1.926s)
[231.042176] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.688s)
[232.267462] [039/133] (788s left) gen3_render_tiledy_blits
[232.397815] [040/133] (788s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[232.505764] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[239.841502] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.345s)
[240.012522] [041/133] (780s left) perf_pmu (rc6)
[240.049140] Starting subtest: rc6
[240.051388] Starting dynamic subtest: gt0
[246.418816] Dynamic subtest gt0: SUCCESS (6.376s)
[246.430967] Starting dynamic subtest: runtime-pm-gt0
[254.171142] Dynamic subtest runtime-pm-gt0: SUCCESS (7.752s)
[254.180144] Starting dynamic subtest: runtime-pm-long-gt0
[266.594479] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.423s)
[266.606640] Starting dynamic subtest: other-idle-gt0
[272.938719] Dynamic subtest other-idle-gt0: SUCCESS (6.344s)
[272.948439] Starting dynamic subtest: gt1
[279.279964] Dynamic subtest gt1: SUCCESS (6.341s)
[279.291124] Starting dynamic subtest: runtime-pm-gt1
[286.771155] Dynamic subtest runtime-pm-gt1: SUCCESS (7.492s)
[286.781337] Starting dynamic subtest: runtime-pm-long-gt1
[299.273470] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.505s)
[299.285733] Starting dynamic subtest: other-idle-gt1
[305.615426] Dynamic subtest other-idle-gt1: SUCCESS (6.343s)
[305.618151] Subtest rc6: SUCCESS (65.589s)
[306.766441] [042/133] (714s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[306.861696] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[306.865914] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[306.938167] [043/133] (714s left) kms_flip (flip-vs-rmfb)
[307.038902] Starting subtest: flip-vs-rmfb
[307.040767] Starting dynamic subtest: A-eDP1
[315.670750] Dynamic subtest A-eDP1: SUCCESS (8.635s)
[315.679888] Starting dynamic subtest: B-eDP1
[324.299686] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[324.308505] Starting dynamic subtest: C-eDP1
[332.929641] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[332.939232] Starting dynamic subtest: D-eDP1
[341.566345] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[341.570648] Subtest flip-vs-rmfb: SUCCESS (34.527s)
[342.730486] [044/133] (678s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[347.723707] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[347.728322] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[348.584149] [045/133] (672s left) gem_exec_balancer (invalid-balancer)
[348.655931] Starting subtest: invalid-balancer
[349.524482] Subtest invalid-balancer: SUCCESS (0.870s)
[349.804774] [046/133] (671s left) gem_flink_basic (bad-open)
[349.859842] Starting subtest: bad-open
[349.862013] Subtest bad-open: SUCCESS (0.000s)
[349.938474] [047/133] (671s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[350.055710] Starting subtest: flip-vs-cursor-varying-size
[358.580889] Subtest flip-vs-cursor-varying-size: SUCCESS (8.524s)
[359.405979] [048/133] (661s left) kms_plane_alpha_blend (alpha-transparent-fb)
[359.495177] Starting subtest: alpha-transparent-fb
[359.787830] Starting dynamic subtest: pipe-A-eDP-1
[360.420749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.630s)
[360.429683] Starting dynamic subtest: pipe-D-eDP-1
[361.771511] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[361.773690] Subtest alpha-transparent-fb: SUCCESS (2.276s)
[362.580629] [049/133] (658s left) api_intel_bb (object-reloc-keep-cache)
[362.642995] Starting subtest: object-reloc-keep-cache
[362.647095] Subtest object-reloc-keep-cache: SKIP (0.003s)
[362.753706] [050/133] (658s left) perf (invalid-open-flags)
[362.843423] Starting subtest: invalid-open-flags
[362.845344] Subtest invalid-open-flags: SUCCESS (0.000s)
[362.887874] [051/133] (658s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[363.000131] Starting subtest: primary-x-tiled-reflect-x-0
[370.047316] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.049s)
[371.244920] [052/133] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[371.345314] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[371.349471] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.426526] [053/133] (649s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[371.545562] Starting subtest: short-busy-flip-before-cursor-toggle
[371.549843] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[371.665274] [054/133] (649s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[371.814559] Starting subtest: dp-mst-lic-type-0-hdcp14
[371.819273] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[371.933569] [055/133] (649s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[372.029261] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[372.033634] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.122158] [056/133] (649s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[372.512939] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[373.285831] [057/133] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[373.381091] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[373.385430] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[373.453830] [058/133] (648s left) gem_userptr_blits (unsync-unmap)
[373.532979] Subtest unsync-unmap: SKIP (0.000s)
[373.642377] [059/133] (647s left) kms_cursor_crc (cursor-sliding-max-size)
[373.933235] Starting subtest: cursor-sliding-max-size
[373.939978] Subtest cursor-sliding-max-size: SKIP (0.000s)
[374.038444] [060/133] (647s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[374.137904] Starting subtest: flip-vs-dpms-off-vs-modeset
[374.139764] Starting dynamic subtest: A-eDP1
[377.727901] Dynamic subtest A-eDP1: SUCCESS (3.590s)
[377.737576] Starting dynamic subtest: B-eDP1
[380.917230] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[380.928099] Starting dynamic subtest: C-eDP1
[384.030648] Dynamic subtest C-eDP1: SUCCESS (3.115s)
[384.040000] Starting dynamic subtest: D-eDP1
[387.113988] Dynamic subtest D-eDP1: SUCCESS (3.081s)
[387.115957] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.981s)
[387.887595] [061/133] (633s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[387.998783] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[388.003240] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[388.117978] [062/133] (633s left) gem_exec_alignment (single)
[388.193079] Starting subtest: single
[388.195460] Subtest single: SUCCESS (0.002s)
[388.260292] [063/133] (633s left) gem_mmap_wc (write-gtt-read-wc)
[388.326056] Subtest write-gtt-read-wc: SKIP (0.000s)
[388.391712] [064/133] (633s left) kms_psr (fbc-psr-sprite-blt)
[388.486739] Starting subtest: fbc-psr-sprite-blt
[388.489444] Starting dynamic subtest: eDP-1
[388.494443] Dynamic subtest eDP-1: SKIP (0.000s)
[388.499097] Subtest fbc-psr-sprite-blt: SKIP (0.002s)
[388.545168] [065/133] (633s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[388.597916] Starting subtest: invalid-multi-wait-unsubmitted
[388.599979] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[388.685369] [066/133] (633s left) gem_exec_schedule (u-semaphore-codependency)
[388.761909] Starting subtest: u-semaphore-codependency
[388.767781] Subtest u-semaphore-codependency: SUCCESS (0.012s)
[389.097333] [067/133] (632s left) gem_ctx_engines (execute-one)
[389.155724] Starting subtest: execute-one
[391.585949] Subtest execute-one: SUCCESS (2.431s)
[391.747332] [068/133] (630s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[391.844469] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[391.846766] Starting dynamic subtest: pipe-A-eDP-1
[392.355259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[392.366500] Starting dynamic subtest: pipe-B-eDP-1
[393.763025] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s)
[393.771678] Starting dynamic subtest: pipe-C-eDP-1
[395.125007] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s)
[395.133844] Starting dynamic subtest: pipe-D-eDP-1
[396.478748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[396.481023] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.609s)
[397.614151] [069/133] (624s left) kms_busy (basic-hang)
[397.732565] Starting subtest: basic-hang
[397.734861] Starting dynamic subtest: flip-pipe-A
[398.331014] Dynamic subtest flip-pipe-A: SUCCESS (0.595s)
[398.341262] Starting dynamic subtest: modeset-pipe-A
[401.987624] Dynamic subtest modeset-pipe-A: SUCCESS (3.659s)
[401.997223] Starting dynamic subtest: flip-pipe-D
[403.186545] Dynamic subtest flip-pipe-D: SUCCESS (1.196s)
[403.196066] Starting dynamic subtest: modeset-pipe-D
[406.616574] Dynamic subtest modeset-pipe-D: SUCCESS (3.432s)
[406.618914] Subtest basic-hang: SUCCESS (8.889s)
[407.396885] [070/133] (614s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[407.494153] Starting subtest: basic-max-pipe-crc-check
[407.498065] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[407.539233] [071/133] (614s left) gen7_exec_parse (cmd-crossing-page)
[407.600542] Subtest cmd-crossing-page: SKIP (0.000s)
[407.698273] [072/133] (614s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[407.796863] Starting subtest: fbc-farfromfence-mmap-gtt
[407.800974] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[407.892135] [073/133] (614s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[407.950126] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[407.954605] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[408.106569] [074/133] (614s left) kms_vrr (flip-basic)
[408.207443] Starting subtest: flip-basic
[408.213780] Subtest flip-basic: SKIP (0.000s)
[408.254903] [075/133] (613s left) kms_vblank (query-busy)
[408.348550] Starting subtest: query-busy
[408.350673] Starting dynamic subtest: pipe-A-eDP-1
[410.222055] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[410.236604] Starting dynamic subtest: pipe-D-eDP-1
[412.790576] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[412.792898] Subtest query-busy: SUCCESS (4.445s)
[413.566042] [076/133] (608s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[413.659395] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[413.661539] Starting dynamic subtest: pipe-A-default-mode
[414.850520] Dynamic subtest pipe-A-default-mode: SKIP (1.187s)
[414.854932] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.189s)
[414.986345] [077/133] (607s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[415.084578] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[415.086753] Starting dynamic subtest: pipe-A-eDP-1
[415.109476] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[415.120342] Starting dynamic subtest: pipe-B-eDP-1
[415.141662] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[415.150075] Starting dynamic subtest: pipe-C-eDP-1
[415.172134] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[415.180504] Starting dynamic subtest: pipe-D-eDP-1
[415.202527] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[415.206528] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[417.368479] [078/133] (604s left) gem_exec_reloc (basic-cpu-read)
[417.433708] Subtest basic-cpu-read: SKIP (0.000s)
[417.523570] [079/133] (604s left) perf_pmu (idle)
[417.566016] Starting subtest: idle
[417.568176] Starting dynamic subtest: rcs0
[418.140206] Dynamic subtest rcs0: SUCCESS (0.572s)
[418.152416] Starting dynamic subtest: bcs0
[418.670773] Dynamic subtest bcs0: SUCCESS (0.528s)
[418.682686] Starting dynamic subtest: vcs0
[419.199731] Dynamic subtest vcs0: SUCCESS (0.525s)
[419.211328] Starting dynamic subtest: vcs1
[419.725997] Dynamic subtest vcs1: SUCCESS (0.524s)
[419.737509] Starting dynamic subtest: vecs0
[420.254670] Dynamic subtest vecs0: SUCCESS (0.526s)
[420.266852] Starting dynamic subtest: ccs0
[420.780948] Dynamic subtest ccs0: SUCCESS (0.524s)
[420.783643] Subtest idle: SUCCESS (3.216s)
[420.875467] [080/133] (601s left) gem_ctx_param (get-priority-new-ctx)
[420.931478] Starting subtest: get-priority-new-ctx
[420.933976] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[421.013680] [081/133] (601s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[421.113863] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[421.117947] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[421.196443] [082/133] (601s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[421.290073] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[421.292537] Starting dynamic subtest: pipe-A-default-mode
[421.591263] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[421.595747] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.301s)
[422.403019] [083/133] (600s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[422.514436] Starting subtest: fbc-rgb101010-draw-blt
[427.155443] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.645s)
[428.309052] [084/133] (594s left) perf (missing-sample-flags)
[428.373046] Starting subtest: missing-sample-flags
[428.375444] Subtest missing-sample-flags: SUCCESS (0.000s)
[428.412866] [085/133] (594s left) gem_mmap_offset (blt-coherency)
[428.469983] Starting subtest: blt-coherency
[428.474994] Subtest blt-coherency: SUCCESS (0.007s)
[428.587779] [086/133] (594s left) gem_softpin (allocator-nopin)
[428.658765] Starting subtest: allocator-nopin
[428.770658] Subtest allocator-nopin: SUCCESS (0.113s)
[428.866694] [087/133] (593s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[428.985163] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[428.989665] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[429.074009] [088/133] (593s left) kms_psr (psr2-cursor-render)
[429.162345] Starting subtest: psr2-cursor-render
[429.164471] Starting dynamic subtest: eDP-1
[430.900474] Dynamic subtest eDP-1: SUCCESS (1.738s)
[430.902771] Subtest psr2-cursor-render: SUCCESS (1.739s)
[431.678609] [089/133] (591s left) gem_pxp (regular-baseline-src-copy-readible)
[431.786338] Starting subtest: regular-baseline-src-copy-readible
[431.843593] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[431.948119] [090/133] (590s left) gem_render_copy_redux (flink)
[432.002643] Starting subtest: flink
[432.686718] Subtest flink: SUCCESS (0.684s)
[432.797720] [091/133] (590s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[432.893637] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[432.895514] Starting dynamic subtest: pipe-A-eDP-1
[432.913899] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[432.924010] Starting dynamic subtest: pipe-B-eDP-1
[432.941955] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[432.950866] Starting dynamic subtest: pipe-C-eDP-1
[432.967945] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[432.976095] Starting dynamic subtest: pipe-D-eDP-1
[432.994039] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[432.997391] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[435.056856] [092/133] (587s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[435.169369] Starting subtest: x-tiled-32bpp-rotate-270
[435.189459] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[435.292260] [093/133] (587s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[435.357469] Starting subtest: single-wait-all-for-submit-signaled
[435.359718] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[435.442237] [094/133] (587s left) kms_rotation_crc (primary-rotation-180)
[435.540299] Starting subtest: primary-rotation-180
[442.420701] Subtest primary-rotation-180: SUCCESS (6.884s)
[443.610591] [095/133] (579s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[443.713487] Starting subtest: yf-tiled-32bpp-rotate-270
[443.718087] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[443.786452] [096/133] (579s left) gem_ctx_bad_destroy (double-destroy)
[443.834170] Starting subtest: double-destroy
[443.836464] Subtest double-destroy: SUCCESS (0.000s)
[443.874137] [097/133] (579s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[443.964587] Starting subtest: fbc-psr2-primary-mmap-cpu
[443.966796] Starting dynamic subtest: eDP-1
[443.970912] Dynamic subtest eDP-1: SKIP (0.000s)
[443.975021] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[444.010252] [098/133] (579s left) kms_chamelium_frames (vga-frame-dump)
[444.390455] Subtest vga-frame-dump: SKIP (0.000s)
[445.238186] [099/133] (577s left) gem_exec_fence (syncobj-invalid-flags)
[445.734049] Starting subtest: syncobj-invalid-flags
[445.736480] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[447.161417] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[447.165229] [100/133] (576s left) kms_color (ctm-green-to-red)
[447.266519] Starting subtest: ctm-green-to-red
[447.268657] Starting dynamic subtest: pipe-A-eDP-1
[447.982134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[447.991411] Starting dynamic subtest: pipe-B-eDP-1
[449.408882] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[449.418626] Starting dynamic subtest: pipe-C-eDP-1
[450.770293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[450.779834] Starting dynamic subtest: pipe-D-eDP-1
[452.090544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[452.092988] Subtest ctm-green-to-red: SUCCESS (4.824s)
[452.883897] [101/133] (570s left) gem_ccs (block-copy-compressed)
[452.941637] Starting subtest: block-copy-compressed
[452.946288] Subtest block-copy-compressed: SKIP (0.000s)
[453.030830] [102/133] (570s left) perf (create-destroy-userspace-config)
[453.085322] Starting subtest: create-destroy-userspace-config
[453.102464] Subtest create-destroy-userspace-config: SUCCESS (0.018s)
[453.150445] [103/133] (570s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[453.252079] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[459.806876] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.556s)
[459.942323] [104/133] (563s left) gem_ctx_persistence (heartbeat-many)
[460.016656] Starting subtest: heartbeat-many
[460.021169] Subtest heartbeat-many: SKIP (0.000s)
[460.107988] [105/133] (563s left) api_intel_allocator (fork-simple-stress-signal)
[460.162931] Starting subtest: fork-simple-stress-signal
[465.564349] Subtest fork-simple-stress-signal: SUCCESS (5.400s)
[465.664194] [106/133] (557s left) prime_self_import (basic-with_one_bo)
[465.706358] Starting subtest: basic-with_one_bo
[465.735930] Subtest basic-with_one_bo: SUCCESS (0.030s)
[465.843541] [107/133] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[465.942821] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[465.947032] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.044269] [108/133] (557s left) kms_getfb (getfb2-handle-closed)
[466.140506] Starting subtest: getfb2-handle-closed
[466.142931] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[466.271480] [109/133] (557s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[466.337273] Starting subtest: multi-wait-all-for-submit-submitted
[466.441138] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[466.497731] [110/133] (557s left) syncobj_timeline (multi-wait-all-signaled)
[466.559914] Starting subtest: multi-wait-all-signaled
[466.562288] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[466.663925] [111/133] (557s left) kms_psr (psr-sprite-plane-move)
[466.763640] Starting subtest: psr-sprite-plane-move
[466.765768] Starting dynamic subtest: eDP-1
[468.480075] Dynamic subtest eDP-1: SUCCESS (1.714s)
[468.482036] Subtest psr-sprite-plane-move: SUCCESS (1.715s)
[469.292333] [112/133] (554s left) kms_psr (pr-sprite-render)
[469.395498] Starting subtest: pr-sprite-render
[469.399927] Subtest pr-sprite-render: SKIP (0.000s)
[469.444937] [113/133] (554s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[469.517699] Subtest untiled-to-tiled: SKIP (0.000s)
[469.605592] [114/133] (554s left) drm_mm (drm_mm)
[469.642608] Starting subtest: drm_mm
[469.652728] Starting dynamic subtest: drm_test_mm_init
[469.822495] Dynamic subtest drm_test_mm_init: SUCCESS (0.168s)
[469.831099] Starting dynamic subtest: drm_test_mm_debug
[469.986451] Dynamic subtest drm_test_mm_debug: SUCCESS (0.163s)
[469.995366] Starting dynamic subtest: drm_test_mm_align32
[470.145697] Dynamic subtest drm_test_mm_align32: SUCCESS (0.160s)
[470.154315] Starting dynamic subtest: drm_test_mm_align64
[470.303665] Dynamic subtest drm_test_mm_align64: SUCCESS (0.155s)
[470.312282] Starting dynamic subtest: drm_test_mm_lowest
[470.466530] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.163s)
[470.475745] Starting dynamic subtest: drm_test_mm_highest
[470.617869] Dynamic subtest drm_test_mm_highest: SUCCESS (0.149s)
[470.620065] Subtest drm_mm: SUCCESS (0.976s)
[470.811558] [115/133] (553s left) kms_addfb_basic (bad-pitch-32)
[470.864518] Starting subtest: bad-pitch-32
[470.866534] Subtest bad-pitch-32: SUCCESS (0.000s)
[470.997352] [116/133] (552s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[471.100647] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[472.071008] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.968s)
[472.207713] [117/133] (551s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[472.313637] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[472.317965] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[472.405155] [118/133] (551s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[472.495471] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[479.548606] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.053s)
[479.672516] [119/133] (544s left) gem_mmap_wc (write-read)
[479.738970] Subtest write-read: SKIP (0.000s)
[479.809101] [120/133] (544s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[479.913651] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[486.731732] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.818s)
[486.856362] [121/133] (537s left) sw_sync (sync_multi_consumer_producer)
[486.896031] Starting subtest: sync_multi_consumer_producer
[487.208412] Subtest sync_multi_consumer_producer: SUCCESS (0.312s)
[487.246684] [122/133] (536s left) gem_ctx_sseu (invalid-sseu)
[487.309320] Subtest invalid-sseu: SKIP (0.000s)
[487.403745] [123/133] (536s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[492.451132] Starting subtest: psr2-cursor-plane-update-sf
[492.453498] Starting dynamic subtest: pipe-A-eDP-1
[493.742232] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.290s)
[493.752133] Starting dynamic subtest: pipe-B-eDP-1
[495.076367] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s)
[495.078545] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.627s)
[495.923318] [124/133] (528s left) kms_joiner (basic-big-joiner)
[496.031944] Starting subtest: basic-big-joiner
[496.036246] Subtest basic-big-joiner: SKIP (0.000s)
[496.073235] [125/133] (528s left) kms_psr2_su (page_flip-xrgb8888)
[496.125721] Subtest page_flip-XRGB8888: SKIP (0.000s)
[496.199789] [126/133] (528s left) prime_vgem (basic-write)
[496.273730] Starting subtest: basic-write
[496.282694] Subtest basic-write: SKIP (0.008s)
[496.379641] [127/133] (527s left) gem_ctx_persistence (engines-persistence)
[496.445621] Starting subtest: engines-persistence
[496.447935] Starting dynamic subtest: rcs0
[497.271776] Dynamic subtest rcs0: SUCCESS (0.825s)
[497.285171] Starting dynamic subtest: bcs0
[498.039331] Dynamic subtest bcs0: SUCCESS (0.766s)
[498.051604] Starting dynamic subtest: vcs0
[498.823897] Dynamic subtest vcs0: SUCCESS (0.781s)
[498.835209] Starting dynamic subtest: vcs1
[499.632691] Dynamic subtest vcs1: SUCCESS (0.806s)
[499.644901] Starting dynamic subtest: vecs0
[500.411706] Dynamic subtest vecs0: SUCCESS (0.777s)
[500.423808] Starting dynamic subtest: ccs0
[501.188823] Dynamic subtest ccs0: SUCCESS (0.774s)
[501.191467] Subtest engines-persistence: SUCCESS (4.743s)
[501.245123] [128/133] (523s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[501.353449] Starting subtest: 4-tiled-8bpp-rotate-270
[501.374222] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[501.466283] [129/133] (522s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[501.547424] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[501.549644] Starting dynamic subtest: pipe-A
[501.569733] Dynamic subtest pipe-A: SKIP (0.017s)
[501.579011] Starting dynamic subtest: pipe-B
[501.599612] Dynamic subtest pipe-B: SKIP (0.031s)
[501.609792] Starting dynamic subtest: pipe-C
[501.632875] Dynamic subtest pipe-C: SKIP (0.031s)
[501.642483] Starting dynamic subtest: pipe-D
[501.662641] Dynamic subtest pipe-D: SKIP (0.030s)
[501.666896] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.112s)
[501.745612] [130/133] (522s left) sriov_basic (enable-vfs-autoprobe-on)
[501.793533] Starting subtest: enable-vfs-autoprobe-on
[501.795928] Starting dynamic subtest: numvfs-1
[501.869706] Dynamic subtest numvfs-1: FAIL (0.012s)
[501.880461] Starting dynamic subtest: numvfs-2
[501.955026] Dynamic subtest numvfs-2: FAIL (0.004s)
[501.965291] Starting dynamic subtest: numvfs-3
[502.039169] Dynamic subtest numvfs-3: FAIL (0.003s)
[502.049644] Starting dynamic subtest: numvfs-4
[502.121655] Dynamic subtest numvfs-4: FAIL (0.004s)
[502.131519] Starting dynamic subtest: numvfs-5
[502.193671] Dynamic subtest numvfs-5: FAIL (0.008s)
[502.203309] Starting dynamic subtest: numvfs-6
[502.261476] Dynamic subtest numvfs-6: FAIL (0.003s)
[502.270567] Starting dynamic subtest: numvfs-7
[502.329394] Dynamic subtest numvfs-7: FAIL (0.003s)
[502.340000] Starting dynamic subtest: numvfs-random
[502.399291] Dynamic subtest numvfs-random: FAIL (0.003s)
[502.409853] Starting dynamic subtest: numvfs-all
[502.469293] Dynamic subtest numvfs-all: FAIL (0.476s)
[502.471248] Subtest enable-vfs-autoprobe-on: FAIL (0.523s)
[502.507843] [131/133] (521s left) perf_pmu (all-busy-idle-check-all)
[502.544484] Starting subtest: all-busy-idle-check-all
[504.108301] Subtest all-busy-idle-check-all: SUCCESS (1.565s)
[504.192384] [132/133] (520s left) i915_pm_rpm (gem-evict-pwrite)
[506.216186] Starting subtest: gem-evict-pwrite
[506.221224] Subtest gem-evict-pwrite: SKIP (0.000s)
[506.603126] [133/133] (518s left) kms_prime (basic-crc-vgem)
[506.693624] Starting subtest: basic-crc-vgem
[506.695945] Starting dynamic subtest: second-to-first
[507.663753] Dynamic subtest second-to-first: SUCCESS (0.973s)
[507.665897] Subtest basic-crc-vgem: SUCCESS (0.975s)
[507.746493] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: i915_getparams_basic
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_lmem_evict
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_flush
results: parsing output: 9/ for test: kms_atomic
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gen9_exec_parse
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: syncobj_eventfd
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: gem_ctx_param
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: gem_exec_parallel
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_chamelium_color
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: gem_pwrite
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: kms_pm_dc
results: parsing output: 34/ for test: gem_watchdog
results: parsing output: 35/ for test: i915_pm_rps
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gen3_render_tiledy_blits
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_flink_basic
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_plane_alpha_blend
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_rotation_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_edid
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_exec_alignment
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_ctx_engines
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: kms_multipipe_modeset
results: parsing output: 70/ for test: gen7_exec_parse
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_vrr
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_pxp
results: parsing output: 89/ for test: gem_render_copy_redux
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_ctx_bad_destroy
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_chamelium_frames
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: kms_color
results: parsing output: 100/ for test: gem_ccs
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: prime_self_import
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_getfb
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_set_tiling_vs_blt
results: parsing output: 113/ for test: drm_mm
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_mmap_wc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: sw_sync
results: parsing output: 121/ for test: gem_ctx_sseu
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_joiner
results: parsing output: 124/ for test: kms_psr2_su
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: sriov_basic
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: i915_pm_rpm
results: parsing output: 132/ for test: kms_prime
Done.