[57.573809] Initializing watchdogs
[57.573854]   /dev/watchdog0
[57.587422] [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]
[57.591785] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.594030] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.597353] [001/132] (960s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[57.722733] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[57.727140] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[58.863094] [002/132] (959s left) i915_query (hwconfig_table)
[58.922058] Starting subtest: hwconfig_table
[59.220559] Subtest hwconfig_table: SUCCESS (0.002s)
[59.255263] [003/132] (958s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[59.354089] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[59.358625] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[59.456793] [004/132] (958s left) kms_setmode (basic-clone-single-crtc)
[59.522793] Starting subtest: basic-clone-single-crtc
[59.529671] Subtest basic-clone-single-crtc: SKIP (0.000s)
[59.619690] [005/132] (958s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[59.673567] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[59.678286] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[59.866087] [006/132] (958s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[59.951195] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[59.953537] Starting dynamic subtest: pipe-A
[59.971733] Dynamic subtest pipe-A: SKIP (0.017s)
[59.979549] Starting dynamic subtest: pipe-B
[60.005178] Dynamic subtest pipe-B: SKIP (0.034s)
[60.012123] Starting dynamic subtest: pipe-C
[60.040060] Dynamic subtest pipe-C: SKIP (0.035s)
[60.046785] Starting dynamic subtest: pipe-D
[60.073522] Dynamic subtest pipe-D: SKIP (0.034s)
[60.077293] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.121s)
[60.176189] [007/132] (958s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[60.289570] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[60.294356] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[60.432824] [008/132] (957s left) kms_hdr (invalid-hdr)
[60.523398] Starting subtest: invalid-hdr
[62.684510] Starting dynamic subtest: pipe-A-eDP-1
[65.076665] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.395s)
[65.079100] Subtest invalid-hdr: SUCCESS (4.562s)
[65.190238] [009/132] (953s left) gem_softpin (evict-active)
[65.248062] Starting subtest: evict-active
[65.254055] Subtest evict-active: SUCCESS (0.006s)
[65.359768] [010/132] (953s left) i915_pm_rc6_residency (rc6-accuracy)
[65.423051] Starting subtest: rc6-accuracy
[65.425329] Starting dynamic subtest: gt0
[68.594882] Dynamic subtest gt0: SUCCESS (3.171s)
[68.604496] Starting dynamic subtest: gt1
[71.763916] Dynamic subtest gt1: SUCCESS (3.169s)
[71.766557] Subtest rc6-accuracy: SUCCESS (6.343s)
[71.834794] [011/132] (946s left) gem_ctx_persistence (hang)
[71.884614] Starting subtest: hang
[71.889422] Subtest hang: SKIP (0.000s)
[71.985263] [012/132] (946s left) kms_getfb (getfb-handle-not-fb)
[72.078586] Starting subtest: getfb-handle-not-fb
[72.080894] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[72.171079] [013/132] (946s left) kms_psr (fbc-psr2-sprite-blt)
[72.265654] Starting subtest: fbc-psr2-sprite-blt
[72.267843] Starting dynamic subtest: eDP-1
[72.272114] Dynamic subtest eDP-1: SKIP (0.000s)
[72.276131] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[72.330971] [014/132] (946s left) kms_content_protection (uevent)
[72.475833] Starting subtest: uevent
[72.480667] Subtest uevent: SKIP (0.000s)
[72.610884] [015/132] (946s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[72.706235] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[72.710398] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[72.774404] [016/132] (945s left) perf (gen12-group-concurrent-oa-buffer-read)
[72.892523] Starting subtest: gen12-group-concurrent-oa-buffer-read
[82.916605] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.025s)
[82.959791] [017/132] (935s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[83.062032] Starting subtest: bad-rotation-90-yf-tiled-ccs
[83.064539] Starting dynamic subtest: pipe-A-eDP-1
[83.088203] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.097230] Starting dynamic subtest: pipe-B-eDP-1
[83.119359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.126814] Starting dynamic subtest: pipe-C-eDP-1
[83.147570] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.154898] Starting dynamic subtest: pipe-D-eDP-1
[83.176818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.180951] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[85.367719] [018/132] (933s left) kms_addfb_basic (bad-pitch-256)
[85.425829] Starting subtest: bad-pitch-256
[85.428372] Subtest bad-pitch-256: SUCCESS (0.000s)
[85.556469] [019/132] (933s left) prime_vgem (fence-write-hang)
[85.691905] Subtest fence-write-hang: SKIP (0.000s)
[85.778700] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true
[85.781590] [020/132] (933s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[85.879098] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[85.883617] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[85.963983] [021/132] (932s left) kms_chamelium_edid (dp-mode-timings)
[86.359651] Subtest dp-mode-timings: SKIP (0.000s)
[87.170773] [022/132] (931s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[87.282905] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[87.285338] Starting dynamic subtest: A-eDP1
[90.903732] Dynamic subtest A-eDP1: SUCCESS (3.622s)
[90.911082] Starting dynamic subtest: B-eDP1
[94.112058] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[94.120538] Starting dynamic subtest: C-eDP1
[97.233489] Dynamic subtest C-eDP1: SUCCESS (3.120s)
[97.240635] Starting dynamic subtest: D-eDP1
[100.325467] Dynamic subtest D-eDP1: SUCCESS (3.093s)
[100.327802] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.049s)
[101.132789] [023/132] (917s left) kms_addfb_basic (bad-pitch-63)
[101.186869] Starting subtest: bad-pitch-63
[101.189417] Subtest bad-pitch-63: SUCCESS (0.000s)
[101.350484] [024/132] (917s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[101.478441] Starting subtest: flip-vs-cursor-crc-legacy
[102.211051] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.732s)
[103.084751] [025/132] (915s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[103.166329] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[103.168552] Starting dynamic subtest: pipe-A-eDP-1
[103.191808] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.200421] Starting dynamic subtest: pipe-B-eDP-1
[103.221096] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.228047] Starting dynamic subtest: pipe-C-eDP-1
[103.248453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.255427] Starting dynamic subtest: pipe-D-eDP-1
[103.277262] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.281352] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[105.439481] [026/132] (913s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[105.541272] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[105.543433] Starting dynamic subtest: A-eDP1
[109.156756] Dynamic subtest A-eDP1: SUCCESS (3.613s)
[109.166062] Starting dynamic subtest: B-eDP1
[112.335314] Dynamic subtest B-eDP1: SUCCESS (3.177s)
[112.349329] Starting dynamic subtest: C-eDP1
[115.426785] Dynamic subtest C-eDP1: SUCCESS (3.092s)
[115.435685] Starting dynamic subtest: D-eDP1
[118.521841] Dynamic subtest D-eDP1: SUCCESS (3.095s)
[118.523933] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.983s)
[119.316418] [027/132] (899s left) perf_pmu (faulting-read)
[119.359382] Starting subtest: faulting-read
[119.361776] Starting dynamic subtest: wb
[119.364099] Dynamic subtest wb: SUCCESS (0.001s)
[119.372556] Starting dynamic subtest: wc
[119.374505] Dynamic subtest wc: SUCCESS (0.000s)
[119.381168] Starting dynamic subtest: uc
[119.383063] Dynamic subtest uc: SUCCESS (0.000s)
[119.384875] Subtest faulting-read: SUCCESS (0.002s)
[119.458606] [028/132] (899s left) gem_exec_params (sol-reset-not-gen7)
[119.517720] Starting subtest: sol-reset-not-gen7
[119.519743] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[119.636909] [029/132] (899s left) gem_exec_balancer (bonded-semaphore)
[119.696070] Starting subtest: bonded-semaphore
[119.700216] Subtest bonded-semaphore: SKIP (0.000s)
[119.987940] [030/132] (899s left) gem_wait (invalid-buf)
[120.051178] Starting subtest: invalid-buf
[120.053658] Subtest invalid-buf: SUCCESS (0.000s)
[120.249516] [031/132] (899s left) kms_psr (psr2-cursor-mmap-gtt)
[120.341268] Starting subtest: psr2-cursor-mmap-gtt
[120.343597] Starting dynamic subtest: eDP-1
[122.009963] Dynamic subtest eDP-1: SUCCESS (1.668s)
[122.012297] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.669s)
[122.894476] [032/132] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[123.000731] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[129.735240] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.738s)
[129.872166] [033/132] (889s left) gem_mmap_gtt (basic-small-copy-xy)
[129.943554] Subtest basic-small-copy-XY: SKIP (0.000s)
[130.007158] [034/132] (889s left) kms_psr (fbc-psr2-sprite-plane-move)
[130.095228] Starting subtest: fbc-psr2-sprite-plane-move
[130.097503] Starting dynamic subtest: eDP-1
[130.101702] Dynamic subtest eDP-1: SKIP (0.000s)
[130.105888] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[130.176957] [035/132] (889s left) kms_cursor_crc (cursor-random-max-size)
[130.477796] Starting subtest: cursor-random-max-size
[130.484351] Subtest cursor-random-max-size: SKIP (0.000s)
[130.646823] [036/132] (888s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[130.744477] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[130.748112] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[130.823781] [037/132] (888s left) gem_exec_reloc (basic-gtt-wc)
[130.891568] Subtest basic-gtt-wc: SKIP (0.000s)
[130.947693] [038/132] (888s left) device_reset (unbind-reset-rebind)
[130.998965] Starting subtest: unbind-reset-rebind
[134.002384] Subtest unbind-reset-rebind: SUCCESS (3.003s)
[134.048614] [039/132] (885s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[134.142101] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[139.120290] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.982s)
[140.248197] [040/132] (879s left) gem_exec_fence (keep-in-fence)
[140.425300] Starting subtest: keep-in-fence
[140.427232] Starting dynamic subtest: rcs0
[140.478789] Dynamic subtest rcs0: SUCCESS (0.056s)
[140.489613] Starting dynamic subtest: bcs0
[140.531982] Dynamic subtest bcs0: SUCCESS (0.051s)
[140.542714] Starting dynamic subtest: vcs0
[141.911085] Dynamic subtest vcs0: SUCCESS (1.376s)
[141.922766] Starting dynamic subtest: vcs1
[143.893084] Dynamic subtest vcs1: SUCCESS (1.980s)
[143.903951] Starting dynamic subtest: vecs0
[145.940904] Dynamic subtest vecs0: SUCCESS (2.045s)
[145.952425] Starting dynamic subtest: ccs0
[146.187827] Dynamic subtest ccs0: SUCCESS (0.246s)
[146.190803] Subtest keep-in-fence: SUCCESS (5.765s)
[147.992316] [041/132] (871s left) kms_invalid_mode (overflow-vrefresh)
[148.082941] Starting subtest: overflow-vrefresh
[148.085095] Starting dynamic subtest: pipe-A-eDP-1
[148.369433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[148.379072] Starting dynamic subtest: pipe-B-eDP-1
[148.381171] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[148.389067] Starting dynamic subtest: pipe-C-eDP-1
[148.391184] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[148.401757] Starting dynamic subtest: pipe-D-eDP-1
[148.404751] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[148.407800] Subtest overflow-vrefresh: SUCCESS (0.291s)
[149.169150] [042/132] (870s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[149.274446] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[149.278773] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[149.373160] [043/132] (870s left) gem_spin_batch (legacy-resubmit)
[149.428707] Starting subtest: legacy-resubmit
[149.431178] Starting dynamic subtest: default
[149.436102] Dynamic subtest default: SUCCESS (0.005s)
[149.447169] Starting dynamic subtest: render
[149.449349] Dynamic subtest render: SUCCESS (0.001s)
[149.457716] Starting dynamic subtest: bsd
[149.459923] Dynamic subtest bsd: SUCCESS (0.003s)
[149.467611] Starting dynamic subtest: bsd1
[149.469797] Dynamic subtest bsd1: SUCCESS (0.001s)
[149.477385] Starting dynamic subtest: bsd2
[149.479578] Dynamic subtest bsd2: SUCCESS (0.002s)
[149.487404] Starting dynamic subtest: blt
[149.489605] Dynamic subtest blt: SUCCESS (0.002s)
[149.497498] Starting dynamic subtest: vebox
[149.499681] Dynamic subtest vebox: SUCCESS (0.003s)
[149.501838] Subtest legacy-resubmit: SUCCESS (0.021s)
[149.677126] [044/132] (870s left) gem_busy (extended)
[149.857119] Starting subtest: extended
[149.859295] Starting dynamic subtest: rcs0
[149.949260] Dynamic subtest rcs0: SUCCESS (0.092s)
[149.959954] Starting dynamic subtest: bcs0
[149.991833] Dynamic subtest bcs0: SUCCESS (0.041s)
[150.001862] Starting dynamic subtest: vcs0
[151.891925] Dynamic subtest vcs0: SUCCESS (1.897s)
[151.902957] Starting dynamic subtest: vcs1
[153.877355] Dynamic subtest vcs1: SUCCESS (1.981s)
[153.888083] Starting dynamic subtest: vecs0
[155.925042] Dynamic subtest vecs0: SUCCESS (2.044s)
[155.936493] Starting dynamic subtest: ccs0
[155.971099] Dynamic subtest ccs0: SUCCESS (0.045s)
[155.973553] Subtest extended: SUCCESS (6.114s)
[156.210619] [045/132] (863s left) kms_rotation_crc (multiplane-rotation)
[156.307497] Starting subtest: multiplane-rotation
[173.759076] Subtest multiplane-rotation: SUCCESS (17.449s)
[173.873454] [046/132] (846s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[173.979609] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[173.983424] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[174.067373] [047/132] (845s left) kms_pm_rpm (dpms-lpsp)
[176.095482] Starting subtest: dpms-lpsp
[176.396039] Subtest dpms-lpsp: SUCCESS (0.301s)
[176.482973] [048/132] (843s left) gem_exec_suspend (basic)
[176.539676] Starting subtest: basic
[176.542261] Starting dynamic subtest: smem
[177.940234] Dynamic subtest smem: SUCCESS (1.398s)
[177.943072] Subtest basic: SUCCESS (1.401s)
[178.126922] [049/132] (841s left) gem_mmap_wc (read-write)
[178.197465] Subtest read-write: SKIP (0.000s)
[178.254761] [050/132] (841s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[178.359604] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[178.370993] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[178.483468] [051/132] (841s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[178.532227] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[178.640747] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[178.716460] [052/132] (841s left) gem_pxp (verify-pxp-stale-buf-execution)
[178.835695] Starting subtest: verify-pxp-stale-buf-execution
[179.897069] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[180.026024] [053/132] (840s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[180.121348] Starting subtest: 4-tiled-32bpp-rotate-0
[181.444722] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.323s)
[181.581250] [054/132] (838s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[181.670507] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[190.314642] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.646s)
[190.421659] [055/132] (829s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[190.522708] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[197.276186] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.756s)
[197.412668] [056/132] (822s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[197.512914] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[197.514730] Starting dynamic subtest: pipe-A-eDP-1
[199.614920] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.102s)
[199.632350] Starting dynamic subtest: pipe-B-eDP-1
[201.792279] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.177s)
[201.802764] Starting dynamic subtest: pipe-C-eDP-1
[203.885842] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.092s)
[203.894631] Starting dynamic subtest: pipe-D-eDP-1
[205.914485] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.028s)
[205.916891] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.403s)
[207.153944] [057/132] (813s left) kms_draw_crc (draw-method-mmap-cpu)
[207.255541] Starting subtest: draw-method-mmap-cpu
[207.257511] Starting dynamic subtest: xrgb8888-untiled
[207.497615] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[207.506684] Starting dynamic subtest: rgb565-untiled
[207.742306] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[207.752881] Starting dynamic subtest: xrgb2101010-untiled
[207.964574] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[207.977763] Starting dynamic subtest: xbgr16161616f-untiled
[208.208604] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.242s)
[208.221108] Starting dynamic subtest: xrgb8888-xtiled
[208.363705] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.153s)
[208.377988] Starting dynamic subtest: rgb565-xtiled
[208.497088] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[208.507035] Starting dynamic subtest: xrgb2101010-xtiled
[208.619360] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[208.631437] Starting dynamic subtest: xbgr16161616f-xtiled
[208.752676] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[208.761206] Starting dynamic subtest: xrgb8888-4tiled
[208.885833] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[208.896527] Starting dynamic subtest: rgb565-4tiled
[209.031292] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[209.039501] Starting dynamic subtest: xrgb2101010-4tiled
[209.175202] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.142s)
[209.187676] Starting dynamic subtest: xbgr16161616f-4tiled
[209.319525] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.142s)
[209.321456] Subtest draw-method-mmap-cpu: SUCCESS (2.067s)
[209.424918] [058/132] (811s left) gem_mmap (bad-size)
[209.478534] Subtest bad-size: SKIP (0.000s)
[209.537450] [059/132] (810s left) gem_exec_parallel (basic)
[209.597082] Starting subtest: basic
[209.599156] Starting dynamic subtest: rcs0
[211.008049] Dynamic subtest rcs0: SUCCESS (1.410s)
[211.020188] Starting dynamic subtest: bcs0
[212.496777] Dynamic subtest bcs0: SUCCESS (1.485s)
[212.507854] Starting dynamic subtest: vcs0
[213.875704] Dynamic subtest vcs0: SUCCESS (1.377s)
[213.884417] Starting dynamic subtest: vcs1
[215.893439] Dynamic subtest vcs1: SUCCESS (2.013s)
[215.904835] Starting dynamic subtest: vecs0
[217.876594] Dynamic subtest vecs0: SUCCESS (1.980s)
[217.886800] Starting dynamic subtest: ccs0
[219.362657] Dynamic subtest ccs0: SUCCESS (1.485s)
[219.364956] Subtest basic: SUCCESS (9.766s)
[219.551936] [060/132] (800s left) kms_cursor_crc (cursor-sliding-512x512)
[219.827626] Starting subtest: cursor-sliding-512x512
[219.831577] Subtest cursor-sliding-512x512: SKIP (0.001s)
[219.988647] [061/132] (800s left) syncobj_basic (bad-pad-handle-to-fd)
[220.050906] Starting subtest: bad-pad-handle-to-fd
[220.053209] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[220.154403] [062/132] (800s left) perf (non-system-wide-paranoid)
[220.272040] Starting subtest: non-system-wide-paranoid
[220.294271] Subtest non-system-wide-paranoid: SUCCESS (0.022s)
[220.349394] [063/132] (800s left) kms_vrr (flip-basic-fastset)
[220.441190] Starting subtest: flip-basic-fastset
[220.447366] Subtest flip-basic-fastset: SKIP (0.000s)
[220.525929] [064/132] (800s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[220.620380] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[221.589110] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.963s)
[221.713524] [065/132] (799s left) gem_flink_basic (bad-open)
[221.775083] Starting subtest: bad-open
[221.776975] Subtest bad-open: SUCCESS (0.000s)
[221.884591] [066/132] (798s left) kms_addfb_basic (master-rmfb)
[221.951877] Starting subtest: master-rmfb
[221.953857] Subtest master-rmfb: SUCCESS (0.001s)
[222.077872] [067/132] (798s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[222.123986] Starting subtest: invalid-single-wait-unsubmitted
[222.126054] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[222.225447] [068/132] (798s left) syncobj_timeline (multi-wait-signaled)
[222.274510] Starting subtest: multi-wait-signaled
[222.276371] Subtest multi-wait-signaled: SUCCESS (0.001s)
[222.364919] [069/132] (798s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[222.461667] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[222.463499] Starting dynamic subtest: pipe-A-eDP-1
[228.344310] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.884s)
[228.352607] Starting dynamic subtest: pipe-B-eDP-1
[234.990207] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.645s)
[234.992713] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.533s)
[235.879246] [070/132] (785s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[235.974790] Starting subtest: yf-tiled-8bpp-rotate-0
[235.979189] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[236.073380] [071/132] (784s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[236.178159] Starting subtest: 2x-long-cursor-vs-flip-atomic
[236.182570] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[236.324834] [072/132] (784s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[236.423301] Starting subtest: x-tiled-64bpp-rotate-270
[236.443579] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[236.549440] [073/132] (784s left) kms_pipe_crc_basic (read-crc)
[236.638105] Starting subtest: read-crc
[236.640239] Starting dynamic subtest: pipe-A-eDP-1
[237.379589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[237.388199] Starting dynamic subtest: pipe-B-eDP-1
[238.757197] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[238.766219] Starting dynamic subtest: pipe-C-eDP-1
[240.125720] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[240.134813] Starting dynamic subtest: pipe-D-eDP-1
[241.466231] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[241.468611] Subtest read-crc: SUCCESS (4.829s)
[242.284262] [074/132] (778s left) kms_atomic (atomic-plane-damage)
[242.373486] Starting subtest: atomic-plane-damage
[242.422702] Starting dynamic subtest: pipe-A-eDP-1
[242.964964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[242.967370] Subtest atomic-plane-damage: SUCCESS (0.593s)
[243.801661] [075/132] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[243.900582] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[243.904833] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[243.990511] [076/132] (777s left) kms_psr (psr2-basic)
[244.082298] Starting subtest: psr2-basic
[244.084556] Starting dynamic subtest: eDP-1
[245.691811] Dynamic subtest eDP-1: SUCCESS (1.610s)
[245.694164] Subtest psr2-basic: SUCCESS (1.611s)
[246.502789] [077/132] (774s left) api_intel_bb (full-batch)
[246.563644] Starting subtest: full-batch
[246.568820] Subtest full-batch: SUCCESS (0.006s)
[246.678096] [078/132] (774s left) gem_exec_schedule (u-lateslice)
[246.744485] Starting subtest: u-lateslice
[246.746401] Starting dynamic subtest: rcs0
[246.756948] Dynamic subtest rcs0: SUCCESS (0.021s)
[246.767566] Starting dynamic subtest: bcs0
[246.775390] Dynamic subtest bcs0: SUCCESS (0.017s)
[246.786305] Starting dynamic subtest: vcs0
[246.794264] Dynamic subtest vcs0: SUCCESS (0.019s)
[246.802566] Starting dynamic subtest: vcs1
[246.814798] Dynamic subtest vcs1: SUCCESS (0.019s)
[246.823065] Starting dynamic subtest: vecs0
[246.833326] Dynamic subtest vecs0: SUCCESS (0.018s)
[246.841396] Starting dynamic subtest: ccs0
[246.851250] Dynamic subtest ccs0: SUCCESS (0.017s)
[246.853312] Subtest u-lateslice: SUCCESS (0.116s)
[247.967609] [079/132] (773s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[248.061785] Starting subtest: fbc-rgb565-draw-pwrite
[252.851460] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.793s)
[254.016850] [080/132] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[254.119951] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[260.960940] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.843s)
[261.109979] [081/132] (760s left) syncobj_timeline (wait-any-interrupted)
[261.170785] Starting subtest: wait-any-interrupted
[261.271879] Subtest wait-any-interrupted: SUCCESS (0.102s)
[261.351892] [082/132] (760s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[261.754908] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[262.533407] [083/132] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[262.636074] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[266.270045] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.638s)
[267.464007] [084/132] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[267.559575] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[267.563986] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[267.657360] [085/132] (753s left) gem_mmap_wc (read)
[267.719620] Subtest read: SKIP (0.000s)
[267.798976] [086/132] (753s left) kms_pm_rpm (system-suspend-modeset)
[270.028159] Starting subtest: system-suspend-modeset
[289.520310] Subtest system-suspend-modeset: SUCCESS (4.770s)
[289.903119] [087/132] (731s left) gem_exec_parallel (userptr)
[289.977584] Starting subtest: userptr
[289.980075] Starting dynamic subtest: rcs0
[291.392159] Dynamic subtest rcs0: SUCCESS (1.424s)
[291.403612] Starting dynamic subtest: bcs0
[292.851526] Dynamic subtest bcs0: SUCCESS (1.466s)
[292.861507] Starting dynamic subtest: vcs0
[294.638485] Dynamic subtest vcs0: SUCCESS (1.792s)
[294.650184] Starting dynamic subtest: vcs1
[296.651010] Dynamic subtest vcs1: SUCCESS (1.988s)
[296.663598] Starting dynamic subtest: vecs0
[298.605392] Dynamic subtest vecs0: SUCCESS (1.990s)
[298.618437] Starting dynamic subtest: ccs0
[300.084620] Dynamic subtest ccs0: SUCCESS (1.482s)
[300.087056] Subtest userptr: SUCCESS (10.153s)
[300.274028] [088/132] (721s left) kms_sequence (get-forked-busy)
[300.360568] Starting subtest: get-forked-busy
[300.362814] Starting dynamic subtest: pipe-A-eDP-1
[302.290933] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[302.300535] Starting dynamic subtest: pipe-B-eDP-1
[304.938469] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.647s)
[304.947522] Starting dynamic subtest: pipe-C-eDP-1
[307.556323] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s)
[307.565825] Starting dynamic subtest: pipe-D-eDP-1
[310.185654] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.630s)
[310.187577] Subtest get-forked-busy: SUCCESS (9.839s)
[311.074045] [089/132] (710s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[311.170181] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[311.174741] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[311.244841] [090/132] (710s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[311.333442] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[311.337844] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[311.433877] [091/132] (710s left) kms_plane_cursor (viewport)
[311.525165] Starting subtest: viewport
[311.529411] Starting dynamic subtest: pipe-A-eDP-1-size-64
[314.043877] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.523s)
[314.104988] Starting dynamic subtest: pipe-A-eDP-1-size-128
[316.499779] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.404s)
[316.562060] Starting dynamic subtest: pipe-A-eDP-1-size-256
[319.034049] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.482s)
[319.383579] Starting dynamic subtest: pipe-B-eDP-1-size-64
[322.581612] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.206s)
[322.640357] Starting dynamic subtest: pipe-B-eDP-1-size-128
[325.216979] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[325.277863] Starting dynamic subtest: pipe-B-eDP-1-size-256
[327.773045] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s)
[328.126444] Starting dynamic subtest: pipe-C-eDP-1-size-64
[330.953867] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.839s)
[330.990950] Starting dynamic subtest: pipe-C-eDP-1-size-128
[333.051852] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.069s)
[333.091439] Starting dynamic subtest: pipe-C-eDP-1-size-256
[335.186321] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.102s)
[335.515783] Starting dynamic subtest: pipe-D-eDP-1-size-64
[338.455185] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.951s)
[338.492208] Starting dynamic subtest: pipe-D-eDP-1-size-128
[340.710888] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s)
[340.748976] Starting dynamic subtest: pipe-D-eDP-1-size-256
[342.877522] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.136s)
[343.197316] Subtest viewport: SUCCESS (31.675s)
[343.991193] [092/132] (677s left) syncobj_timeline (etime-single-wait-all-submitted)
[344.058280] Starting subtest: etime-single-wait-all-submitted
[344.161951] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[344.253214] [093/132] (677s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[344.357727] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[344.361950] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[344.426820] [094/132] (677s left) gem_mmap_offset (ptrace)
[344.495185] Starting subtest: ptrace
[344.497520] Starting dynamic subtest: smem0-wb
[344.513273] Dynamic subtest smem0-wb: SUCCESS (0.017s)
[344.524521] Starting dynamic subtest: smem0-wc
[344.532680] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[344.541463] Starting dynamic subtest: smem0-uc
[344.553180] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[344.555537] Subtest ptrace: SUCCESS (0.060s)
[344.640420] [095/132] (677s left) gem_exec_whisper (basic-queues)
[344.696650] Starting subtest: basic-queues
[350.607830] Subtest basic-queues: SUCCESS (5.910s)
[350.794396] [096/132] (671s left) gem_vm_create (isolation)
[350.848657] Starting subtest: isolation
[350.862236] Subtest isolation: SUCCESS (0.014s)
[350.992635] [097/132] (671s left) gen9_exec_parse (allowed-single)
[351.062670] Subtest allowed-single: SKIP (0.000s)
[351.119538] [098/132] (670s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[351.214911] Starting subtest: x-tiled-addfb-size-offset-overflow
[351.217285] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[351.307682] [099/132] (670s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[351.397849] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[358.778145] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.384s)
[358.912761] [100/132] (663s left) kms_rotation_crc (sprite-rotation-90)
[359.007834] Starting subtest: sprite-rotation-90
[359.012286] Subtest sprite-rotation-90: SKIP (0.001s)
[359.082222] [101/132] (663s left) kms_cursor_crc (cursor-onscreen-max-size)
[359.370645] Starting subtest: cursor-onscreen-max-size
[359.377003] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[359.506698] [102/132] (662s left) gem_exec_fence (basic-await)
[359.690166] Starting subtest: basic-await
[359.692081] Starting dynamic subtest: rcs0
[359.765729] Dynamic subtest rcs0: SUCCESS (0.078s)
[359.779888] Starting dynamic subtest: bcs0
[359.840054] Dynamic subtest bcs0: SUCCESS (0.073s)
[359.852510] Starting dynamic subtest: vcs0
[359.913535] Dynamic subtest vcs0: SUCCESS (0.072s)
[359.925819] Starting dynamic subtest: vcs1
[359.987240] Dynamic subtest vcs1: SUCCESS (0.071s)
[359.999449] Starting dynamic subtest: vecs0
[360.058851] Dynamic subtest vecs0: SUCCESS (0.070s)
[360.071218] Starting dynamic subtest: ccs0
[360.132211] Dynamic subtest ccs0: SUCCESS (0.071s)
[360.135004] Subtest basic-await: SUCCESS (0.446s)
[361.715411] [103/132] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[361.824581] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[361.828662] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[361.910435] [104/132] (660s left) kms_addfb_basic (too-wide)
[362.005232] Starting subtest: too-wide
[362.007389] Subtest too-wide: SUCCESS (0.000s)
[362.111250] [105/132] (660s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[362.163105] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[362.265653] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[362.345050] [106/132] (660s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[362.439407] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[369.150701] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.719s)
[369.264618] [107/132] (653s left) gem_exec_reloc (basic-gtt-read-active)
[369.333940] Subtest basic-gtt-read-active: SKIP (0.000s)
[369.410105] [108/132] (653s left) gem_softpin (softpin)
[369.484511] Starting subtest: softpin
[401.855035] Subtest softpin: SUCCESS (32.363s)
[401.982092] [109/132] (620s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[402.076463] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[402.080957] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[402.176555] [110/132] (620s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[402.265342] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[402.267621] Starting dynamic subtest: pipe-A
[402.607320] Dynamic subtest pipe-A: SUCCESS (0.342s)
[402.620655] Starting dynamic subtest: pipe-B
[404.033850] Dynamic subtest pipe-B: SUCCESS (1.425s)
[404.044197] Starting dynamic subtest: pipe-C
[405.484027] Dynamic subtest pipe-C: SUCCESS (1.449s)
[405.494420] Starting dynamic subtest: pipe-D
[406.969912] Dynamic subtest pipe-D: SUCCESS (1.484s)
[406.972270] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.706s)
[408.153692] [111/132] (614s left) kms_flip (2x-flip-vs-modeset)
[408.257086] Starting subtest: 2x-flip-vs-modeset
[408.265696] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[408.365599] [112/132] (614s left) kms_mmap_write_crc (main)
[408.464815] Starting subtest: main
[408.467101] Starting dynamic subtest: pipe-A-eDP-1
[411.856082] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.389s)
[411.858364] Subtest main: SUCCESS (3.390s)
[412.702209] [113/132] (610s left) kms_color (invalid-degamma-lut-sizes)
[412.803757] Starting subtest: invalid-degamma-lut-sizes
[412.805991] Starting dynamic subtest: pipe-A
[413.090270] Dynamic subtest pipe-A: SUCCESS (0.286s)
[413.100184] Starting dynamic subtest: pipe-B
[413.102414] Dynamic subtest pipe-B: SUCCESS (0.000s)
[413.111529] Starting dynamic subtest: pipe-C
[413.113762] Dynamic subtest pipe-C: SUCCESS (0.000s)
[413.122759] Starting dynamic subtest: pipe-D
[413.124639] Dynamic subtest pipe-D: SUCCESS (0.000s)
[413.126530] Subtest invalid-degamma-lut-sizes: SUCCESS (0.290s)
[413.915678] [114/132] (608s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[414.031092] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[414.035569] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[414.147875] [115/132] (608s left) gem_ctx_persistence (engines-queued)
[414.204003] Starting subtest: engines-queued
[414.206099] Starting dynamic subtest: rcs0
[414.270724] Dynamic subtest rcs0: SUCCESS (0.066s)
[414.282618] Starting dynamic subtest: bcs0
[414.314486] Dynamic subtest bcs0: SUCCESS (0.042s)
[414.324852] Starting dynamic subtest: vcs0
[415.630718] Dynamic subtest vcs0: SUCCESS (1.313s)
[415.642691] Starting dynamic subtest: vcs1
[417.611610] Dynamic subtest vcs1: SUCCESS (1.978s)
[417.623490] Starting dynamic subtest: vecs0
[419.595584] Dynamic subtest vecs0: SUCCESS (1.981s)
[419.607493] Starting dynamic subtest: ccs0
[419.768693] Dynamic subtest ccs0: SUCCESS (0.172s)
[419.771097] Subtest engines-queued: SUCCESS (5.565s)
[419.888542] [116/132] (602s left) perf (oa-formats)
[419.990110] Starting subtest: oa-formats
[419.992496] Starting dynamic subtest: 0-rcs0
[420.003772] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[420.014482] Starting dynamic subtest: 1-vecs0
[420.026936] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[420.029039] Subtest oa-formats: SUCCESS (0.038s)
[420.077008] [117/132] (602s left) gem_mmap_gtt (fault-concurrent-y)
[420.136067] Subtest fault-concurrent-Y: SKIP (0.000s)
[420.206243] [118/132] (602s left) i915_drm_fdinfo (all-busy-idle-check-all)
[420.246151] Starting subtest: all-busy-idle-check-all
[420.253364] Subtest all-busy-idle-check-all: SKIP (0.006s)
[420.326620] [119/132] (602s left) prime_vgem (fence-flip-hang)
[420.422049] Subtest fence-flip-hang: SKIP (0.000s)
[420.520288] [120/132] (602s left) kms_chamelium_audio (dp-audio-edid)
[420.905076] Subtest dp-audio-edid: SKIP (0.000s)
[421.717269] [121/132] (601s left) sw_sync (timeline_closed)
[421.758088] Starting subtest: timeline_closed
[421.760330] Subtest timeline_closed: SUCCESS (0.000s)
[421.813619] [122/132] (601s left) gem_ccs (suspend-resume)
[421.869218] Starting subtest: suspend-resume
[421.873784] Subtest suspend-resume: SKIP (0.000s)
[421.970702] [123/132] (601s left) gem_exec_whisper (basic-queues-forked)
[422.036724] Starting subtest: basic-queues-forked
[445.063513] Subtest basic-queues-forked: SUCCESS (23.024s)
[445.246887] [124/132] (577s left) i915_hangman (engine-engine-hang)
[445.313355] Starting subtest: engine-engine-hang
[445.315483] Starting dynamic subtest: rcs0
[446.608457] Dynamic subtest rcs0: SUCCESS (1.288s)
[446.618676] Starting dynamic subtest: bcs0
[448.588181] Dynamic subtest bcs0: SUCCESS (1.983s)
[448.599835] Starting dynamic subtest: vcs0
[450.571297] Dynamic subtest vcs0: SUCCESS (1.982s)
[450.587082] Starting dynamic subtest: vcs1
[451.594690] Dynamic subtest vcs1: SUCCESS (1.021s)
[451.606864] Starting dynamic subtest: vecs0
[453.643840] Dynamic subtest vecs0: SUCCESS (2.046s)
[453.656387] Starting dynamic subtest: ccs0
[455.627764] Dynamic subtest ccs0: SUCCESS (1.982s)
[455.630449] Subtest engine-engine-hang: SUCCESS (10.317s)
[455.747737] [125/132] (567s left) gem_exec_schedule (noreorder)
[455.920642] Starting subtest: noreorder
[455.923175] Starting dynamic subtest: rcs0
[455.995233] Dynamic subtest rcs0: SUCCESS (0.074s)
[456.005643] Starting dynamic subtest: vcs0
[457.641838] Dynamic subtest vcs0: SUCCESS (1.643s)
[457.653471] Starting dynamic subtest: vcs1
[459.623945] Dynamic subtest vcs1: SUCCESS (1.980s)
[459.636637] Starting dynamic subtest: vecs0
[461.689539] Dynamic subtest vecs0: SUCCESS (2.042s)
[461.703873] Starting dynamic subtest: ccs0
[461.732370] Dynamic subtest ccs0: SUCCESS (0.064s)
[461.734702] Subtest noreorder: SUCCESS (5.814s)
[461.918363] [126/132] (561s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[462.037755] Starting subtest: cursorA-vs-flipB-legacy
[462.042443] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[462.180253] [127/132] (561s left) gem_exec_capture (userptr)
[462.238098] Starting subtest: userptr
[463.061781] Subtest userptr: SUCCESS (0.823s)
[463.195670] [128/132] (560s left) perf (polling-small-buf)
[463.303820] Starting subtest: polling-small-buf
[463.390869] Subtest polling-small-buf: SUCCESS (0.087s)
[463.438372] [129/132] (559s left) kms_flip (flip-vs-expired-vblank)
[463.522880] Starting subtest: flip-vs-expired-vblank
[463.525121] Starting dynamic subtest: A-eDP1
[472.233438] Dynamic subtest A-eDP1: SUCCESS (8.712s)
[472.244496] Starting dynamic subtest: B-eDP1
[480.961709] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[480.982625] Starting dynamic subtest: C-eDP1
[489.681463] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[489.695274] Starting dynamic subtest: D-eDP1
[498.319604] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[498.324707] Subtest flip-vs-expired-vblank: SUCCESS (34.810s)
[499.501562] [130/132] (523s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[499.606449] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[499.610600] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[499.673408] [131/132] (523s left) gem_exec_reloc (basic-cpu-wc-active)
[499.740464] Subtest basic-cpu-wc-active: SKIP (0.000s)
[499.826943] [132/132] (523s left) sysfs_preempt_timeout (invalid)
[499.875224] Starting subtest: invalid
[499.877623] Starting dynamic subtest: vecs0
[499.879828] Dynamic subtest vecs0: SUCCESS (0.000s)
[499.890600] Starting dynamic subtest: ccs0
[499.892807] Dynamic subtest ccs0: SUCCESS (0.000s)
[499.901697] Starting dynamic subtest: vcs0
[499.903527] Dynamic subtest vcs0: SUCCESS (0.000s)
[499.912059] Starting dynamic subtest: bcs0
[499.913970] Dynamic subtest bcs0: SUCCESS (0.000s)
[499.922494] Starting dynamic subtest: rcs0
[499.924403] Dynamic subtest rcs0: SUCCESS (0.000s)
[499.932920] Starting dynamic subtest: vcs1
[499.935352] Dynamic subtest vcs1: SUCCESS (0.000s)
[499.937621] Subtest invalid: SUCCESS (0.005s)
[499.990301] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_setmode
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_hdr
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: i915_pm_rc6_residency
results: parsing output: 10/ for test: gem_ctx_persistence
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_chamelium_edid
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: gem_wait
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: device_reset
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_spin_batch
results: parsing output: 43/ for test: gem_busy
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: gem_exec_suspend
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_draw_crc
results: parsing output: 57/ for test: gem_mmap
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: syncobj_basic
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_flink_basic
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_pipe_crc_basic
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: gem_exec_parallel
results: parsing output: 87/ for test: kms_sequence
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane_cursor
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_mmap_offset
results: parsing output: 94/ for test: gem_exec_whisper
results: parsing output: 95/ for test: gem_vm_create
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_mmap_write_crc
results: parsing output: 112/ for test: kms_color
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: i915_drm_fdinfo
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_chamelium_audio
results: parsing output: 120/ for test: sw_sync
results: parsing output: 121/ for test: gem_ccs
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: i915_hangman
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_exec_capture
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: sysfs_preempt_timeout
Done.