[58.786137] Initializing watchdogs
[58.786188]   /dev/watchdog0
[58.801204] [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.805732] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.807946] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.811407] [001/132] (960s left) kms_invalid_mode (bad-hsync-end)
[58.929007] Starting subtest: bad-hsync-end
[58.931254] Starting dynamic subtest: pipe-A-eDP-1
[59.217839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[59.227880] Starting dynamic subtest: pipe-B-eDP-1
[59.230303] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[59.237283] Starting dynamic subtest: pipe-C-eDP-1
[59.239480] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[59.246574] Starting dynamic subtest: pipe-D-eDP-1
[59.248673] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[59.250801] Subtest bad-hsync-end: SUCCESS (0.295s)
[60.030871] [002/132] (959s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[60.122267] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[60.124696] Starting dynamic subtest: pipe-A
[60.145579] Dynamic subtest pipe-A: SKIP (0.019s)
[60.154195] Starting dynamic subtest: pipe-B
[60.179341] Dynamic subtest pipe-B: SKIP (0.035s)
[60.186947] Starting dynamic subtest: pipe-C
[60.214479] Dynamic subtest pipe-C: SKIP (0.036s)
[60.221552] Starting dynamic subtest: pipe-D
[60.250212] Dynamic subtest pipe-D: SKIP (0.035s)
[60.254567] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.126s)
[60.330647] [003/132] (959s left) kms_big_fb (linear-64bpp-rotate-180)
[60.441970] Starting subtest: linear-64bpp-rotate-180
[62.019109] Subtest linear-64bpp-rotate-180: SUCCESS (1.578s)
[62.187908] [004/132] (957s left) syncobj_timeline (single-wait-all-available-submitted)
[62.243771] Starting subtest: single-wait-all-available-submitted
[62.246113] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[62.339210] [005/132] (957s left) gem_exec_params (no-bsd)
[62.412899] Starting subtest: no-bsd
[62.416739] Subtest no-bsd: SUCCESS (0.003s)
[64.418894] [006/132] (955s left) gem_flink_race (flink_close)
[64.453484] Starting subtest: flink_close
[69.557200] Subtest flink_close: SUCCESS (5.098s)
[69.636320] [007/132] (949s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[69.738805] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[69.741366] Starting dynamic subtest: pipe-A-eDP-1
[69.750921] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[69.764186] Starting dynamic subtest: pipe-B-eDP-1
[69.772856] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[69.780656] Starting dynamic subtest: pipe-C-eDP-1
[69.789098] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[69.796081] Starting dynamic subtest: pipe-D-eDP-1
[69.804736] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[69.809137] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[72.014566] [008/132] (947s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[72.113043] Starting subtest: fbc-rgb101010-draw-mmap-wc
[76.692975] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.583s)
[77.805674] [009/132] (941s left) syncobj_timeline (host-signal-ordered)
[77.871481] Starting subtest: host-signal-ordered
[77.873835] Subtest host-signal-ordered: SUCCESS (0.001s)
[77.977010] [010/132] (941s left) kms_pipe_crc_basic (suspend-read-crc)
[78.064820] Starting subtest: suspend-read-crc
[78.066741] Starting dynamic subtest: pipe-A-eDP-1
[96.513930] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.048s)
[96.523855] Starting dynamic subtest: pipe-B-eDP-1
[115.497245] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.511s)
[115.505697] Starting dynamic subtest: pipe-C-eDP-1
[134.459677] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.520s)
[134.470445] Starting dynamic subtest: pipe-D-eDP-1
[153.453590] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.463s)
[153.455616] Subtest suspend-read-crc: SUCCESS (13.547s)
[159.337216] [011/132] (865s left) gem_ctx_freq (sysfs)
[159.419885] Starting subtest: sysfs
[159.422482] Starting dynamic subtest: gt0
[164.938947] Dynamic subtest gt0: SUCCESS (5.517s)
[164.950765] Starting dynamic subtest: gt1
[206.195984] Dynamic subtest gt1: SUCCESS (41.252s)
[206.198444] Subtest sysfs: SUCCESS (46.770s)
[206.315404] [012/132] (818s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[206.446650] Starting subtest: cursorA-vs-flipB-toggle
[206.451047] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[206.588384] [013/132] (818s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[206.655820] Starting subtest: map-fixed-invalidate-overlap-busy
[206.660496] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[206.785006] [014/132] (818s left) gem_pwrite (basic-random)
[206.832288] Subtest basic-random: SKIP (0.000s)
[206.889179] [015/132] (818s left) kms_cursor_edge_walk (128x128-top-bottom)
[206.971595] Starting subtest: 128x128-top-bottom
[206.973802] Starting dynamic subtest: pipe-A-eDP-1
[210.431799] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[210.442095] Starting dynamic subtest: pipe-D-eDP-1
[213.565114] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[213.567515] Subtest 128x128-top-bottom: SUCCESS (6.593s)
[214.390978] [016/132] (810s left) kms_psr2_su (page_flip-p010)
[214.444037] Subtest page_flip-P010: SKIP (0.000s)
[214.497392] [017/132] (810s left) gem_ctx_persistence (legacy-engines-cleanup)
[214.569850] Starting subtest: legacy-engines-cleanup
[214.572287] Starting dynamic subtest: render
[214.635904] Dynamic subtest render: SUCCESS (0.066s)
[214.647457] Starting dynamic subtest: bsd1
[214.652644] Dynamic subtest bsd1: SUCCESS (0.015s)
[214.661037] Starting dynamic subtest: bsd2
[214.707857] Dynamic subtest bsd2: SUCCESS (0.054s)
[214.719147] Starting dynamic subtest: blt
[214.741614] Dynamic subtest blt: SUCCESS (0.032s)
[214.750592] Starting dynamic subtest: vebox
[214.779678] Dynamic subtest vebox: SUCCESS (0.036s)
[214.782166] Subtest legacy-engines-cleanup: SUCCESS (0.211s)
[214.862143] [018/132] (810s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[214.956811] Starting subtest: psr-1p-pri-indfb-multidraw
[237.998680] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.046s)
[238.124404] [019/132] (786s left) kms_getfb (getfb-repeated-different-handles)
[238.228677] Starting subtest: getfb-repeated-different-handles
[238.230456] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[238.335973] [020/132] (786s left) kms_vblank (invalid)
[238.423417] Starting subtest: invalid
[238.425297] Starting dynamic subtest: pipe-A-eDP-1
[238.822127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[238.824947] Subtest invalid: SUCCESS (0.398s)
[239.625536] [021/132] (785s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[239.736215] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[246.827563] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.095s)
[246.964096] [022/132] (778s left) gem_exec_store (cachelines)
[247.022516] Starting subtest: cachelines
[247.024364] Starting dynamic subtest: rcs0
[247.091885] Dynamic subtest rcs0: SUCCESS (0.070s)
[247.103127] Starting dynamic subtest: bcs0
[247.152471] Dynamic subtest bcs0: SUCCESS (0.059s)
[247.163487] Starting dynamic subtest: vcs0
[247.206384] Dynamic subtest vcs0: SUCCESS (0.052s)
[247.216824] Starting dynamic subtest: vcs1
[247.258226] Dynamic subtest vcs1: SUCCESS (0.050s)
[247.268845] Starting dynamic subtest: vecs0
[247.310483] Dynamic subtest vecs0: SUCCESS (0.050s)
[247.320946] Starting dynamic subtest: ccs0
[247.364902] Dynamic subtest ccs0: SUCCESS (0.052s)
[247.367483] Subtest cachelines: SUCCESS (0.345s)
[247.563101] [023/132] (777s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[247.657198] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[247.661534] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[247.755982] [024/132] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[247.852513] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[247.856558] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[247.961825] [025/132] (777s left) kms_cursor_crc (cursor-random-128x128)
[248.162062] Starting subtest: cursor-random-128x128
[248.166853] Starting dynamic subtest: pipe-A-eDP-1
[251.477772] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.309s)
[251.505736] Starting dynamic subtest: pipe-D-eDP-1
[255.460470] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.961s)
[255.462668] Subtest cursor-random-128x128: SUCCESS (7.297s)
[256.308171] [026/132] (769s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[256.412437] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[263.127536] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.718s)
[263.251029] [027/132] (762s left) gem_ctx_exec (basic-close-race)
[263.308631] Starting subtest: basic-close-race
[269.167492] Subtest basic-close-race: SUCCESS (5.806s)
[269.271803] [028/132] (756s left) kms_draw_crc (draw-method-mmap-wc)
[269.366386] Starting subtest: draw-method-mmap-wc
[269.368263] Starting dynamic subtest: xrgb8888-untiled
[269.585529] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[269.597297] Starting dynamic subtest: rgb565-untiled
[269.819651] Dynamic subtest rgb565-untiled: SUCCESS (0.231s)
[269.828871] Starting dynamic subtest: xrgb2101010-untiled
[270.029722] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.208s)
[270.038988] Starting dynamic subtest: xbgr16161616f-untiled
[270.229506] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[270.238147] Starting dynamic subtest: xrgb8888-xtiled
[270.362832] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[270.371671] Starting dynamic subtest: rgb565-xtiled
[270.496432] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[270.508077] Starting dynamic subtest: xrgb2101010-xtiled
[270.629402] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[270.638829] Starting dynamic subtest: xbgr16161616f-xtiled
[270.762917] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[270.771736] Starting dynamic subtest: xrgb8888-4tiled
[270.918492] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[270.926955] Starting dynamic subtest: rgb565-4tiled
[271.064329] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[271.072672] Starting dynamic subtest: xrgb2101010-4tiled
[271.207330] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[271.218093] Starting dynamic subtest: xbgr16161616f-4tiled
[271.385497] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.175s)
[271.387352] Subtest draw-method-mmap-wc: SUCCESS (2.022s)
[271.476853] [029/132] (754s left) kms_chamelium_hpd (dp-hpd-storm)
[271.866665] Subtest dp-hpd-storm: SKIP (0.000s)
[272.641041] [030/132] (752s left) gem_exec_fence (basic-wait)
[272.830476] Starting subtest: basic-wait
[272.832822] Starting dynamic subtest: rcs0
[272.907469] Dynamic subtest rcs0: SUCCESS (0.077s)
[272.919157] Starting dynamic subtest: bcs0
[272.966652] Dynamic subtest bcs0: SUCCESS (0.057s)
[272.977973] Starting dynamic subtest: vcs0
[273.025449] Dynamic subtest vcs0: SUCCESS (0.057s)
[273.036711] Starting dynamic subtest: vcs1
[273.085488] Dynamic subtest vcs1: SUCCESS (0.057s)
[273.096967] Starting dynamic subtest: vecs0
[273.151662] Dynamic subtest vecs0: SUCCESS (0.064s)
[273.162963] Starting dynamic subtest: ccs0
[273.213863] Dynamic subtest ccs0: SUCCESS (0.060s)
[273.216345] Subtest basic-wait: SUCCESS (0.385s)
[275.178663] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[275.182273] [031/132] (750s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[275.271405] Starting subtest: fbc-dirtyfb-ioctl
[275.273614] Starting dynamic subtest: A-eDP-1
[277.827903] Dynamic subtest A-eDP-1: SUCCESS (2.557s)
[277.830357] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.559s)
[278.634994] [032/132] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[278.737888] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[278.742328] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[278.819966] [033/132] (746s left) gen9_exec_parse (unaligned-jump)
[278.893959] Subtest unaligned-jump: SKIP (0.000s)
[278.967404] [034/132] (746s left) gem_exec_async (forked-writes)
[279.027489] Starting subtest: forked-writes
[279.029698] Starting dynamic subtest: rcs0
[279.056886] Dynamic subtest rcs0: SUCCESS (0.029s)
[279.068901] Starting dynamic subtest: bcs0
[279.080899] Dynamic subtest bcs0: SUCCESS (0.023s)
[279.093439] Starting dynamic subtest: vcs0
[279.103742] Dynamic subtest vcs0: SUCCESS (0.022s)
[279.113863] Starting dynamic subtest: vcs1
[279.128604] Dynamic subtest vcs1: SUCCESS (0.024s)
[279.138598] Starting dynamic subtest: vecs0
[279.152990] Dynamic subtest vecs0: SUCCESS (0.023s)
[279.164989] Starting dynamic subtest: ccs0
[279.176350] Dynamic subtest ccs0: SUCCESS (0.023s)
[279.178558] Subtest forked-writes: SUCCESS (0.149s)
[279.424719] [035/132] (746s left) kms_rotation_crc (primary-rotation-180)
[279.516147] Starting subtest: primary-rotation-180
[286.533852] Subtest primary-rotation-180: SUCCESS (7.019s)
[287.690833] [036/132] (738s left) kms_psr (fbc-pr-primary-mmap-gtt)
[287.782510] Starting subtest: fbc-pr-primary-mmap-gtt
[287.786802] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[287.856151] [037/132] (738s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[287.943455] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[287.945741] Starting dynamic subtest: pipe-A
[287.964195] Dynamic subtest pipe-A: SKIP (0.016s)
[287.974052] Starting dynamic subtest: pipe-B
[287.993681] Dynamic subtest pipe-B: SKIP (0.030s)
[288.003015] Starting dynamic subtest: pipe-C
[288.022306] Dynamic subtest pipe-C: SKIP (0.028s)
[288.031511] Starting dynamic subtest: pipe-D
[288.050473] Dynamic subtest pipe-D: SKIP (0.028s)
[288.054021] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.105s)
[288.142945] [038/132] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[288.240685] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[288.244946] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[288.332319] [039/132] (737s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[288.424174] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[288.426300] Starting dynamic subtest: pipe-A-eDP-1
[288.481750] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[288.492448] Starting dynamic subtest: pipe-B-eDP-1
[288.547689] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[288.560772] Starting dynamic subtest: pipe-C-eDP-1
[288.617887] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[288.628411] Starting dynamic subtest: pipe-D-eDP-1
[288.674117] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[288.677576] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[290.684041] [040/132] (735s left) gem_exec_schedule (semaphore-user)
[290.752585] Starting subtest: semaphore-user
[290.802441] Subtest semaphore-user: SUCCESS (0.057s)
[292.198853] [041/132] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[292.302752] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[292.306945] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[292.385714] [042/132] (733s left) kms_lease (implicit-plane-lease)
[292.475423] Starting subtest: implicit-plane-lease
[292.477560] Subtest implicit-plane-lease: SUCCESS (0.003s)
[292.579743] [043/132] (733s left) kms_chamelium_color (ctm-red-to-blue)
[292.668289] Subtest ctm-red-to-blue: SKIP (0.000s)
[292.715030] [044/132] (733s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[292.821389] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[292.823553] Starting dynamic subtest: pipe-A-eDP-1
[292.907260] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[292.917603] Starting dynamic subtest: pipe-B-eDP-1
[294.065004] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s)
[294.069486] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.247s)
[295.272657] [045/132] (730s left) gem_pxp (protected-raw-src-copy-not-readible)
[295.393177] Starting subtest: protected-raw-src-copy-not-readible
[295.450317] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[295.576645] [046/132] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[295.680185] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[295.684168] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[295.784456] [047/132] (730s left) gem_softpin (evict-single-offset)
[295.849143] Starting subtest: evict-single-offset
[324.151286] Subtest evict-single-offset: SUCCESS (28.299s)
[324.237023] [048/132] (702s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[324.382392] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[324.387668] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[324.490504] [049/132] (701s left) syncobj_eventfd (invalid-bad-pad)
[324.560278] Starting subtest: invalid-bad-pad
[324.562125] Subtest invalid-bad-pad: SUCCESS (0.000s)
[324.640839] [050/132] (701s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[324.740725] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[324.744883] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[324.812657] [051/132] (701s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[324.908414] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[324.910690] Starting dynamic subtest: pipe-A-eDP-1
[324.934110] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[324.945972] Starting dynamic subtest: pipe-B-eDP-1
[324.966394] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[324.975872] Starting dynamic subtest: pipe-C-eDP-1
[324.996934] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[325.008686] Starting dynamic subtest: pipe-D-eDP-1
[325.029411] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[325.033409] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[327.126219] [052/132] (699s left) gem_exec_schedule (independent)
[327.201194] Starting subtest: independent
[327.203277] Starting dynamic subtest: rcs0
[329.139987] Dynamic subtest rcs0: SUCCESS (1.948s)
[329.154091] Starting dynamic subtest: vcs0
[331.195025] Dynamic subtest vcs0: SUCCESS (2.052s)
[331.208878] Starting dynamic subtest: vcs1
[333.180597] Dynamic subtest vcs1: SUCCESS (1.985s)
[333.195058] Starting dynamic subtest: vecs0
[335.166209] Dynamic subtest vecs0: SUCCESS (1.983s)
[335.180611] Starting dynamic subtest: ccs0
[337.141446] Dynamic subtest ccs0: SUCCESS (1.973s)
[337.144294] Subtest independent: SUCCESS (9.950s)
[337.447416] [053/132] (689s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[337.514439] Starting subtest: multi-wait-for-submit-submitted-signaled
[337.516826] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[337.629344] [054/132] (688s left) gem_eio (in-flight-contexts-10ms)
[337.880839] Starting subtest: in-flight-contexts-10ms
[351.184117] Subtest in-flight-contexts-10ms: SUCCESS (13.303s)
[351.314402] [055/132] (675s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[351.408375] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[351.410640] Starting dynamic subtest: pipe-A-default-mode
[354.153315] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s)
[354.155676] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.747s)
[355.027160] [056/132] (671s left) gem_render_copy_redux (normal)
[355.084930] Starting subtest: normal
[355.458882] Subtest normal: SUCCESS (0.374s)
[355.579738] [057/132] (671s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[355.631209] Starting subtest: wait-all-for-submit-delayed-submit
[355.734286] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[355.813097] [058/132] (670s left) gem_mmap_offset (clear)
[355.866108] Starting subtest: clear
[355.868491] Starting dynamic subtest: smem0
[380.611608] Dynamic subtest smem0: SUCCESS (24.742s)
[380.613981] Subtest clear: SUCCESS (24.744s)
[380.764477] [059/132] (646s left) prime_mmap (test_dup)
[380.863140] Starting subtest: test_dup
[380.865076] Starting dynamic subtest: test_dup-smem
[380.894129] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[380.896608] Subtest test_dup: SUCCESS (0.033s)
[380.974359] [060/132] (645s left) kms_psr (psr2-cursor-render)
[381.080973] Starting subtest: psr2-cursor-render
[381.083305] Starting dynamic subtest: eDP-1
[382.803853] Dynamic subtest eDP-1: SUCCESS (1.723s)
[382.806193] Subtest psr2-cursor-render: SUCCESS (1.724s)
[383.692084] [061/132] (643s left) i915_query (query-topology-coherent-slice-mask)
[383.758711] Starting subtest: query-topology-coherent-slice-mask
[383.763263] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[383.866557] [062/132] (643s left) fbdev (write)
[383.911159] Starting subtest: write
[384.275970] Subtest write: SUCCESS (0.363s)
[384.357057] [063/132] (642s left) i915_query (engine-info-invalid)
[384.406011] Starting subtest: engine-info-invalid
[384.408785] Subtest engine-info-invalid: SUCCESS (0.000s)
[384.508018] [064/132] (642s left) kms_pm_rpm (basic-pci-d3-state)
[386.271962] Starting subtest: basic-pci-d3-state
[387.776965] Subtest basic-pci-d3-state: SUCCESS (1.512s)
[387.877368] [065/132] (639s left) i915_pm_rpm (system-suspend)
[389.400677] Starting subtest: system-suspend
[407.385492] Subtest system-suspend: SUCCESS (3.300s)
[412.795223] [066/132] (619s left) gem_mmap_gtt (cpuset-big-copy)
[412.863270] Subtest cpuset-big-copy: SKIP (0.000s)
[412.927182] [067/132] (619s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[413.018862] Starting subtest: bo-too-small-due-to-tiling
[413.023275] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[413.136233] [068/132] (619s left) gem_partial_pwrite_pread (write-display)
[413.194726] Subtest write-display: SKIP (0.000s)
[413.256372] [069/132] (619s left) kms_vblank (wait-idle)
[413.350663] Starting subtest: wait-idle
[413.352475] Starting dynamic subtest: pipe-A-eDP-1
[415.113217] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.763s)
[415.129886] Starting dynamic subtest: pipe-D-eDP-1
[417.538525] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[417.540819] Subtest wait-idle: SUCCESS (4.186s)
[418.369215] [070/132] (613s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[418.437309] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[418.513939] [071/132] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[418.614643] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[422.256369] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.644s)
[423.482512] [072/132] (608s left) gem_exec_balancer (parallel)
[423.746526] Starting subtest: parallel
[424.689112] Subtest parallel: SUCCESS (0.942s)
[425.930794] [073/132] (606s left) gem_userptr_blits (access-control)
[426.007391] Starting subtest: access-control
[426.012660] Subtest access-control: SKIP (0.000s)
[426.138213] [074/132] (606s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[426.254364] Starting subtest: flip-vs-cursor-busy-crc-atomic
[427.075475] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.820s)
[427.891673] [075/132] (604s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[428.008956] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[428.012937] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[428.115383] [076/132] (604s left) perf_pmu (busy-check-all)
[428.161642] Starting subtest: busy-check-all
[428.163933] Starting dynamic subtest: rcs0
[428.709748] Dynamic subtest rcs0: SUCCESS (0.549s)
[428.728704] Starting dynamic subtest: bcs0
[429.258121] Dynamic subtest bcs0: SUCCESS (0.547s)
[429.271758] Starting dynamic subtest: vcs0
[430.868011] Dynamic subtest vcs0: SUCCESS (1.605s)
[430.882376] Starting dynamic subtest: vcs1
[432.851752] Dynamic subtest vcs1: SUCCESS (1.981s)
[432.865629] Starting dynamic subtest: vecs0
[434.836911] Dynamic subtest vecs0: SUCCESS (1.982s)
[434.850865] Starting dynamic subtest: ccs0
[435.403419] Dynamic subtest ccs0: SUCCESS (0.564s)
[435.406122] Subtest busy-check-all: SUCCESS (7.244s)
[435.555615] [077/132] (597s left) kms_cursor_crc (cursor-offscreen-128x42)
[435.795035] Starting subtest: cursor-offscreen-128x42
[435.842050] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[436.040814] [078/132] (596s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[436.133729] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[436.506938] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[439.323028] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.761s)
[439.337380] Starting dynamic subtest: pipe-A-eDP-1-4
[441.495755] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[441.512914] Starting dynamic subtest: pipe-A-eDP-1-4
[443.453906] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[443.470368] Starting dynamic subtest: pipe-A-eDP-1-x
[445.696336] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[446.035498] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[448.857147] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[448.870266] Starting dynamic subtest: pipe-B-eDP-1-4
[451.042463] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[451.056304] Starting dynamic subtest: pipe-B-eDP-1-4
[453.001280] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[453.012603] Starting dynamic subtest: pipe-B-eDP-1-x
[455.253551] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[455.573542] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[458.389485] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[458.403580] Starting dynamic subtest: pipe-C-eDP-1-4
[460.563174] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[460.576713] Starting dynamic subtest: pipe-C-eDP-1-4
[462.522174] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[462.535221] Starting dynamic subtest: pipe-C-eDP-1-x
[464.752015] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[465.064247] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[467.869869] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[467.880658] Starting dynamic subtest: pipe-D-eDP-1-4
[470.086028] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s)
[470.099508] Starting dynamic subtest: pipe-D-eDP-1-4
[472.043144] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[472.056842] Starting dynamic subtest: pipe-D-eDP-1-x
[474.222123] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[474.224450] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.087s)
[475.459801] [079/132] (557s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[475.580329] Starting subtest: cursorA-vs-flipA-atomic
[486.709367] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.125s)
[487.588914] [080/132] (545s left) sriov_basic (enable-vfs-autoprobe-off)
[487.638159] Starting subtest: enable-vfs-autoprobe-off
[487.640487] Starting dynamic subtest: numvfs-1
[487.722569] Dynamic subtest numvfs-1: FAIL (0.031s)
[487.736278] Starting dynamic subtest: numvfs-2
[487.808625] Dynamic subtest numvfs-2: FAIL (0.004s)
[487.821408] Starting dynamic subtest: numvfs-3
[487.893822] Dynamic subtest numvfs-3: FAIL (0.003s)
[487.905555] Starting dynamic subtest: numvfs-4
[487.977471] Dynamic subtest numvfs-4: FAIL (0.003s)
[487.989618] Starting dynamic subtest: numvfs-5
[488.061034] Dynamic subtest numvfs-5: FAIL (0.004s)
[488.072976] Starting dynamic subtest: numvfs-6
[488.145435] Dynamic subtest numvfs-6: FAIL (0.004s)
[488.156913] Starting dynamic subtest: numvfs-7
[488.230368] Dynamic subtest numvfs-7: FAIL (0.004s)
[488.242741] Starting dynamic subtest: numvfs-random
[488.313997] Dynamic subtest numvfs-random: FAIL (0.004s)
[488.326083] Starting dynamic subtest: numvfs-all
[488.400620] Dynamic subtest numvfs-all: FAIL (0.521s)
[488.402725] Subtest enable-vfs-autoprobe-off: FAIL (0.586s)
[488.448206] [081/132] (544s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[488.562145] Starting subtest: yf-tiled-32bpp-rotate-180
[488.565831] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[488.654758] [082/132] (544s left) gem_userptr_blits (input-checking)
[488.717947] Starting subtest: input-checking
[488.719641] Subtest input-checking: SUCCESS (0.000s)
[488.840840] [083/132] (544s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[488.890878] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[488.897696] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[489.079083] [084/132] (543s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[489.179807] Starting subtest: primary-y-tiled-reflect-x-90
[489.184044] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[489.257876] [085/132] (543s left) perf_pmu (rc6-all-gts)
[489.309801] Starting subtest: rc6-all-gts
[495.727687] Subtest rc6-all-gts: SUCCESS (6.364s)
[496.584946] [086/132] (536s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[496.699030] Starting subtest: x-tiled-16bpp-rotate-0
[497.978038] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.279s)
[498.123780] [087/132] (535s left) gem_ctx_param (set-priority-not-supported)
[498.168983] Starting subtest: set-priority-not-supported
[498.172730] Subtest set-priority-not-supported: SKIP (0.000s)
[498.229767] [088/132] (534s left) kms_cdclk (mode-transition)
[498.325989] Starting subtest: mode-transition
[498.327726] Starting dynamic subtest: pipe-A-eDP-1
[498.621508] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[498.633131] Starting dynamic subtest: pipe-B-eDP-1
[498.637749] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[498.648883] Starting dynamic subtest: pipe-C-eDP-1
[498.653490] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[498.663933] Starting dynamic subtest: pipe-D-eDP-1
[498.668314] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[498.672774] Subtest mode-transition: SKIP (0.300s)
[499.415299] [089/132] (533s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[499.509666] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[503.713555] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.207s)
[504.856566] [090/132] (528s left) kms_psr (psr2-basic)
[504.945134] Starting subtest: psr2-basic
[504.947522] Starting dynamic subtest: eDP-1
[506.602502] Dynamic subtest eDP-1: SUCCESS (1.656s)
[506.604364] Subtest psr2-basic: SUCCESS (1.657s)
[507.413980] [091/132] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[507.512460] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[507.516335] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[507.605576] [092/132] (525s left) gem_exec_fence (syncobj-repeat)
[508.049178] Starting subtest: syncobj-repeat
[508.240619] Subtest syncobj-repeat: SUCCESS (0.190s)
[509.921784] [093/132] (523s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[509.979996] Subtest no-spare-fences-busy: SKIP (0.000s)
[510.047320] [094/132] (523s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[510.154756] Starting subtest: modeset-transition-nonblocking-fencing
[510.157910] Starting dynamic subtest: 1x-outputs
[520.974307] Dynamic subtest 1x-outputs: SUCCESS (10.819s)
[520.976739] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.821s)
[521.836490] [095/132] (511s left) api_intel_bb (simple-bb)
[521.902903] Starting subtest: simple-bb
[521.908218] Subtest simple-bb: SUCCESS (0.006s)
[522.034176] [096/132] (511s left) gem_userptr_blits (unsync-unmap)
[522.095360] Subtest unsync-unmap: SKIP (0.000s)
[522.206734] [097/132] (511s left) api_intel_bb (crc32)
[522.264913] Starting subtest: crc32
[522.267292] Starting dynamic subtest: rcs0-smem0
[522.584211] Dynamic subtest rcs0-smem0: SUCCESS (0.321s)
[522.598387] Starting dynamic subtest: bcs0-smem0
[522.923442] Dynamic subtest bcs0-smem0: SUCCESS (0.337s)
[522.937770] Starting dynamic subtest: vcs0-smem0
[523.349099] Dynamic subtest vcs0-smem0: SUCCESS (0.423s)
[523.363301] Starting dynamic subtest: vcs1-smem0
[523.755552] Dynamic subtest vcs1-smem0: SUCCESS (0.403s)
[523.767065] Starting dynamic subtest: vecs0-smem0
[524.145002] Dynamic subtest vecs0-smem0: SUCCESS (0.387s)
[524.158983] Starting dynamic subtest: ccs0-smem0
[524.518833] Dynamic subtest ccs0-smem0: SUCCESS (0.371s)
[524.521916] Subtest crc32: SUCCESS (2.258s)
[524.637972] [098/132] (508s left) gem_userptr_blits (nohangcheck)
[524.734831] Starting subtest: nohangcheck
[525.073216] Subtest nohangcheck: SUCCESS (0.336s)
[525.186329] [099/132] (508s left) kms_flip (dpms-off-confusion)
[525.282626] Starting subtest: dpms-off-confusion
[525.284546] Starting dynamic subtest: A-eDP1
[533.960405] Dynamic subtest A-eDP1: SUCCESS (8.644s)
[533.973234] Starting dynamic subtest: B-eDP1
[542.592164] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[542.605538] Starting dynamic subtest: C-eDP1
[551.232487] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[551.246147] Starting dynamic subtest: D-eDP1
[559.868250] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[559.870596] Subtest dpms-off-confusion: SUCCESS (34.542s)
[560.995814] [100/132] (472s left) gen9_exec_parse (bb-start-out)
[561.057288] Subtest bb-start-out: SKIP (0.000s)
[561.128132] [101/132] (472s left) kms_plane (pixel-format-4-tiled-modifier)
[561.213161] Starting subtest: pixel-format-4-tiled-modifier
[561.237832] Starting dynamic subtest: pipe-A-plane-0
[561.871083] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[561.882438] Starting dynamic subtest: pipe-A-plane-3
[562.271286] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[562.281909] Starting dynamic subtest: pipe-A-plane-5
[562.285487] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[563.388274] Starting dynamic subtest: pipe-B-plane-0
[564.040969] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[564.055386] Starting dynamic subtest: pipe-B-plane-3
[564.486113] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[564.498486] Starting dynamic subtest: pipe-B-plane-5
[564.502173] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[564.794437] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.581s)
[565.646512] [102/132] (468s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[565.742153] Starting subtest: fbc-psr-sprite-mmap-gtt
[565.744510] Starting dynamic subtest: eDP-1
[565.748785] Dynamic subtest eDP-1: SKIP (0.000s)
[565.752911] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[565.819758] [103/132] (468s left) kms_content_protection (lic-type-0-hdcp14)
[565.951689] Starting subtest: lic-type-0-hdcp14
[565.956301] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[566.079937] [104/132] (467s left) kms_plane_multiple (tiling-y)
[566.169091] Starting subtest: tiling-y
[566.173335] Subtest tiling-y: SKIP (0.000s)
[566.246229] [105/132] (467s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[566.351136] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[566.353399] Starting dynamic subtest: pipe-A-default-mode
[569.101977] Dynamic subtest pipe-A-default-mode: SUCCESS (2.751s)
[569.104186] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.752s)
[569.949152] [106/132] (464s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[570.047712] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[570.660763] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.614s)
[570.827173] [107/132] (463s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[570.940574] Starting subtest: flip-vs-cursor-toggle
[579.939925] Subtest flip-vs-cursor-toggle: SUCCESS (8.997s)
[580.766146] [108/132] (453s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[580.872488] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[580.896899] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.024s)
[580.983922] [109/132] (453s left) syncobj_wait (reset-during-wait-for-submit)
[581.044330] Starting subtest: reset-during-wait-for-submit
[581.148709] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[581.239491] [110/132] (452s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[581.346099] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[590.753043] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.405s)
[591.592369] [111/132] (442s left) sysfs_timeslice_duration (duration)
[591.650032] Starting subtest: duration
[591.652429] Starting dynamic subtest: vecs0
[605.745614] Dynamic subtest vecs0: SUCCESS (14.091s)
[605.764053] Starting dynamic subtest: ccs0
[618.902060] Dynamic subtest ccs0: SUCCESS (13.153s)
[618.916482] Starting dynamic subtest: vcs0
[633.777368] Dynamic subtest vcs0: SUCCESS (14.869s)
[633.801971] Starting dynamic subtest: bcs0
[646.931750] Dynamic subtest bcs0: SUCCESS (13.143s)
[646.943088] Starting dynamic subtest: rcs0
[660.060158] Dynamic subtest rcs0: SUCCESS (13.136s)
[660.079745] Starting dynamic subtest: vcs1
[673.777536] Dynamic subtest vcs1: SUCCESS (13.714s)
[673.781112] Subtest duration: SUCCESS (82.123s)
[673.860576] [112/132] (360s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[673.961338] Starting subtest: psr-rgb101010-draw-mmap-wc
[681.251943] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.294s)
[681.364731] [113/132] (352s left) syncobj_wait (invalid-reset-bad-pad)
[681.415901] Starting subtest: invalid-reset-bad-pad
[681.418146] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[681.545370] [114/132] (352s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[681.659643] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[681.663534] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[681.754375] [115/132] (352s left) kms_properties (invalid-properties-atomic)
[681.853653] Starting subtest: invalid-properties-atomic
[682.167436] Subtest invalid-properties-atomic: SUCCESS (0.314s)
[682.247099] [116/132] (352s left) gem_exercise_blt (fast-copy-emit)
[682.317315] Starting subtest: fast-copy-emit
[682.319417] Starting dynamic subtest: linear-smem-smem-emit
[682.337987] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[682.350284] Starting dynamic subtest: xmajor-smem-smem-emit
[682.355183] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[682.365853] Starting dynamic subtest: tile4-smem-smem-emit
[682.372522] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[682.383259] Starting dynamic subtest: tile64-smem-smem-emit
[682.389032] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[682.391237] Subtest fast-copy-emit: SUCCESS (0.074s)
[682.507194] [117/132] (351s left) kms_color (ctm-negative)
[682.600864] Starting subtest: ctm-negative
[682.603100] Starting dynamic subtest: pipe-A-eDP-1
[683.310101] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[683.321566] Starting dynamic subtest: pipe-B-eDP-1
[684.732689] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[684.747010] Starting dynamic subtest: pipe-C-eDP-1
[686.096258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[686.107750] Starting dynamic subtest: pipe-D-eDP-1
[687.437719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[687.440064] Subtest ctm-negative: SUCCESS (4.839s)
[688.238844] [118/132] (346s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[688.348408] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[695.187524] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.841s)
[695.321617] [119/132] (339s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[695.446545] Starting subtest: 2x-long-flip-vs-cursor-legacy
[695.450889] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[695.596500] [120/132] (338s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[695.698516] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[702.719826] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.025s)
[702.835287] [121/132] (331s left) kms_psr (psr-primary-mmap-gtt)
[702.937581] Starting subtest: psr-primary-mmap-gtt
[702.939720] Starting dynamic subtest: eDP-1
[704.396713] Dynamic subtest eDP-1: SKIP (1.455s)
[704.401588] Subtest psr-primary-mmap-gtt: SKIP (1.457s)
[704.570835] [122/132] (330s left) gem_eio (banned)
[704.764253] Starting subtest: banned
[705.292065] Subtest banned: SUCCESS (0.527s)
[705.460318] [123/132] (329s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[705.517354] Starting subtest: invalid-multi-wait-all-unsubmitted
[705.519350] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[705.638111] [124/132] (329s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[705.722668] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[705.726325] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[706.863977] [125/132] (327s left) gem_exec_flush (basic-wb-rw-before-default)
[706.927099] Starting subtest: basic-wb-rw-before-default
[712.402897] Subtest basic-wb-rw-before-default: SUCCESS (5.460s)
[712.583689] [126/132] (322s left) gem_mmap_wc (read)
[712.647393] Subtest read: SKIP (0.000s)
[712.709009] [127/132] (322s left) gem_exec_schedule (implicit-boths)
[712.774003] Starting subtest: implicit-boths
[712.775883] Starting dynamic subtest: rcs0
[712.955947] Dynamic subtest rcs0: SUCCESS (0.188s)
[712.969724] Starting dynamic subtest: vcs0
[713.066184] Dynamic subtest vcs0: SUCCESS (0.110s)
[713.079345] Starting dynamic subtest: vcs1
[713.184215] Dynamic subtest vcs1: SUCCESS (0.117s)
[713.198646] Starting dynamic subtest: vecs0
[713.292747] Dynamic subtest vecs0: SUCCESS (0.107s)
[713.305239] Starting dynamic subtest: ccs0
[713.424294] Dynamic subtest ccs0: SUCCESS (0.131s)
[713.426755] Subtest implicit-boths: SUCCESS (0.659s)
[713.968834] [128/132] (320s left) i915_pm_freq_api (freq-suspend)
[714.038014] Starting subtest: freq-suspend
[714.039981] Starting dynamic subtest: gt0
[730.589818] Dynamic subtest gt0: SUCCESS (1.607s)
[730.603212] Starting dynamic subtest: gt1
[747.589671] Dynamic subtest gt1: SUCCESS (1.594s)
[747.594120] Subtest freq-suspend: SUCCESS (3.204s)
[754.676555] [129/132] (287s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[754.734023] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[754.736212] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[754.815630] [130/132] (287s left) kms_pm_rpm (pm-tiling)
[756.337621] Starting subtest: pm-tiling
[756.343037] Subtest pm-tiling: SKIP (0.000s)
[757.113488] [131/132] (284s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[757.206546] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[757.210915] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[757.303551] [132/132] (284s left) dmabuf_sync_file (export-basic)
[757.352738] Starting subtest: export-basic
[757.354910] Subtest export-basic: SUCCESS (0.001s)
[757.410246] Closing watchdogs
results: parsing output: 0/ for test: kms_invalid_mode
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: gem_flink_race
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_pipe_crc_basic
results: parsing output: 10/ for test: gem_ctx_freq
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: gem_pwrite
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: kms_psr2_su
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_getfb
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_store
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_exec
results: parsing output: 27/ for test: kms_draw_crc
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_dirtyfb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: gem_exec_async
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: kms_chamelium_color
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: gem_pxp
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_render_copy_redux
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: prime_mmap
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: i915_query
results: parsing output: 61/ for test: fbdev
results: parsing output: 62/ for test: i915_query
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: i915_pm_rpm
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: gem_partial_pwrite_pread
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_async_flips
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: sriov_basic
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: kms_cdclk
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: gem_fenced_exec_thrash
results: parsing output: 93/ for test: kms_atomic_transition
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gen9_exec_parse
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_plane_multiple
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: sysfs_timeslice_duration
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: gem_exercise_blt
results: parsing output: 116/ for test: kms_color
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: i915_pm_freq_api
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_pm_rpm
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: dmabuf_sync_file
Done.