[64.878794] Initializing watchdogs
[64.878840]   /dev/watchdog0
[64.893485] [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]
[64.898166] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.900349] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.903878] [001/133] (960s left) kms_cursor_edge_walk (256x256-right-edge)
[65.027538] Starting subtest: 256x256-right-edge
[65.029690] Starting dynamic subtest: pipe-A-eDP-1
[68.521761] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[68.532103] Starting dynamic subtest: pipe-D-eDP-1
[71.653112] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[71.655416] Subtest 256x256-right-edge: SUCCESS (6.615s)
[72.454076] [002/133] (952s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[72.545043] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[72.571613] Starting dynamic subtest: pipe-A-plane-0
[73.005494] Dynamic subtest pipe-A-plane-0: SUCCESS (0.434s)
[73.014093] Starting dynamic subtest: pipe-A-plane-3
[73.272223] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[74.339965] Starting dynamic subtest: pipe-B-plane-0
[74.799934] Dynamic subtest pipe-B-plane-0: SUCCESS (0.467s)
[74.809755] Starting dynamic subtest: pipe-B-plane-3
[75.055411] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[75.364292] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.817s)
[76.216353] [003/133] (949s left) i915_query (query-regions-unallocated)
[76.265448] Starting subtest: query-regions-unallocated
[76.267918] Subtest query-regions-unallocated: SUCCESS (0.000s)
[76.382194] [004/133] (949s left) syncobj_timeline (invalid-signal-bad-pad)
[76.438661] Starting subtest: invalid-signal-bad-pad
[76.440979] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[76.540400] [005/133] (949s left) kms_cursor_crc (cursor-offscreen-64x64)
[76.705123] Starting subtest: cursor-offscreen-64x64
[76.710890] Starting dynamic subtest: pipe-A-eDP-1
[78.659781] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.950s)
[78.690114] Starting dynamic subtest: pipe-D-eDP-1
[81.244490] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[81.246899] Subtest cursor-offscreen-64x64: SUCCESS (4.535s)
[82.091164] [006/133] (943s left) gem_close_race (multigpu-basic-process)
[82.160984] Starting subtest: multigpu-basic-process
[82.165991] Subtest multigpu-basic-process: SKIP (0.000s)
[82.413933] [007/133] (943s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[82.467908] Starting subtest: etime-multi-wait-all-available-unsubmitted
[82.569232] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[82.658038] [008/133] (943s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[82.751750] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[82.764819] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[82.860872] [009/133] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[82.970657] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[82.974902] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[83.053619] [010/133] (942s left) kms_pm_dc (dc5-psr)
[84.148765] Starting subtest: dc5-psr
[87.029898] Subtest dc5-psr: SUCCESS (2.879s)
[87.845940] [011/133] (937s left) kms_lease (lease-revoke)
[87.953746] Starting subtest: lease-revoke
[87.955953] Starting dynamic subtest: pipe-A-eDP-1
[87.988547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[87.997106] Starting dynamic subtest: pipe-B-eDP-1
[88.019072] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.032s)
[88.026602] Starting dynamic subtest: pipe-C-eDP-1
[88.049443] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[88.057110] Starting dynamic subtest: pipe-D-eDP-1
[88.075461] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[88.077715] Subtest lease-revoke: SUCCESS (0.123s)
[88.197098] [012/133] (937s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[88.335632] Starting subtest: verify-pxp-stale-buf-optout-execution
[89.394964] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.061s)
[89.508977] [013/133] (936s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[89.594563] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[89.598872] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[89.665210] [014/133] (936s left) prime_mmap_coherency (write)
[89.728328] Starting subtest: write
[95.171764] Subtest write: SUCCESS (5.379s)
[95.252788] [015/133] (930s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[95.354662] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[95.359137] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[95.451631] [016/133] (930s left) gem_exec_reloc (basic-write-cpu-active)
[95.521079] Subtest basic-write-cpu-active: SKIP (0.000s)
[95.593882] [017/133] (930s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[95.694118] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[95.696451] Starting dynamic subtest: pipe-A-eDP-1
[95.954083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.231s)
[95.961863] Starting dynamic subtest: pipe-B-eDP-1
[97.253206] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.299s)
[97.264660] Starting dynamic subtest: pipe-C-eDP-1
[98.515333] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.258s)
[98.524644] Starting dynamic subtest: pipe-D-eDP-1
[99.750652] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[99.753051] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.025s)
[100.883396] [018/133] (925s left) kms_psr2_su (page_flip-p010)
[100.953797] Subtest page_flip-P010: SKIP (0.000s)
[101.016679] [019/133] (925s left) syncobj_timeline (single-wait-for-submit-signaled)
[101.073326] Starting subtest: single-wait-for-submit-signaled
[101.075583] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[101.169413] [020/133] (924s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[101.753726] Starting subtest: syncobj-timeline-invalid-wait
[101.756712] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[103.021834] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[103.025581] [021/133] (923s left) gem_exec_whisper (basic-sync)
[103.079035] Starting subtest: basic-sync
[112.077324] Subtest basic-sync: SUCCESS (8.974s)
[112.236946] [022/133] (913s left) gem_exec_reloc (basic-wc-active)
[112.307588] Subtest basic-wc-active: SKIP (0.000s)
[112.385222] [023/133] (913s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[112.495368] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[112.499580] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[112.600206] [024/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[112.687438] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[112.690064] Starting dynamic subtest: pipe-A-eDP-1
[112.714394] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[112.724917] Starting dynamic subtest: pipe-B-eDP-1
[112.746780] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[112.754809] Starting dynamic subtest: pipe-C-eDP-1
[112.776470] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[112.784511] Starting dynamic subtest: pipe-D-eDP-1
[112.806818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[112.811021] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[114.960339] [025/133] (911s left) kms_vblank (ts-continuation-modeset-rpm)
[115.053011] Starting subtest: ts-continuation-modeset-rpm
[115.054995] Starting dynamic subtest: pipe-A-eDP-1
[117.558662] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[117.574772] Starting dynamic subtest: pipe-D-eDP-1
[119.813890] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.251s)
[119.815834] Subtest ts-continuation-modeset-rpm: SUCCESS (4.760s)
[120.606519] [026/133] (905s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[120.703106] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[126.098044] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.399s)
[127.231262] [027/133] (899s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[127.339164] Starting subtest: plane-lut1d-ctm3x4
[127.462254] Starting dynamic subtest: pipe-A-plane-0
[127.800854] Dynamic subtest pipe-A-plane-0: FAIL (0.165s)
[127.811574] Starting dynamic subtest: pipe-A-plane-1
[128.031638] Dynamic subtest pipe-A-plane-1: FAIL (0.176s)
[128.041289] Starting dynamic subtest: pipe-A-plane-2
[128.266489] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[129.230638] Starting dynamic subtest: pipe-B-plane-0
[129.666461] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[129.674850] Starting dynamic subtest: pipe-B-plane-1
[129.984821] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[129.994974] Starting dynamic subtest: pipe-B-plane-2
[130.292252] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[130.972644] Starting dynamic subtest: pipe-C-plane-0
[131.474514] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[131.484706] Starting dynamic subtest: pipe-C-plane-1
[131.869445] Dynamic subtest pipe-C-plane-1: FAIL (0.599s)
[131.877575] Starting dynamic subtest: pipe-C-plane-2
[132.244713] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[133.070998] Starting dynamic subtest: pipe-D-plane-0
[133.664311] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[133.674305] Starting dynamic subtest: pipe-D-plane-1
[134.114848] Dynamic subtest pipe-D-plane-1: FAIL (0.603s)
[134.123550] Starting dynamic subtest: pipe-D-plane-2
[134.541827] Dynamic subtest pipe-D-plane-2: FAIL (0.517s)
[134.625301] Subtest plane-lut1d-ctm3x4: FAIL (7.288s)
[135.447062] [028/133] (891s left) kms_flip (2x-flip-vs-panning-interruptible)
[135.545568] Starting subtest: 2x-flip-vs-panning-interruptible
[135.558181] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[135.646991] [029/133] (890s left) kms_async_flips (invalid-async-flip-atomic)
[135.749088] Starting subtest: invalid-async-flip-atomic
[136.122118] Starting dynamic subtest: pipe-A-eDP-1
[136.980177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.858s)
[137.339503] Starting dynamic subtest: pipe-B-eDP-1
[138.206032] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.873s)
[138.570750] Starting dynamic subtest: pipe-C-eDP-1
[139.419911] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.856s)
[139.778831] Starting dynamic subtest: pipe-D-eDP-1
[140.557075] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.784s)
[140.559257] Subtest invalid-async-flip-atomic: SUCCESS (4.809s)
[141.709704] [030/133] (884s left) perf (gen12-invalid-class-instance)
[141.826389] Starting subtest: gen12-invalid-class-instance
[141.838162] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[141.891618] [031/133] (884s left) vgem_basic (mmap)
[141.948501] Starting subtest: mmap
[141.955851] Subtest mmap: SUCCESS (0.009s)
[142.017558] [032/133] (884s left) kms_fbcon_fbt (psr)
[142.090607] Starting subtest: psr
[149.428269] Subtest psr: SUCCESS (7.334s)
[149.510033] [033/133] (877s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[149.610029] Starting subtest: multiplane-rotation-cropping-top
[167.026842] Subtest multiplane-rotation-cropping-top: SUCCESS (17.419s)
[167.142710] [034/133] (859s left) gem_ctx_freq (sysfs)
[167.209218] Starting subtest: sysfs
[167.211267] Starting dynamic subtest: gt0
[172.723944] Dynamic subtest gt0: SUCCESS (5.515s)
[172.735181] Starting dynamic subtest: gt1
[213.909030] Dynamic subtest gt1: SUCCESS (41.180s)
[213.911798] Subtest sysfs: SUCCESS (46.698s)
[214.056220] [035/133] (812s left) vgem_basic (setversion)
[214.111703] Starting subtest: setversion
[214.116233] Subtest setversion: SUCCESS (0.000s)
[214.169167] [036/133] (812s left) gem_eio (hibernate)
[214.384865] Starting subtest: hibernate
[229.012927] Subtest hibernate: SUCCESS (14.627s)
[241.234243] [037/133] (797s left) i915_pm_rc6_residency (rc6-idle)
[241.317038] Starting subtest: rc6-idle
[241.342723] Starting dynamic subtest: gt0-rcs0
[265.612896] Dynamic subtest gt0-rcs0: SUCCESS (24.271s)
[265.622491] Starting dynamic subtest: gt0-bcs0
[289.898747] Dynamic subtest gt0-bcs0: SUCCESS (24.283s)
[289.909080] Starting dynamic subtest: gt0-ccs0
[314.111603] Dynamic subtest gt0-ccs0: SUCCESS (24.209s)
[314.123232] Starting dynamic subtest: gt1-vcs0
[320.285336] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[320.297998] Starting dynamic subtest: gt1-vecs0
[326.511197] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[326.513498] Subtest rc6-idle: SUCCESS (85.142s)
[326.554503] [038/133] (712s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[326.653978] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[326.658318] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[326.748844] [039/133] (712s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[326.849107] Starting subtest: plane-upscale-20x20-with-pixel-format
[326.851383] Starting dynamic subtest: pipe-A
[327.896665] Dynamic subtest pipe-A: SUCCESS (1.050s)
[327.909112] Starting dynamic subtest: pipe-B
[330.049542] Dynamic subtest pipe-B: SUCCESS (2.152s)
[330.058936] Starting dynamic subtest: pipe-C
[331.242550] Dynamic subtest pipe-C: SUCCESS (1.191s)
[331.252999] Starting dynamic subtest: pipe-D
[332.393385] Dynamic subtest pipe-D: SUCCESS (1.149s)
[332.395683] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.546s)
[333.590415] [040/133] (705s left) gem_exec_reloc (basic-cpu-active)
[333.675073] Subtest basic-cpu-active: SKIP (0.000s)
[333.759452] [041/133] (705s left) kms_chamelium_hpd (hdmi-hpd)
[334.146381] Subtest hdmi-hpd: SKIP (0.000s)
[334.992253] [042/133] (704s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[335.096431] Starting subtest: bad-rotation-90-y-tiled-ccs
[335.098332] Starting dynamic subtest: pipe-A-eDP-1
[335.120169] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[335.131893] Starting dynamic subtest: pipe-B-eDP-1
[335.152261] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[335.161692] Starting dynamic subtest: pipe-C-eDP-1
[335.182450] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[335.192072] Starting dynamic subtest: pipe-D-eDP-1
[335.213157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[335.217062] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.006s)
[337.277588] [043/133] (701s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[337.373858] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[337.376103] Starting dynamic subtest: pipe-A-default-mode
[340.088208] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[340.090563] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.714s)
[340.963208] [044/133] (698s left) i915_drm_fdinfo (idle)
[341.010827] Starting subtest: idle
[341.012780] Starting dynamic subtest: rcs0
[341.560369] Dynamic subtest rcs0: SUCCESS (0.550s)
[341.575265] Starting dynamic subtest: bcs0
[342.090298] Dynamic subtest bcs0: SUCCESS (0.527s)
[342.102315] Starting dynamic subtest: vcs0
[342.596113] Dynamic subtest vcs0: SUCCESS (0.503s)
[342.607912] Starting dynamic subtest: vcs1
[343.102090] Dynamic subtest vcs1: SUCCESS (0.503s)
[343.114038] Starting dynamic subtest: vecs0
[343.608461] Dynamic subtest vecs0: SUCCESS (0.503s)
[343.622926] Starting dynamic subtest: ccs0
[344.114283] Dynamic subtest ccs0: SUCCESS (0.503s)
[344.117070] Subtest idle: SUCCESS (3.105s)
[344.196568] [045/133] (695s left) gem_exec_balancer (parallel-ordering)
[344.480789] Starting subtest: parallel-ordering
[345.494897] Subtest parallel-ordering: SUCCESS (1.013s)
[345.617886] [046/133] (693s left) api_intel_allocator (execbuf-with-allocator)
[345.667751] Starting subtest: execbuf-with-allocator
[345.675382] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[345.794156] [047/133] (693s left) gem_userptr_blits (dmabuf-unsync)
[345.864923] Subtest dmabuf-unsync: SKIP (0.000s)
[345.972963] [048/133] (693s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[346.069701] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[346.081640] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[346.157716] [049/133] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[346.257669] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[353.538558] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.282s)
[353.682813] [050/133] (685s left) syncobj_wait (wait-all-interrupted)
[353.738976] Starting subtest: wait-all-interrupted
[353.841514] Subtest wait-all-interrupted: SUCCESS (0.102s)
[353.923480] [051/133] (685s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[354.036738] Starting subtest: cursorB-vs-flipB-varying-size
[354.041385] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[354.182977] [052/133] (685s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[354.239699] Starting subtest: y-tiled-to-vebox-yf-tiled
[354.243818] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[354.428062] [053/133] (685s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[354.520854] Starting subtest: 4-tiled-8bpp-rotate-180
[355.757593] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.237s)
[355.874322] [054/133] (683s left) kms_setmode (invalid-clone-exclusive-crtc)
[355.937567] Starting subtest: invalid-clone-exclusive-crtc
[355.943144] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[356.028797] [055/133] (683s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[356.134289] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[356.803584] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[356.968547] [056/133] (682s left) core_setmaster (master-drop-set-shared-fd)
[357.050946] Starting subtest: master-drop-set-shared-fd
[357.070322] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[357.110468] [057/133] (682s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[357.164939] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[357.167182] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[357.265128] [058/133] (682s left) perf_pmu (init-busy)
[357.308845] Starting subtest: init-busy
[357.311282] Starting dynamic subtest: rcs0
[357.313528] Dynamic subtest rcs0: SUCCESS (0.001s)
[357.324643] Starting dynamic subtest: bcs0
[357.326821] Dynamic subtest bcs0: SUCCESS (0.000s)
[357.339719] Starting dynamic subtest: vcs0
[357.342081] Dynamic subtest vcs0: SUCCESS (0.001s)
[357.351416] Starting dynamic subtest: vcs1
[357.353627] Dynamic subtest vcs1: SUCCESS (0.001s)
[357.362693] Starting dynamic subtest: vecs0
[357.364570] Dynamic subtest vecs0: SUCCESS (0.001s)
[357.373752] Starting dynamic subtest: ccs0
[357.375930] Dynamic subtest ccs0: SUCCESS (0.000s)
[357.378125] Subtest init-busy: SUCCESS (0.008s)
[357.419753] [059/133] (682s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[357.522679] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[357.527207] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[357.625569] [060/133] (682s left) gem_ctx_param (set-priority-range)
[357.683938] Starting subtest: set-priority-range
[357.700169] Subtest set-priority-range: SUCCESS (0.016s)
[357.803092] [061/133] (682s left) kms_dsc (dsc-basic)
[357.889091] Starting subtest: dsc-basic
[357.900093] Subtest dsc-basic: SKIP (0.000s)
[357.966133] [062/133] (682s left) kms_psr (fbc-psr-basic)
[358.055374] Starting subtest: fbc-psr-basic
[358.057312] Starting dynamic subtest: eDP-1
[358.060856] Dynamic subtest eDP-1: SKIP (0.000s)
[358.064537] Subtest fbc-psr-basic: SKIP (0.001s)
[358.145870] [063/133] (681s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[358.205308] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[358.279631] [064/133] (681s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[358.374033] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[358.746578] Starting dynamic subtest: pipe-A-eDP-1
[361.584299] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.781s)
[361.893502] Starting dynamic subtest: pipe-B-eDP-1
[364.715853] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.778s)
[365.026620] Starting dynamic subtest: pipe-C-eDP-1
[367.848653] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.778s)
[368.165310] Starting dynamic subtest: pipe-D-eDP-1
[370.972108] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[370.974473] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.545s)
[372.103620] [065/133] (668s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[372.213472] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[372.217497] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[372.342475] [066/133] (667s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[372.432485] Starting subtest: plane-downscale-factor-0-5-with-rotation
[372.434605] Starting dynamic subtest: pipe-A
[372.453362] Dynamic subtest pipe-A: SKIP (0.016s)
[372.462776] Starting dynamic subtest: pipe-B
[372.482669] Dynamic subtest pipe-B: SKIP (0.030s)
[372.492135] Starting dynamic subtest: pipe-C
[372.514517] Dynamic subtest pipe-C: SKIP (0.030s)
[372.524059] Starting dynamic subtest: pipe-D
[372.543670] Dynamic subtest pipe-D: SKIP (0.030s)
[372.547759] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.109s)
[372.654347] [067/133] (667s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[372.753503] Starting subtest: fbcpsr-rgb565-draw-blt
[379.810975] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.060s)
[379.938621] [068/133] (660s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[380.032058] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[386.923212] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.893s)
[387.066835] [069/133] (653s left) kms_selftest (drm_dp_mst_helper)
[387.106180] Starting subtest: drm_dp_mst_helper
[387.142992] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[387.229474] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.086s)
[387.240692] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[387.332658] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.099s)
[387.353219] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[387.425668] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.095s)
[387.427942] Subtest drm_dp_mst_helper: SUCCESS (0.321s)
[387.564061] [070/133] (652s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[387.657798] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[387.659711] Starting dynamic subtest: A-eDP1
[396.521144] Dynamic subtest A-eDP1: SUCCESS (8.862s)
[396.534098] Starting dynamic subtest: B-eDP1
[405.456496] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[405.471237] Starting dynamic subtest: C-eDP1
[414.423236] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[414.436161] Starting dynamic subtest: D-eDP1
[423.360871] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[423.363634] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.655s)
[424.536493] [071/133] (615s left) kms_cursor_crc (cursor-random-64x64)
[424.752840] Starting subtest: cursor-random-64x64
[424.757770] Starting dynamic subtest: pipe-A-eDP-1
[428.187586] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[428.218970] Starting dynamic subtest: pipe-D-eDP-1
[432.210176] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[432.212437] Subtest cursor-random-64x64: SUCCESS (7.455s)
[433.094321] [072/133] (607s left) core_getclient (basic)
[433.147678] Starting subtest: basic
[433.149577] Subtest basic: SUCCESS (0.000s)
[433.258979] [073/133] (607s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[433.358710] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[440.341878] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.985s)
[440.492300] [074/133] (600s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[440.545107] Starting subtest: invalid-single-wait-all-unsubmitted
[440.547287] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[440.643319] [075/133] (599s left) kms_joiner (basic-ultra-joiner)
[440.732141] Starting subtest: basic-ultra-joiner
[440.736306] Subtest basic-ultra-joiner: SKIP (0.000s)
[440.806977] [076/133] (599s left) kms_prime (d3hot)
[440.896825] Subtest D3hot: SKIP (0.000s)
[440.993811] [077/133] (599s left) gem_close (basic)
[441.050373] Starting subtest: basic
[441.052710] Subtest basic: SUCCESS (0.000s)
[441.151222] [078/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[441.246343] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[448.100929] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.857s)
[448.240585] [079/133] (592s left) kms_flip (flip-vs-rmfb)
[448.335029] Starting subtest: flip-vs-rmfb
[448.337196] Starting dynamic subtest: A-eDP1
[456.964684] Dynamic subtest A-eDP1: SUCCESS (8.631s)
[456.974686] Starting dynamic subtest: B-eDP1
[465.606454] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[465.619283] Starting dynamic subtest: C-eDP1
[474.240878] Dynamic subtest C-eDP1: SUCCESS (8.631s)
[474.250453] Starting dynamic subtest: D-eDP1
[482.870458] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[482.875753] Subtest flip-vs-rmfb: SUCCESS (34.542s)
[484.063416] [080/133] (556s left) gem_exec_balancer (bonded-false-hang)
[484.318539] Starting subtest: bonded-false-hang
[484.324130] Subtest bonded-false-hang: SKIP (0.000s)
[484.419967] [081/133] (556s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[484.513156] Starting subtest: coverage-vs-premult-vs-constant
[484.798545] Starting dynamic subtest: pipe-A-eDP-1
[485.422479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[485.435217] Starting dynamic subtest: pipe-D-eDP-1
[486.787555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.363s)
[486.789640] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.275s)
[487.650944] [082/133] (553s left) sysfs_heartbeat_interval (idempotent)
[487.719689] Starting subtest: idempotent
[487.722108] Starting dynamic subtest: vecs0
[487.724491] Dynamic subtest vecs0: SUCCESS (0.001s)
[487.735484] Starting dynamic subtest: ccs0
[487.737387] Dynamic subtest ccs0: SUCCESS (0.001s)
[487.746917] Starting dynamic subtest: vcs0
[487.748919] Dynamic subtest vcs0: SUCCESS (0.000s)
[487.758250] Starting dynamic subtest: bcs0
[487.760170] Dynamic subtest bcs0: SUCCESS (0.001s)
[487.769266] Starting dynamic subtest: rcs0
[487.771181] Dynamic subtest rcs0: SUCCESS (0.000s)
[487.780841] Starting dynamic subtest: vcs1
[487.783121] Dynamic subtest vcs1: SUCCESS (0.000s)
[487.785365] Subtest idempotent: SUCCESS (0.008s)
[487.842731] [083/133] (553s left) kms_properties (colorop-properties-atomic)
[487.934620] Starting subtest: colorop-properties-atomic
[487.936869] Starting dynamic subtest: pipe-A-eDP-1
[488.272726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.339s)
[488.282992] Starting dynamic subtest: pipe-B-eDP-1
[489.316793] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.041s)
[489.327740] Starting dynamic subtest: pipe-C-eDP-1
[490.357569] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.038s)
[490.370773] Starting dynamic subtest: pipe-D-eDP-1
[491.386826] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.030s)
[491.389266] Subtest colorop-properties-atomic: SUCCESS (3.454s)
[492.202183] [084/133] (548s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[492.301979] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[492.304339] Starting dynamic subtest: pipe-A-eDP-1
[492.327139] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.339095] Starting dynamic subtest: pipe-B-eDP-1
[492.360384] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.369912] Starting dynamic subtest: pipe-C-eDP-1
[492.391974] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.401145] Starting dynamic subtest: pipe-D-eDP-1
[492.422846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.427231] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[494.474767] [085/133] (546s left) kms_atomic_transition (plane-all-transition-fencing)
[494.581315] Starting subtest: plane-all-transition-fencing
[494.583655] Starting dynamic subtest: pipe-A-eDP-1
[497.099342] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.516s)
[497.405946] Starting dynamic subtest: pipe-B-eDP-1
[500.603972] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s)
[500.906341] Subtest plane-all-transition-fencing: SUCCESS (6.322s)
[501.735612] [086/133] (539s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[501.794169] Starting subtest: etime-single-wait-all-for-submit-submitted
[501.898339] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[501.984220] [087/133] (539s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[502.093173] Starting subtest: x-tiled-32bpp-rotate-0
[503.528333] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.435s)
[503.652839] [088/133] (537s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[503.762950] Starting subtest: fbc-psr2-primary-mmap-cpu
[503.765468] Starting dynamic subtest: eDP-1
[503.770476] Dynamic subtest eDP-1: SKIP (0.000s)
[503.774777] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[503.846520] [089/133] (537s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[503.942991] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[503.946465] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[504.034381] [090/133] (537s left) kms_psr (pr-primary-render)
[504.127248] Starting subtest: pr-primary-render
[504.130637] Subtest pr-primary-render: SKIP (0.000s)
[504.201766] [091/133] (537s left) gem_ctx_persistence (process)
[504.261757] Starting subtest: process
[504.436358] Subtest process: SUCCESS (0.174s)
[504.515894] [092/133] (536s left) gem_userptr_blits (coherency-unsync)
[504.581178] Subtest coherency-unsync: SKIP (0.000s)
[504.693995] [093/133] (536s left) gem_eio (in-flight-1us)
[504.920106] Starting subtest: in-flight-1us
[513.864523] Subtest in-flight-1us: SUCCESS (8.942s)
[513.992169] [094/133] (527s left) kms_dp_linktrain_fallback (dsc-fallback)
[514.094587] Starting subtest: dsc-fallback
[514.100690] Subtest dsc-fallback: SKIP (0.000s)
[514.174133] [095/133] (527s left) kms_big_fb (linear-16bpp-rotate-270)
[514.279843] Starting subtest: linear-16bpp-rotate-270
[514.302704] Subtest linear-16bpp-rotate-270: SKIP (0.020s)
[514.402614] [096/133] (527s left) gem_exec_gttfill (engines)
[514.475408] Starting subtest: engines
[514.477799] Starting dynamic subtest: rcs0
[537.526209] Dynamic subtest rcs0: SUCCESS (23.049s)
[537.536999] Starting dynamic subtest: bcs0
[560.827507] Dynamic subtest bcs0: SUCCESS (23.299s)
[560.838590] Starting dynamic subtest: vcs0
[584.236756] Dynamic subtest vcs0: SUCCESS (23.407s)
[584.247411] Starting dynamic subtest: vcs1
[607.565633] Dynamic subtest vcs1: SUCCESS (23.326s)
[607.575933] Starting dynamic subtest: vecs0
[630.991365] Dynamic subtest vecs0: SUCCESS (23.424s)
[631.004277] Starting dynamic subtest: ccs0
[654.425362] Dynamic subtest ccs0: SUCCESS (23.429s)
[654.428334] Subtest engines: SUCCESS (139.942s)
[654.617409] [097/133] (386s left) i915_pm_freq_api (freq-reset)
[654.723280] Starting subtest: freq-reset
[654.725693] Starting dynamic subtest: gt0
[654.926432] Dynamic subtest gt0: SUCCESS (0.201s)
[654.937661] Starting dynamic subtest: gt1
[655.093860] Dynamic subtest gt1: SUCCESS (0.166s)
[655.097320] Subtest freq-reset: SUCCESS (0.370s)
[655.174397] [098/133] (386s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[655.294304] Starting subtest: y-tiled-64bpp-rotate-270
[655.298612] Subtest y-tiled-64bpp-rotate-270: SKIP (0.001s)
[655.390450] [099/133] (386s left) gem_softpin (full)
[655.455401] Starting subtest: full
[655.462811] Subtest full: SUCCESS (0.007s)
[655.585442] [100/133] (386s left) gem_exec_schedule (noreorder-corked)
[655.771913] Starting subtest: noreorder-corked
[655.774081] Starting dynamic subtest: rcs0
[656.907642] Dynamic subtest rcs0: SUCCESS (1.135s)
[656.920801] Starting dynamic subtest: vcs0
[658.904150] Dynamic subtest vcs0: SUCCESS (1.994s)
[658.918677] Starting dynamic subtest: vcs1
[660.883880] Dynamic subtest vcs1: SUCCESS (1.977s)
[660.896137] Starting dynamic subtest: vecs0
[662.930941] Dynamic subtest vecs0: SUCCESS (2.044s)
[662.943356] Starting dynamic subtest: ccs0
[664.088771] Dynamic subtest ccs0: SUCCESS (1.156s)
[664.091202] Subtest noreorder-corked: SUCCESS (8.318s)
[664.278236] [101/133] (377s left) kms_psr (psr-cursor-render)
[664.378717] Starting subtest: psr-cursor-render
[664.380901] Starting dynamic subtest: eDP-1
[666.127634] Dynamic subtest eDP-1: SUCCESS (1.747s)
[666.129950] Subtest psr-cursor-render: SUCCESS (1.748s)
[666.995178] [102/133] (374s left) gen7_exec_parse (bitmasks)
[667.057622] Subtest bitmasks: SKIP (0.000s)
[667.129038] [103/133] (374s left) gem_vm_create (invalid-destroy)
[667.184944] Starting subtest: invalid-destroy
[667.187278] Subtest invalid-destroy: SUCCESS (0.002s)
[667.311083] [104/133] (374s left) gem_exec_params (dr1-dirt)
[667.372149] Starting subtest: DR1-dirt
[667.374092] Subtest DR1-dirt: SUCCESS (0.000s)
[667.472684] [105/133] (374s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[667.568099] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[667.570177] Starting dynamic subtest: pipe-A-eDP-1
[667.653513] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[667.665045] Starting dynamic subtest: pipe-B-eDP-1
[668.772947] Dynamic subtest pipe-B-eDP-1: SKIP (1.117s)
[668.777638] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.208s)
[669.959608] [106/133] (372s left) kms_flip (2x-modeset-vs-vblank-race)
[670.061993] Starting subtest: 2x-modeset-vs-vblank-race
[670.074308] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[670.170258] [107/133] (371s left) kms_chamelium_audio (dp-audio)
[670.560326] Subtest dp-audio: SKIP (0.000s)
[671.367866] [108/133] (370s left) prime_busy (before-wait)
[671.436931] Starting subtest: before-wait
[671.439275] Starting dynamic subtest: rcs0
[671.459039] Dynamic subtest rcs0: SUCCESS (0.021s)
[671.470335] Starting dynamic subtest: bcs0
[671.508438] Dynamic subtest bcs0: SUCCESS (0.049s)
[671.519899] Starting dynamic subtest: vcs0
[671.549825] Dynamic subtest vcs0: SUCCESS (0.041s)
[671.560439] Starting dynamic subtest: vcs1
[671.590014] Dynamic subtest vcs1: SUCCESS (0.039s)
[671.600109] Starting dynamic subtest: vecs0
[671.631012] Dynamic subtest vecs0: SUCCESS (0.041s)
[671.641020] Starting dynamic subtest: ccs0
[671.672494] Dynamic subtest ccs0: SUCCESS (0.041s)
[671.781935] Subtest before-wait: SUCCESS (0.345s)
[671.859196] [109/133] (370s left) gem_ccs (ctrl-surf-copy-new-ctx)
[671.925569] Starting subtest: ctrl-surf-copy-new-ctx
[671.930052] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[672.033074] [110/133] (370s left) gem_mmap_offset (oob-read)
[672.089629] Starting subtest: oob-read
[672.091845] Subtest oob-read: SUCCESS (0.000s)
[672.183280] [111/133] (370s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[672.279937] Starting subtest: psr-rgb565-draw-mmap-gtt
[672.284125] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[672.371662] [112/133] (369s left) gem_fence_thrash (bo-write-verify-y)
[672.412785] Starting subtest: bo-write-verify-y
[672.432988] Subtest bo-write-verify-y: SKIP (0.016s)
[672.503028] [113/133] (369s left) kms_content_protection (content-type-change)
[672.646159] Starting subtest: content-type-change
[672.650612] Subtest content-type-change: SKIP (0.000s)
[672.764611] [114/133] (369s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[672.867559] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[679.501987] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.634s)
[679.623440] [115/133] (362s left) gem_flink_basic (flink-lifetime)
[679.679420] Starting subtest: flink-lifetime
[679.681722] Subtest flink-lifetime: SUCCESS (0.002s)
[679.798709] [116/133] (362s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[679.912465] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[679.916641] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[680.010844] [117/133] (362s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[680.404268] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[681.228574] [118/133] (361s left) syncobj_wait (multi-wait-all-submitted)
[681.291699] Starting subtest: multi-wait-all-submitted
[681.392952] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[681.472636] [119/133] (361s left) tools_test (tools_test)
[681.525629] Starting subtest: tools_test
[681.587038] Subtest tools_test: SUCCESS (0.078s)
[681.669860] [120/133] (360s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[681.760893] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[688.686182] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.928s)
[688.833989] [121/133] (353s left) gem_pread (self)
[688.893302] Subtest self: SKIP (0.000s)
[688.961967] [122/133] (353s left) gem_ctx_shared (q-promotion)
[689.031584] Starting subtest: Q-promotion
[689.033829] Starting dynamic subtest: rcs0
[689.147543] Dynamic subtest rcs0: SUCCESS (0.114s)
[689.159546] Starting dynamic subtest: vcs0
[689.246905] Dynamic subtest vcs0: SUCCESS (0.099s)
[689.265900] Starting dynamic subtest: vcs1
[689.342243] Dynamic subtest vcs1: SUCCESS (0.094s)
[689.361431] Starting dynamic subtest: vecs0
[689.427441] Dynamic subtest vecs0: SUCCESS (0.085s)
[689.445509] Starting dynamic subtest: ccs0
[689.522307] Dynamic subtest ccs0: SUCCESS (0.093s)
[689.525037] Subtest Q-promotion: SUCCESS (0.490s)
[690.987921] [123/133] (351s left) syncobj_wait (single-wait-all-for-submit-signaled)
[691.056226] Starting subtest: single-wait-all-for-submit-signaled
[691.058644] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[691.173341] [124/133] (351s left) gem_exec_reloc (basic-wc-noreloc)
[691.232609] Subtest basic-wc-noreloc: SKIP (0.000s)
[691.298521] [125/133] (351s left) gem_mmap_gtt (cpuset-big-copy-xy)
[691.360427] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[691.419651] [126/133] (351s left) gem_exec_whisper (basic-fds-priority)
[691.478927] Starting subtest: basic-fds-priority
[716.375443] Subtest basic-fds-priority: SUCCESS (24.877s)
[716.548859] [127/133] (326s left) gem_ctx_create (basic-files)
[716.604695] Starting subtest: basic-files
[718.614073] Subtest basic-files: SUCCESS (2.009s)
[719.941289] [128/133] (322s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[720.041385] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[720.045403] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[720.135212] [129/133] (322s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[720.238307] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[727.674311] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.438s)
[727.803589] [130/133] (315s left) gem_exec_schedule (u-lateslice)
[727.869337] Starting subtest: u-lateslice
[727.871256] Starting dynamic subtest: rcs0
[727.883992] Dynamic subtest rcs0: SUCCESS (0.024s)
[727.896628] Starting dynamic subtest: bcs0
[727.912453] Dynamic subtest bcs0: SUCCESS (0.027s)
[727.923128] Starting dynamic subtest: vcs0
[727.940641] Dynamic subtest vcs0: SUCCESS (0.026s)
[727.951801] Starting dynamic subtest: vcs1
[727.961232] Dynamic subtest vcs1: SUCCESS (0.019s)
[727.971219] Starting dynamic subtest: vecs0
[727.981435] Dynamic subtest vecs0: SUCCESS (0.020s)
[727.992061] Starting dynamic subtest: ccs0
[728.004983] Dynamic subtest ccs0: SUCCESS (0.022s)
[728.007309] Subtest u-lateslice: SUCCESS (0.147s)
[729.952813] [131/133] (313s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[730.028575] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[730.094610] [132/133] (313s left) kms_plane_multiple (2x-tiling-yf)
[730.182370] Starting subtest: 2x-tiling-yf
[730.186614] Subtest 2x-tiling-yf: SKIP (0.000s)
[730.260297] [133/133] (312s left) gem_userptr_blits (unsync-overlap)
[730.337766] Subtest unsync-overlap: SKIP (0.000s)
[730.484474] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: i915_query
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_close_race
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_pm_dc
results: parsing output: 10/ for test: kms_lease
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: prime_mmap_coherency
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_psr2_su
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_color_pipeline
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: vgem_basic
results: parsing output: 31/ for test: kms_fbcon_fbt
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: gem_ctx_freq
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: gem_eio
results: parsing output: 36/ for test: i915_pm_rc6_residency
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: api_intel_allocator
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_setmode
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: core_setmaster
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_ctx_param
results: parsing output: 60/ for test: kms_dsc
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_selftest
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: core_getclient
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_joiner
results: parsing output: 75/ for test: kms_prime
results: parsing output: 76/ for test: gem_close
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: kms_plane_alpha_blend
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: kms_properties
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: kms_dp_linktrain_fallback
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_gttfill
results: parsing output: 96/ for test: i915_pm_freq_api
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gen7_exec_parse
results: parsing output: 102/ for test: gem_vm_create
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_chamelium_audio
results: parsing output: 107/ for test: prime_busy
results: parsing output: 108/ for test: gem_ccs
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_fence_thrash
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_flink_basic
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_chamelium_edid
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: tools_test
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_pread
results: parsing output: 121/ for test: gem_ctx_shared
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: gem_ctx_create
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: kms_pipe_b_c_ivb
results: parsing output: 131/ for test: kms_plane_multiple
results: parsing output: 132/ for test: gem_userptr_blits
Done.