[57.487203] Initializing watchdogs
[57.487248]   /dev/watchdog0
[57.500910] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.505127] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.507455] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.511084] [001/133] (960s left) gem_mmap_gtt (medium-copy-xy)
[57.596491] Subtest medium-copy-XY: SKIP (0.000s)
[57.662119] [002/133] (960s left) kms_plane (pixel-format-yf-tiled-modifier)
[57.762957] Starting subtest: pixel-format-yf-tiled-modifier
[57.767177] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[57.832160] [003/133] (960s left) kms_pm_rpm (pm-caching)
[60.086191] Starting subtest: pm-caching
[60.091838] Subtest pm-caching: SKIP (0.000s)
[60.468395] [004/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[60.554373] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[60.556934] Starting dynamic subtest: pipe-A-eDP-1
[60.578249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[60.587725] Starting dynamic subtest: pipe-B-eDP-1
[60.606832] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[60.613751] Starting dynamic subtest: pipe-C-eDP-1
[60.633248] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[60.639887] Starting dynamic subtest: pipe-D-eDP-1
[60.660136] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[60.662309] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.005s)
[62.803707] [005/133] (955s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[63.178816] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[64.018384] [006/133] (954s left) kms_flip (flip-vs-modeset-vs-hang)
[64.123366] Starting subtest: flip-vs-modeset-vs-hang
[64.125799] Starting dynamic subtest: A-eDP1
[115.434777] Dynamic subtest A-eDP1: SUCCESS (51.320s)
[115.442292] Starting dynamic subtest: D-eDP1
[165.360895] Dynamic subtest D-eDP1: SUCCESS (49.920s)
[165.362959] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.246s)
[165.741122] [007/133] (852s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[165.804101] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[165.806163] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[165.885496] [008/133] (852s left) gem_gpgpu_fill (basic)
[165.939972] Starting subtest: basic
[165.942378] Starting dynamic subtest: smem
[165.947218] Dynamic subtest smem: SUCCESS (0.007s)
[165.949238] Subtest basic: SUCCESS (0.007s)
[166.077233] [009/133] (852s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[166.624931] Starting subtest: syncobj-timeline-invalid-flags
[166.627769] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[167.939815] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[167.943205] [010/133] (850s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[167.993916] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[168.095616] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[168.184792] [011/133] (850s left) gem_mmap_wc (fault-concurrent)
[168.247475] Subtest fault-concurrent: SKIP (0.000s)
[168.344822] [012/133] (850s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[168.460161] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[168.471634] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[168.548555] [013/133] (849s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[168.617023] Starting subtest: multi-wait-all-for-submit-unsubmitted
[168.721530] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[168.794710] [014/133] (849s left) kms_cursor_crc (cursor-offscreen-512x512)
[169.077751] Starting subtest: cursor-offscreen-512x512
[169.082236] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[169.255717] [015/133] (849s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[169.313671] Starting subtest: wait-all-for-submit-delayed-submit
[169.417090] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[169.492900] [016/133] (849s left) kms_draw_crc (draw-method-mmap-wc)
[169.586995] Starting subtest: draw-method-mmap-wc
[169.588923] Starting dynamic subtest: xrgb8888-untiled
[169.806952] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[169.815343] Starting dynamic subtest: rgb565-untiled
[170.007012] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[170.015428] Starting dynamic subtest: xrgb2101010-untiled
[170.207085] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[170.215406] Starting dynamic subtest: xbgr16161616f-untiled
[170.407180] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s)
[170.415835] Starting dynamic subtest: xrgb8888-xtiled
[170.528889] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[170.537093] Starting dynamic subtest: rgb565-xtiled
[170.652806] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[170.660463] Starting dynamic subtest: xrgb2101010-xtiled
[170.762192] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[170.770619] Starting dynamic subtest: xbgr16161616f-xtiled
[170.884436] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[170.891580] Starting dynamic subtest: xrgb8888-4tiled
[171.039953] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[171.048444] Starting dynamic subtest: rgb565-4tiled
[171.184387] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[171.191399] Starting dynamic subtest: xrgb2101010-4tiled
[171.318075] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[171.332865] Starting dynamic subtest: xbgr16161616f-4tiled
[171.484646] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[171.486553] Subtest draw-method-mmap-wc: SUCCESS (1.900s)
[171.590667] [017/133] (847s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[171.690528] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[178.342021] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.652s)
[178.456687] [018/133] (840s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[178.564714] Starting subtest: psr-rgb565-draw-mmap-cpu
[185.291368] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.730s)
[185.403929] [019/133] (833s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[185.509389] Starting subtest: multiplane-rotation-cropping-bottom
[202.916227] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.406s)
[203.028340] [020/133] (815s left) gem_exec_params (secure-non-root)
[203.097840] Starting subtest: secure-non-root
[203.101489] Subtest secure-non-root: SKIP (0.000s)
[203.191455] [021/133] (815s left) gem_exec_schedule (smoketest)
[203.363853] Starting subtest: smoketest
[203.365943] Starting dynamic subtest: rcs0
[208.908306] Dynamic subtest rcs0: SUCCESS (5.499s)
[208.919348] Starting dynamic subtest: bcs0
[214.443267] Dynamic subtest bcs0: SUCCESS (5.528s)
[214.454375] Starting dynamic subtest: vcs0
[219.946135] Dynamic subtest vcs0: SUCCESS (5.501s)
[219.959309] Starting dynamic subtest: vcs1
[225.454036] Dynamic subtest vcs1: SUCCESS (5.509s)
[225.463531] Starting dynamic subtest: vecs0
[230.954583] Dynamic subtest vecs0: SUCCESS (5.498s)
[230.963799] Starting dynamic subtest: ccs0
[236.466874] Dynamic subtest ccs0: SUCCESS (5.512s)
[236.468860] Subtest smoketest: SUCCESS (33.055s)
[236.650452] [022/133] (782s left) kms_psr (fbc-psr-primary-render)
[236.747870] Starting subtest: fbc-psr-primary-render
[236.750087] Starting dynamic subtest: eDP-1
[236.754128] Dynamic subtest eDP-1: SKIP (0.000s)
[236.758211] Subtest fbc-psr-primary-render: SKIP (0.001s)
[236.833437] [023/133] (782s left) kms_pm_dc (dc3co-vpb-simulation)
[237.931888] Starting subtest: dc3co-vpb-simulation
[246.885912] Subtest dc3co-vpb-simulation: SKIP (8.950s)
[247.018675] [024/133] (771s left) gem_exec_whisper (basic-fds-all)
[247.088784] Starting subtest: basic-fds-all
[258.870954] Subtest basic-fds-all: SUCCESS (11.778s)
[259.053872] [025/133] (759s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[259.168471] Starting subtest: fbc-rgb565-draw-blt
[263.309804] Subtest fbc-rgb565-draw-blt: SUCCESS (4.145s)
[264.455329] [026/133] (754s left) prime_vgem (fence-flip-hang)
[264.521448] Subtest fence-flip-hang: SKIP (0.000s)
[264.635392] [027/133] (754s left) gem_pwrite (basic-random)
[264.697507] Subtest basic-random: SKIP (0.000s)
[264.755951] [028/133] (754s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[264.817091] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[264.821523] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[265.000688] [029/133] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[265.102672] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[271.984368] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.885s)
[272.118243] [030/133] (747s left) kms_flip (wf_vblank-ts-check-interruptible)
[272.221973] Starting subtest: wf_vblank-ts-check-interruptible
[272.224299] Starting dynamic subtest: A-eDP1
[281.122773] Dynamic subtest A-eDP1: SUCCESS (8.900s)
[281.133996] Starting dynamic subtest: B-eDP1
[290.057588] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[290.068060] Starting dynamic subtest: C-eDP1
[298.972586] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[298.983035] Starting dynamic subtest: D-eDP1
[307.902726] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[307.905106] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.684s)
[309.123111] [031/133] (710s left) perf (gen12-unprivileged-single-ctx-counters)
[309.235820] Starting subtest: gen12-unprivileged-single-ctx-counters
[309.238170] Starting dynamic subtest: rcs0
[309.421290] Dynamic subtest rcs0: SUCCESS (0.185s)
[309.423492] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.186s)
[309.473816] [032/133] (709s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[309.588602] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[309.592842] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[309.684950] [033/133] (709s left) kms_big_fb (linear-32bpp-rotate-0)
[309.790874] Starting subtest: linear-32bpp-rotate-0
[311.315525] Subtest linear-32bpp-rotate-0: SUCCESS (1.524s)
[311.446305] [034/133] (707s left) gem_exec_async (concurrent-writes)
[311.512070] Starting subtest: concurrent-writes
[311.513944] Starting dynamic subtest: rcs0
[311.527920] Dynamic subtest rcs0: SUCCESS (0.016s)
[311.538157] Starting dynamic subtest: bcs0
[311.540139] Dynamic subtest bcs0: SUCCESS (0.005s)
[311.548049] Starting dynamic subtest: vcs0
[311.549712] Dynamic subtest vcs0: SUCCESS (0.006s)
[311.558060] Starting dynamic subtest: vcs1
[311.559930] Dynamic subtest vcs1: SUCCESS (0.006s)
[311.567661] Starting dynamic subtest: vecs0
[311.569276] Dynamic subtest vecs0: SUCCESS (0.005s)
[311.576662] Starting dynamic subtest: ccs0
[311.578260] Dynamic subtest ccs0: SUCCESS (0.007s)
[311.579794] Subtest concurrent-writes: SUCCESS (0.049s)
[311.792923] [035/133] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[311.886776] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[319.275661] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.389s)
[319.388275] [036/133] (700s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[319.495440] Starting subtest: plane-lut1d-ctm3x4
[319.619086] Starting dynamic subtest: pipe-A-plane-0
[319.764289] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[319.773045] Starting dynamic subtest: pipe-A-plane-1
[319.907978] Dynamic subtest pipe-A-plane-1: SUCCESS (0.143s)
[319.916969] Starting dynamic subtest: pipe-A-plane-2
[320.096898] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[321.321735] Starting dynamic subtest: pipe-B-plane-0
[321.513225] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[321.522099] Starting dynamic subtest: pipe-B-plane-1
[321.657754] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[321.669028] Starting dynamic subtest: pipe-B-plane-2
[321.835371] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[323.045039] Starting dynamic subtest: pipe-C-plane-0
[323.171689] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[323.180953] Starting dynamic subtest: pipe-C-plane-1
[323.316217] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[323.325443] Starting dynamic subtest: pipe-C-plane-2
[323.449342] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[324.679039] Starting dynamic subtest: pipe-D-plane-0
[324.805430] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[324.814100] Starting dynamic subtest: pipe-D-plane-1
[324.938709] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[324.947299] Starting dynamic subtest: pipe-D-plane-2
[325.072041] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[325.358253] Subtest plane-lut1d-ctm3x4: SUCCESS (5.863s)
[326.148215] [037/133] (693s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[326.257728] Starting subtest: y-tiled-16bpp-rotate-270
[326.262249] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[326.358037] [038/133] (693s left) kms_properties (plane-properties-legacy)
[326.460237] Starting subtest: plane-properties-legacy
[326.462534] Starting dynamic subtest: pipe-A-eDP-1
[327.028104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[327.038073] Starting dynamic subtest: pipe-B-eDP-1
[328.333271] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.302s)
[328.342429] Starting dynamic subtest: pipe-C-eDP-1
[329.568575] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[329.578204] Starting dynamic subtest: pipe-D-eDP-1
[330.805044] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[330.807371] Subtest plane-properties-legacy: SUCCESS (4.345s)
[331.596751] [039/133] (687s left) gem_exec_reloc (basic-write-read-noreloc)
[331.659468] Subtest basic-write-read-noreloc: SKIP (0.000s)
[331.724549] [040/133] (687s left) sw_sync (sync_multi_timeline_wait)
[331.763955] Starting subtest: sync_multi_timeline_wait
[331.766322] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[331.815487] [041/133] (687s left) kms_plane_scaling (planes-upscale-20x20)
[331.913065] Starting subtest: planes-upscale-20x20
[331.915340] Starting dynamic subtest: pipe-A
[331.972347] Dynamic subtest pipe-A: SUCCESS (0.062s)
[331.983062] Starting dynamic subtest: pipe-B
[333.121581] Dynamic subtest pipe-B: SUCCESS (1.148s)
[333.131311] Starting dynamic subtest: pipe-C
[334.225229] Dynamic subtest pipe-C: SUCCESS (1.102s)
[334.233539] Starting dynamic subtest: pipe-D
[335.366553] Dynamic subtest pipe-D: SUCCESS (1.140s)
[335.368834] Subtest planes-upscale-20x20: SUCCESS (3.457s)
[336.521989] [042/133] (683s left) perf_pmu (busy-idle-check-all)
[336.563777] Starting subtest: busy-idle-check-all
[336.566051] Starting dynamic subtest: rcs0
[337.211209] Dynamic subtest rcs0: SUCCESS (0.650s)
[337.222227] Starting dynamic subtest: bcs0
[337.861735] Dynamic subtest bcs0: SUCCESS (0.648s)
[337.873254] Starting dynamic subtest: vcs0
[339.925398] Dynamic subtest vcs0: SUCCESS (2.059s)
[339.937696] Starting dynamic subtest: vcs1
[341.908881] Dynamic subtest vcs1: SUCCESS (1.980s)
[341.920275] Starting dynamic subtest: vecs0
[343.892963] Dynamic subtest vecs0: SUCCESS (1.981s)
[343.904968] Starting dynamic subtest: ccs0
[344.548144] Dynamic subtest ccs0: SUCCESS (0.653s)
[344.550587] Subtest busy-idle-check-all: SUCCESS (7.989s)
[344.661669] [043/133] (675s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[344.753950] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[344.758095] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[344.860662] [044/133] (674s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[345.064712] Starting subtest: cursor-rapid-movement-128x128
[345.069356] Starting dynamic subtest: pipe-A-eDP-1
[345.618948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[345.647373] Starting dynamic subtest: pipe-D-eDP-1
[346.840332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s)
[346.842538] Subtest cursor-rapid-movement-128x128: SUCCESS (1.774s)
[347.702819] [045/133] (672s left) sw_sync (timeline_closed_signaled)
[347.748041] Starting subtest: timeline_closed_signaled
[347.750429] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[347.803381] [046/133] (672s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[347.894693] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[347.899246] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[347.994308] [047/133] (671s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[348.098609] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[348.102628] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[348.196360] [048/133] (671s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[348.302585] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[348.306757] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[348.403268] [049/133] (671s left) kms_psr (psr-cursor-plane-move)
[348.515998] Starting subtest: psr-cursor-plane-move
[348.518228] Starting dynamic subtest: eDP-1
[350.285831] Dynamic subtest eDP-1: SUCCESS (1.769s)
[350.288291] Subtest psr-cursor-plane-move: SUCCESS (1.771s)
[351.159773] [050/133] (668s left) gem_exec_schedule (pi-distinct-iova)
[351.349078] Starting subtest: pi-distinct-iova
[351.351564] Starting dynamic subtest: rcs0
[351.432302] Dynamic subtest rcs0: SUCCESS (0.086s)
[351.444694] Starting dynamic subtest: vcs0
[351.496323] Dynamic subtest vcs0: SUCCESS (0.063s)
[351.505424] Starting dynamic subtest: vcs1
[351.552270] Dynamic subtest vcs1: SUCCESS (0.053s)
[351.560835] Starting dynamic subtest: vecs0
[351.607772] Dynamic subtest vecs0: SUCCESS (0.055s)
[351.619086] Starting dynamic subtest: ccs0
[351.668491] Dynamic subtest ccs0: SUCCESS (0.060s)
[351.670792] Subtest pi-distinct-iova: SUCCESS (0.323s)
[353.017398] [051/133] (667s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[353.399111] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[354.172707] [052/133] (665s left) i915_drm_fdinfo (busy-check-all)
[354.217182] Starting subtest: busy-check-all
[354.219526] Starting dynamic subtest: rcs0
[354.223989] Dynamic subtest rcs0: SKIP (0.003s)
[354.234035] Starting dynamic subtest: bcs0
[354.238064] Dynamic subtest bcs0: SKIP (0.000s)
[354.246443] Starting dynamic subtest: vcs0
[354.250666] Dynamic subtest vcs0: SKIP (0.000s)
[354.258740] Starting dynamic subtest: vcs1
[354.262838] Dynamic subtest vcs1: SKIP (0.000s)
[354.270639] Starting dynamic subtest: vecs0
[354.274662] Dynamic subtest vecs0: SKIP (0.000s)
[354.283123] Starting dynamic subtest: ccs0
[354.287214] Dynamic subtest ccs0: SKIP (0.000s)
[354.291258] Subtest busy-check-all: SKIP (0.010s)
[354.327441] [053/133] (665s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[354.450628] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[354.454838] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[354.523011] [054/133] (665s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[354.582953] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[354.587358] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[354.764832] [055/133] (665s left) gem_linear_blits (basic)
[355.154872] Starting subtest: basic
[355.162136] Subtest basic: SUCCESS (0.008s)
[355.304281] [056/133] (664s left) gem_wait (invalid-flags)
[355.395694] Starting subtest: invalid-flags
[355.398038] Subtest invalid-flags: SUCCESS (0.000s)
[355.631603] [057/133] (664s left) gem_exec_balancer (parallel-out-fence)
[355.891054] Starting subtest: parallel-out-fence
[357.004416] Subtest parallel-out-fence: SUCCESS (1.114s)
[357.131127] [058/133] (663s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[357.187510] Subtest writes-after-reads: SKIP (0.000s)
[357.257104] [059/133] (663s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[357.384426] Starting subtest: cursorB-vs-flipB-toggle
[357.389186] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[357.528148] [060/133] (662s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[357.582928] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[357.669647] [061/133] (662s left) gem_softpin (allocator-nopin)
[357.724416] Starting subtest: allocator-nopin
[357.824641] Subtest allocator-nopin: SUCCESS (0.100s)
[357.965933] [062/133] (662s left) gen7_exec_parse (batch-without-end)
[358.018672] Subtest batch-without-end: SKIP (0.000s)
[358.097285] [063/133] (662s left) kms_flip (flip-vs-suspend)
[358.185393] Starting subtest: flip-vs-suspend
[358.187369] Starting dynamic subtest: A-eDP1
[407.202697] Dynamic subtest A-eDP1: SUCCESS (4.757s)
[407.215880] Starting dynamic subtest: B-eDP1
[456.177003] Dynamic subtest B-eDP1: SUCCESS (4.458s)
[456.188227] Starting dynamic subtest: C-eDP1
[505.198409] Dynamic subtest C-eDP1: SUCCESS (4.574s)
[505.214528] Starting dynamic subtest: D-eDP1
[554.185041] Dynamic subtest D-eDP1: SUCCESS (4.485s)
[554.187208] Subtest flip-vs-suspend: SUCCESS (18.283s)
[555.353996] [064/133] (465s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[555.456324] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[555.459118] Starting dynamic subtest: pipe-A-eDP-1
[555.490490] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[555.501843] Starting dynamic subtest: pipe-B-eDP-1
[555.530428] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[555.540346] Starting dynamic subtest: pipe-C-eDP-1
[555.569117] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[555.578892] Starting dynamic subtest: pipe-D-eDP-1
[555.607102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[555.612150] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[557.628627] [065/133] (463s left) gem_ctx_engines (invalid-engines)
[557.685367] Starting subtest: invalid-engines
[557.694168] Subtest invalid-engines: SUCCESS (0.009s)
[557.916102] [066/133] (462s left) kms_atomic_transition (plane-toggle-modeset-transition)
[558.014776] Starting subtest: plane-toggle-modeset-transition
[558.017113] Starting dynamic subtest: pipe-A-eDP-1
[570.745185] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.751s)
[570.764045] Starting dynamic subtest: pipe-B-eDP-1
[583.169258] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.429s)
[583.172391] Subtest plane-toggle-modeset-transition: SUCCESS (25.187s)
[583.990972] [067/133] (436s left) kms_psr (fbc-pr-sprite-plane-onoff)
[584.089017] Starting subtest: fbc-pr-sprite-plane-onoff
[584.093797] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[584.165736] [068/133] (436s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[584.261653] Starting subtest: fbcpsr-rgb565-draw-pwrite
[591.261399] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.023s)
[591.396263] [069/133] (429s left) gem_ccs (ctrl-surf-copy)
[591.460945] Starting subtest: ctrl-surf-copy
[591.466182] Subtest ctrl-surf-copy: SKIP (0.000s)
[591.580234] [070/133] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[591.690154] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[591.695187] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[591.801362] [071/133] (429s left) prime_vgem (fence-write-hang)
[591.876404] Subtest fence-write-hang: SKIP (0.000s)
[591.976117] [072/133] (428s left) syncobj_timeline (invalid-signal-zero-handles)
[592.035370] Starting subtest: invalid-signal-zero-handles
[592.037635] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[592.107699] [073/133] (428s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[592.192114] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[592.196602] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[592.263464] [074/133] (428s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[592.352289] Starting subtest: psr-2p-pri-indfb-multidraw
[592.356720] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[592.446507] [075/133] (428s left) kms_pipe_crc_basic (suspend-read-crc)
[592.535993] Starting subtest: suspend-read-crc
[592.538076] Starting dynamic subtest: pipe-A-eDP-1
[610.079917] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.550s)
[610.092940] Starting dynamic subtest: pipe-B-eDP-1
[628.080850] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.160s)
[628.092057] Starting dynamic subtest: pipe-C-eDP-1
[646.037777] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.049s)
[646.050905] Starting dynamic subtest: pipe-D-eDP-1
[664.026874] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.041s)
[664.029766] Subtest suspend-read-crc: SUCCESS (11.805s)
[664.854861] [076/133] (356s left) dumb_buffer (invalid-bpp)
[664.918942] Starting subtest: invalid-bpp
[664.921906] Subtest invalid-bpp: SUCCESS (0.000s)
[665.019693] [077/133] (356s left) kms_plane (plane-position-hole-dpms)
[665.108587] Starting subtest: plane-position-hole-dpms
[665.633799] Starting dynamic subtest: pipe-A-plane-1
[668.030878] Dynamic subtest pipe-A-plane-1: SUCCESS (2.413s)
[668.045655] Starting dynamic subtest: pipe-A-plane-2
[670.341524] Dynamic subtest pipe-A-plane-2: SUCCESS (2.319s)
[670.352728] Starting dynamic subtest: pipe-A-plane-3
[672.721793] Dynamic subtest pipe-A-plane-3: SUCCESS (2.386s)
[672.734738] Starting dynamic subtest: pipe-A-plane-4
[675.071927] Dynamic subtest pipe-A-plane-4: SUCCESS (2.356s)
[675.083321] Starting dynamic subtest: pipe-A-plane-5
[675.105677] Dynamic subtest pipe-A-plane-5: SUCCESS (0.032s)
[676.260457] Starting dynamic subtest: pipe-B-plane-1
[678.668829] Dynamic subtest pipe-B-plane-1: SUCCESS (2.423s)
[678.679765] Starting dynamic subtest: pipe-B-plane-2
[680.945812] Dynamic subtest pipe-B-plane-2: SUCCESS (2.279s)
[680.956714] Starting dynamic subtest: pipe-B-plane-3
[683.294151] Dynamic subtest pipe-B-plane-3: SUCCESS (2.352s)
[683.307902] Starting dynamic subtest: pipe-B-plane-4
[685.654907] Dynamic subtest pipe-B-plane-4: SUCCESS (2.363s)
[685.665231] Starting dynamic subtest: pipe-B-plane-5
[685.685889] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[685.688786] Subtest plane-position-hole-dpms: SUCCESS (20.637s)
[686.463221] [078/133] (334s left) gem_exec_create (madvise)
[686.539083] Starting subtest: madvise
[686.541946] Starting dynamic subtest: smem
[708.609060] Dynamic subtest smem: SUCCESS (22.074s)
[708.611835] Subtest madvise: SUCCESS (22.075s)
[709.395726] [079/133] (311s left) i915_module_load (reload-no-display)
[709.451024] Starting subtest: reload-no-display
[714.748531] Subtest reload-no-display: SUCCESS (5.302s)
[714.779537] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[714.780312] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[714.784180] [080/133] (306s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[717.274754] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[717.277417] Starting dynamic subtest: pipe-A-eDP-1
[717.405044] Dynamic subtest pipe-A-eDP-1: SKIP (0.136s)
[717.416073] Starting dynamic subtest: pipe-B-eDP-1
[718.552040] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[718.557750] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.284s)
[719.775587] [FACT kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[719.776835] [FACT kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)] new: kernel.kmod_is_loaded.i915: true
[719.780441] [081/133] (301s left) prime_vgem (coherency-blt)
[719.872525] Starting subtest: coherency-blt
[720.977722] Subtest coherency-blt: SUCCESS (1.104s)
[721.096454] [082/133] (300s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[721.205541] Starting subtest: x-tiled-64bpp-rotate-180
[722.877949] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.673s)
[723.021110] [083/133] (298s left) gem_exec_balancer (indices)
[723.088473] Starting subtest: indices
[725.447880] Subtest indices: SUCCESS (2.359s)
[725.754763] [084/133] (295s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[725.849887] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[725.852685] Starting dynamic subtest: pipe-A-eDP-1
[726.312817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[726.323884] Starting dynamic subtest: pipe-B-eDP-1
[727.750800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s)
[727.761250] Starting dynamic subtest: pipe-C-eDP-1
[729.155330] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[729.165806] Starting dynamic subtest: pipe-D-eDP-1
[730.487053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[730.489844] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.608s)
[731.659724] [085/133] (289s left) kms_sequence (queue-idle)
[731.753894] Starting subtest: queue-idle
[731.756623] Starting dynamic subtest: pipe-A-eDP-1
[733.570591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[733.581036] Starting dynamic subtest: pipe-B-eDP-1
[736.041248] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.472s)
[736.052245] Starting dynamic subtest: pipe-C-eDP-1
[738.547758] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.506s)
[738.558586] Starting dynamic subtest: pipe-D-eDP-1
[740.962040] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.416s)
[740.965024] Subtest queue-idle: SUCCESS (9.214s)
[741.773391] [086/133] (279s left) api_intel_bb (simple-bb)
[741.835894] Starting subtest: simple-bb
[741.839330] Subtest simple-bb: SUCCESS (0.007s)
[741.956304] [087/133] (279s left) gem_watchdog (default-physical)
[742.020031] Starting subtest: default-physical
[743.778409] Subtest default-physical: SUCCESS (1.771s)
[743.870276] [088/133] (277s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[743.956329] Starting subtest: fbc-pr-cursor-mmap-cpu
[743.961491] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[744.030899] [089/133] (277s left) kms_cursor_crc (cursor-sliding-256x85)
[744.291617] Starting subtest: cursor-sliding-256x85
[744.337034] Subtest cursor-sliding-256x85: SKIP (0.039s)
[744.517271] [090/133] (277s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[744.620056] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[745.743108] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.123s)
[745.859038] [091/133] (275s left) kms_lease (lease-again)
[745.950934] Starting subtest: lease-again
[745.953689] Starting dynamic subtest: pipe-A-eDP-1
[745.956094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[745.967447] Starting dynamic subtest: pipe-B-eDP-1
[745.969582] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[745.980824] Starting dynamic subtest: pipe-C-eDP-1
[745.983175] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[745.992078] Starting dynamic subtest: pipe-D-eDP-1
[745.994803] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[745.997234] Subtest lease-again: SUCCESS (0.014s)
[746.078858] [092/133] (275s left) kms_prop_blob (invalid-get-prop)
[746.132105] Starting subtest: invalid-get-prop
[746.134832] Subtest invalid-get-prop: SUCCESS (0.000s)
[746.244692] [093/133] (275s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[746.351926] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[746.357878] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[746.447908] [094/133] (275s left) gem_mmap_gtt (hang-busy)
[746.508719] Subtest hang-busy: SKIP (0.000s)
[746.566834] [095/133] (275s left) kms_flip (2x-modeset-vs-vblank-race)
[746.661612] Starting subtest: 2x-modeset-vs-vblank-race
[746.669932] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[746.750046] [096/133] (275s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[746.849243] Starting subtest: 4-tiled-64bpp-rotate-0
[748.425668] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.579s)
[748.584542] [097/133] (273s left) kms_addfb_basic (basic)
[748.642701] Starting subtest: basic
[748.645436] Subtest basic: SUCCESS (0.000s)
[748.774121] [098/133] (273s left) gem_reg_read (timestamp-monotonic)
[748.829842] Starting subtest: timestamp-monotonic
[753.614344] Subtest timestamp-monotonic: SUCCESS (4.787s)
[753.704584] [099/133] (268s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[753.797802] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[753.802984] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[753.870967] [100/133] (268s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[753.965916] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[753.968791] Starting dynamic subtest: pipe-A-eDP-1
[753.997289] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[754.007840] Starting dynamic subtest: pipe-B-eDP-1
[754.032661] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[754.041877] Starting dynamic subtest: pipe-C-eDP-1
[754.067056] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[754.075979] Starting dynamic subtest: pipe-D-eDP-1
[754.102556] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[754.107261] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[756.225287] [101/133] (265s left) kms_properties (invalid-properties-legacy)
[756.323031] Starting subtest: invalid-properties-legacy
[756.421332] Subtest invalid-properties-legacy: SUCCESS (0.100s)
[756.508452] [102/133] (265s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[756.557855] Starting subtest: multi-wait-available-unsubmitted-submitted
[756.560739] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[756.649774] [103/133] (265s left) kms_properties (crtc-properties-atomic)
[756.747427] Starting subtest: crtc-properties-atomic
[756.749755] Starting dynamic subtest: pipe-A-eDP-1
[757.185552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[757.195352] Starting dynamic subtest: pipe-B-eDP-1
[758.381076] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.195s)
[758.392185] Starting dynamic subtest: pipe-C-eDP-1
[759.494597] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[759.505417] Starting dynamic subtest: pipe-D-eDP-1
[760.642896] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[760.645318] Subtest crtc-properties-atomic: SUCCESS (3.896s)
[761.447881] [104/133] (260s left) i915_pm_rps (min-max-config-idle)
[761.512915] Starting subtest: min-max-config-idle
[761.518866] Subtest min-max-config-idle: SKIP (0.001s)
[761.635306] [105/133] (260s left) gem_softpin (evict-active-interruptible)
[761.698861] Starting subtest: evict-active-interruptible
[761.704654] Subtest evict-active-interruptible: SUCCESS (0.006s)
[761.825248] [106/133] (260s left) gem_exec_schedule (fairslice)
[761.895428] Starting subtest: fairslice
[761.897602] Starting dynamic subtest: rcs0
[763.915563] Dynamic subtest rcs0: SUCCESS (2.017s)
[763.931046] Starting dynamic subtest: bcs0
[765.939055] Dynamic subtest bcs0: SUCCESS (2.024s)
[765.950027] Starting dynamic subtest: vcs0
[767.958435] Dynamic subtest vcs0: SUCCESS (2.018s)
[767.968799] Starting dynamic subtest: vcs1
[769.978501] Dynamic subtest vcs1: SUCCESS (2.020s)
[769.989449] Starting dynamic subtest: vecs0
[772.003654] Dynamic subtest vecs0: SUCCESS (2.021s)
[772.013543] Starting dynamic subtest: ccs0
[774.025723] Dynamic subtest ccs0: SUCCESS (2.020s)
[774.028319] Subtest fairslice: SUCCESS (12.127s)
[774.323168] [107/133] (248s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[774.422355] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[774.424307] Starting dynamic subtest: pipe-A-eDP-1
[776.549465] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.126s)
[776.561548] Starting dynamic subtest: pipe-B-eDP-1
[778.703682] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.153s)
[778.716028] Starting dynamic subtest: pipe-C-eDP-1
[780.704927] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.000s)
[780.714528] Starting dynamic subtest: pipe-D-eDP-1
[782.783283] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.078s)
[782.785312] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.362s)
[783.969625] [108/133] (238s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[784.070795] Starting subtest: addfb25-y-tiled-legacy
[784.073068] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[784.161593] [109/133] (238s left) kms_psr (fbc-psr-suspend)
[784.249825] Starting subtest: fbc-psr-suspend
[784.252418] Starting dynamic subtest: eDP-1
[784.257663] Dynamic subtest eDP-1: SKIP (0.000s)
[784.262662] Subtest fbc-psr-suspend: SKIP (0.001s)
[784.324069] [110/133] (238s left) gem_ctx_persistence (legacy-engines-persistence)
[784.379815] Starting subtest: legacy-engines-persistence
[784.382605] Starting dynamic subtest: render
[785.191221] Dynamic subtest render: SUCCESS (0.811s)
[785.204071] Starting dynamic subtest: bsd1
[785.958035] Dynamic subtest bsd1: SUCCESS (0.764s)
[785.972830] Starting dynamic subtest: bsd2
[786.720397] Dynamic subtest bsd2: SUCCESS (0.759s)
[786.732368] Starting dynamic subtest: blt
[787.497047] Dynamic subtest blt: SUCCESS (0.774s)
[787.510236] Starting dynamic subtest: vebox
[788.245990] Dynamic subtest vebox: SUCCESS (0.746s)
[788.248864] Subtest legacy-engines-persistence: SUCCESS (3.867s)
[788.366802] [111/133] (234s left) i915_suspend (basic-s2idle-without-i915)
[788.411897] Starting subtest: basic-s2idle-without-i915
[807.659142] Subtest basic-s2idle-without-i915: SUCCESS (4.026s)
[807.807684] [112/133] (214s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[807.919055] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[807.923029] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[808.031267] [113/133] (214s left) syncobj_basic (create-signaled)
[808.088373] Starting subtest: create-signaled
[808.090623] Subtest create-signaled: SUCCESS (0.000s)
[808.205783] [114/133] (214s left) gem_exec_params (cliprects-invalid)
[808.274448] Starting subtest: cliprects-invalid
[808.276869] Subtest cliprects-invalid: SUCCESS (0.000s)
[808.369525] [115/133] (214s left) kms_invalid_mode (overflow-vrefresh)
[808.454271] Starting subtest: overflow-vrefresh
[808.456399] Starting dynamic subtest: pipe-A-eDP-1
[808.772233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.317s)
[808.781281] Starting dynamic subtest: pipe-B-eDP-1
[808.783218] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[808.791978] Starting dynamic subtest: pipe-C-eDP-1
[808.794119] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[808.802379] Starting dynamic subtest: pipe-D-eDP-1
[808.804490] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[808.806603] Subtest overflow-vrefresh: SUCCESS (0.333s)
[809.593055] [116/133] (213s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[809.699518] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[809.704117] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[809.844384] [117/133] (213s left) sysfs_timeslice_duration (invalid)
[809.900411] Starting subtest: invalid
[809.902695] Starting dynamic subtest: vecs0
[809.904945] Dynamic subtest vecs0: SUCCESS (0.000s)
[809.914215] Starting dynamic subtest: ccs0
[809.916489] Dynamic subtest ccs0: SUCCESS (0.000s)
[809.925149] Starting dynamic subtest: vcs0
[809.927051] Dynamic subtest vcs0: SUCCESS (0.000s)
[809.935566] Starting dynamic subtest: bcs0
[809.937749] Dynamic subtest bcs0: SUCCESS (0.000s)
[809.946006] Starting dynamic subtest: rcs0
[809.948148] Dynamic subtest rcs0: SUCCESS (0.000s)
[809.956472] Starting dynamic subtest: vcs1
[809.958708] Dynamic subtest vcs1: SUCCESS (0.000s)
[809.960926] Subtest invalid: SUCCESS (0.005s)
[809.998790] [118/133] (212s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[810.108511] Starting subtest: cursorA-vs-flipA-varying-size
[821.291551] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.175s)
[822.137861] [119/133] (200s left) kms_async_flips (crc-atomic)
[822.235139] Starting subtest: crc-atomic
[822.614314] Starting dynamic subtest: pipe-A-eDP-1
[825.535174] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.920s)
[825.917489] Starting dynamic subtest: pipe-B-eDP-1
[828.862364] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.951s)
[829.239309] Starting dynamic subtest: pipe-C-eDP-1
[832.155907] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.927s)
[832.531205] Starting dynamic subtest: pipe-D-eDP-1
[835.384566] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.865s)
[835.386962] Subtest crc-atomic: SUCCESS (13.150s)
[836.558840] [120/133] (186s left) gem_ctx_exec (basic-norecovery)
[836.631804] Starting subtest: basic-norecovery
[836.826404] Subtest basic-norecovery: SUCCESS (0.193s)
[836.939442] [121/133] (186s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[837.044088] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[840.656328] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.618s)
[841.860353] [122/133] (181s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[841.959283] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[841.963479] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[842.060438] [123/133] (181s left) syncobj_eventfd (timeline-wait-before-signal)
[842.121569] Starting subtest: timeline-wait-before-signal
[842.151661] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[842.228926] [124/133] (180s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[842.325900] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[842.329790] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[842.422782] [125/133] (180s left) gem_ctx_param (root-set)
[842.470264] Starting subtest: root-set
[842.472545] Subtest root-set: SUCCESS (0.001s)
[842.563399] [126/133] (180s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[842.666866] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[849.456316] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.792s)
[849.594880] [127/133] (173s left) gem_eio (hibernate)
[849.767126] Starting subtest: hibernate
[864.200396] Subtest hibernate: SUCCESS (14.437s)
[873.333071] [128/133] (158s left) kms_content_protection (dp-mst-lic-type-0)
[873.514544] Starting subtest: dp-mst-lic-type-0
[873.518910] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[873.621118] [129/133] (158s left) gem_exec_reloc (basic-write-cpu-noreloc)
[873.675829] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[873.749598] [130/133] (158s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[873.811386] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[873.813606] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[873.930119] [131/133] (158s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[874.052965] Starting subtest: fbc-dirtyfb-ioctl
[874.055240] Starting dynamic subtest: A-eDP-1
[876.694623] Dynamic subtest A-eDP-1: SUCCESS (2.642s)
[876.696919] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.644s)
[877.499338] [132/133] (154s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[877.603767] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[877.607961] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[877.702496] [133/133] (154s left) kms_vblank (query-forked-busy-hang)
[877.787075] Starting subtest: query-forked-busy-hang
[877.789215] Starting dynamic subtest: pipe-A-eDP-1
[904.477333] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.689s)
[904.493520] Starting dynamic subtest: pipe-D-eDP-1
[919.444843] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.965s)
[919.447296] Subtest query-forked-busy-hang: SUCCESS (41.659s)
[920.247739] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_chamelium_frames
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gem_gpgpu_fill
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_mmap_wc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_draw_crc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_rotation_crc
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_pm_dc
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: prime_vgem
results: parsing output: 26/ for test: gem_pwrite
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_exec_async
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_color_pipeline
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_properties
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: sw_sync
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_chamelium_hpd
results: parsing output: 51/ for test: i915_drm_fdinfo
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: gem_linear_blits
results: parsing output: 55/ for test: gem_wait
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_ctx_engines
results: parsing output: 65/ for test: kms_atomic_transition
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: dumb_buffer
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: gem_exec_create
results: parsing output: 78/ for test: i915_module_load
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: prime_vgem
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_sequence
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: gem_watchdog
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: kms_prop_blob
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: gem_reg_read
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_properties
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: i915_suspend
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_basic
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: sysfs_timeslice_duration
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: gem_ctx_exec
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_eventfd
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_content_protection
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_dirtyfb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_vblank
Done.