[52.247879] Initializing watchdogs
[52.247928]   /dev/watchdog0
[52.263421] [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]
[52.268801] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.272557] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.275809] [001/133] (960s left) gem_mmap_gtt (medium-copy-xy)
[52.357409] Subtest medium-copy-XY: SKIP (0.000s)
[52.431521] [002/133] (960s left) kms_plane (pixel-format-yf-tiled-modifier)
[52.518371] Starting subtest: pixel-format-yf-tiled-modifier
[52.522929] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[52.589927] [003/133] (960s left) kms_pm_rpm (pm-caching)
[54.150246] Starting subtest: pm-caching
[54.155923] Subtest pm-caching: SKIP (0.000s)
[54.939444] [004/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[55.046048] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[55.048202] Starting dynamic subtest: pipe-A-eDP-1
[55.068040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[55.077092] Starting dynamic subtest: pipe-B-eDP-1
[55.096618] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[55.104063] Starting dynamic subtest: pipe-C-eDP-1
[55.122646] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[55.129804] Starting dynamic subtest: pipe-D-eDP-1
[55.149813] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[55.151799] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.005s)
[57.196367] [005/133] (955s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[57.586838] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[58.405039] [006/133] (954s left) kms_flip (flip-vs-modeset-vs-hang)
[58.496925] Starting subtest: flip-vs-modeset-vs-hang
[58.499471] Starting dynamic subtest: A-eDP1
[109.357769] Dynamic subtest A-eDP1: SUCCESS (50.857s)
[109.367960] Starting dynamic subtest: D-eDP1
[159.340943] Dynamic subtest D-eDP1: SUCCESS (49.981s)
[159.343226] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.843s)
[159.724064] [007/133] (853s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[159.778995] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[159.781452] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[159.880837] [008/133] (853s left) gem_gpgpu_fill (basic)
[159.938853] Starting subtest: basic
[159.941302] Starting dynamic subtest: smem
[159.947111] Dynamic subtest smem: SUCCESS (0.008s)
[159.949510] Subtest basic: SUCCESS (0.008s)
[160.066328] [009/133] (853s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[160.617601] Starting subtest: syncobj-timeline-invalid-flags
[160.620250] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[161.948993] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[161.953598] [010/133] (851s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[162.006446] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[162.113730] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[162.194753] [011/133] (850s left) gem_mmap_wc (fault-concurrent)
[162.246093] Subtest fault-concurrent: SKIP (0.000s)
[162.309539] [012/133] (850s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[162.403071] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[162.414881] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[162.499763] [013/133] (850s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[162.545906] Starting subtest: multi-wait-all-for-submit-unsubmitted
[162.649789] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[162.730294] [014/133] (850s left) kms_cursor_crc (cursor-offscreen-512x512)
[163.012476] Starting subtest: cursor-offscreen-512x512
[163.017178] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[163.160854] [015/133] (850s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[163.219164] Starting subtest: wait-all-for-submit-delayed-submit
[163.323801] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s)
[163.411536] [016/133] (849s left) kms_draw_crc (draw-method-mmap-wc)
[163.504633] Starting subtest: draw-method-mmap-wc
[163.506938] Starting dynamic subtest: xrgb8888-untiled
[163.747170] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[163.756151] Starting dynamic subtest: rgb565-untiled
[163.991878] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[164.001410] Starting dynamic subtest: xrgb2101010-untiled
[164.215905] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[164.223792] Starting dynamic subtest: xbgr16161616f-untiled
[164.424608] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[164.432875] Starting dynamic subtest: xrgb8888-xtiled
[164.558144] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[164.567499] Starting dynamic subtest: rgb565-xtiled
[164.691146] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[164.700302] Starting dynamic subtest: xrgb2101010-xtiled
[164.813086] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[164.820736] Starting dynamic subtest: xbgr16161616f-xtiled
[164.936320] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[164.943375] Starting dynamic subtest: xrgb8888-4tiled
[165.091173] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[165.100202] Starting dynamic subtest: rgb565-4tiled
[165.224470] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[165.232654] Starting dynamic subtest: xrgb2101010-4tiled
[165.369016] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[165.377023] Starting dynamic subtest: xbgr16161616f-4tiled
[165.547303] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[165.549644] Subtest draw-method-mmap-wc: SUCCESS (2.045s)
[165.651628] [017/133] (847s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[165.757577] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[172.448741] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.693s)
[172.576494] [018/133] (840s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[172.685810] Starting subtest: psr-rgb565-draw-mmap-cpu
[179.470048] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.789s)
[179.577544] [019/133] (833s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[179.675719] Starting subtest: multiplane-rotation-cropping-bottom
[197.088278] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.416s)
[197.211370] [020/133] (816s left) gem_exec_params (secure-non-root)
[197.272560] Starting subtest: secure-non-root
[197.276167] Subtest secure-non-root: SKIP (0.000s)
[197.365391] [021/133] (816s left) gem_exec_schedule (smoketest)
[197.542089] Starting subtest: smoketest
[197.544311] Starting dynamic subtest: rcs0
[203.080994] Dynamic subtest rcs0: SUCCESS (5.490s)
[203.094362] Starting dynamic subtest: bcs0
[208.582647] Dynamic subtest bcs0: SUCCESS (5.500s)
[208.595057] Starting dynamic subtest: vcs0
[214.081504] Dynamic subtest vcs0: SUCCESS (5.497s)
[214.094636] Starting dynamic subtest: vcs1
[219.596687] Dynamic subtest vcs1: SUCCESS (5.515s)
[219.606050] Starting dynamic subtest: vecs0
[225.095096] Dynamic subtest vecs0: SUCCESS (5.495s)
[225.105256] Starting dynamic subtest: ccs0
[230.602654] Dynamic subtest ccs0: SUCCESS (5.509s)
[230.604663] Subtest smoketest: SUCCESS (33.014s)
[230.787489] [022/133] (782s left) kms_psr (fbc-psr-primary-render)
[230.883867] Starting subtest: fbc-psr-primary-render
[230.886159] Starting dynamic subtest: eDP-1
[230.890420] Dynamic subtest eDP-1: SKIP (0.000s)
[230.894768] Subtest fbc-psr-primary-render: SKIP (0.001s)
[230.958322] [023/133] (782s left) kms_pm_dc (dc3co-vpb-simulation)
[232.065715] Starting subtest: dc3co-vpb-simulation
[240.635034] Subtest dc3co-vpb-simulation: SKIP (8.567s)
[240.760327] [024/133] (772s left) gem_exec_whisper (basic-fds-all)
[240.830426] Starting subtest: basic-fds-all
[252.054558] Subtest basic-fds-all: SUCCESS (11.223s)
[252.241636] [025/133] (761s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[252.339219] Starting subtest: fbc-rgb565-draw-blt
[256.437052] Subtest fbc-rgb565-draw-blt: SUCCESS (4.101s)
[257.642737] [026/133] (756s left) prime_vgem (fence-flip-hang)
[257.737775] Subtest fence-flip-hang: SKIP (0.000s)
[257.836170] [027/133] (756s left) gem_pwrite (basic-random)
[257.889241] Subtest basic-random: SKIP (0.000s)
[257.943627] [028/133] (755s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[258.000402] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[258.004871] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[258.184385] [029/133] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[258.277390] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[265.348258] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.073s)
[265.486073] [030/133] (748s left) kms_flip (wf_vblank-ts-check-interruptible)
[265.589637] Starting subtest: wf_vblank-ts-check-interruptible
[265.591548] Starting dynamic subtest: A-eDP1
[274.459585] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[274.468317] Starting dynamic subtest: B-eDP1
[283.389519] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[283.399987] Starting dynamic subtest: C-eDP1
[292.314594] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[292.326436] Starting dynamic subtest: D-eDP1
[301.250690] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[301.255561] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.661s)
[302.394462] [031/133] (711s left) perf (gen12-unprivileged-single-ctx-counters)
[302.520057] Starting subtest: gen12-unprivileged-single-ctx-counters
[302.522347] Starting dynamic subtest: rcs0
[302.555252] Dynamic subtest rcs0: SUCCESS (0.035s)
[302.557436] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.036s)
[302.604074] [032/133] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[302.716305] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[302.720686] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[302.819329] [033/133] (711s left) kms_big_fb (linear-32bpp-rotate-0)
[302.924951] Starting subtest: linear-32bpp-rotate-0
[304.404434] Subtest linear-32bpp-rotate-0: SUCCESS (1.478s)
[304.562640] [034/133] (709s left) gem_exec_async (concurrent-writes)
[304.625883] Starting subtest: concurrent-writes
[304.628071] Starting dynamic subtest: rcs0
[304.643863] Dynamic subtest rcs0: SUCCESS (0.018s)
[304.654168] Starting dynamic subtest: bcs0
[304.655711] Dynamic subtest bcs0: SUCCESS (0.006s)
[304.664164] Starting dynamic subtest: vcs0
[304.665968] Dynamic subtest vcs0: SUCCESS (0.005s)
[304.673837] Starting dynamic subtest: vcs1
[304.675657] Dynamic subtest vcs1: SUCCESS (0.008s)
[304.683261] Starting dynamic subtest: vecs0
[304.684788] Dynamic subtest vecs0: SUCCESS (0.005s)
[304.692193] Starting dynamic subtest: ccs0
[304.693720] Dynamic subtest ccs0: SUCCESS (0.005s)
[304.695249] Subtest concurrent-writes: SUCCESS (0.051s)
[304.916864] [035/133] (709s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[305.025183] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[312.304350] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.280s)
[312.420507] [036/133] (701s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[312.542681] Starting subtest: plane-lut1d-ctm3x4
[312.667484] Starting dynamic subtest: pipe-A-plane-0
[312.833885] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[312.842886] Starting dynamic subtest: pipe-A-plane-1
[312.978291] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[312.987036] Starting dynamic subtest: pipe-A-plane-2
[313.167298] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[314.322286] Starting dynamic subtest: pipe-B-plane-0
[314.515864] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[314.524983] Starting dynamic subtest: pipe-B-plane-1
[314.682150] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[314.690714] Starting dynamic subtest: pipe-B-plane-2
[314.849111] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[316.044215] Starting dynamic subtest: pipe-C-plane-0
[316.171246] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[316.179906] Starting dynamic subtest: pipe-C-plane-1
[316.315530] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[316.324207] Starting dynamic subtest: pipe-C-plane-2
[316.471462] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[317.695295] Starting dynamic subtest: pipe-D-plane-0
[317.824374] Dynamic subtest pipe-D-plane-0: SUCCESS (0.143s)
[317.833089] Starting dynamic subtest: pipe-D-plane-1
[317.992203] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[318.001585] Starting dynamic subtest: pipe-D-plane-2
[318.135633] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[318.437875] Subtest plane-lut1d-ctm3x4: SUCCESS (5.896s)
[319.249050] [037/133] (695s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[319.350336] Starting subtest: y-tiled-16bpp-rotate-270
[319.354632] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[319.447730] [038/133] (694s left) kms_properties (plane-properties-legacy)
[319.551341] Starting subtest: plane-properties-legacy
[319.553588] Starting dynamic subtest: pipe-A-eDP-1
[320.122197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[320.131477] Starting dynamic subtest: pipe-B-eDP-1
[321.457390] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.331s)
[321.466201] Starting dynamic subtest: pipe-C-eDP-1
[322.761049] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s)
[322.770626] Starting dynamic subtest: pipe-D-eDP-1
[323.994218] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[323.996932] Subtest plane-properties-legacy: SUCCESS (4.443s)
[324.795264] [039/133] (689s left) gem_exec_reloc (basic-write-read-noreloc)
[324.860276] Subtest basic-write-read-noreloc: SKIP (0.000s)
[324.927457] [040/133] (689s left) sw_sync (sync_multi_timeline_wait)
[324.963324] Starting subtest: sync_multi_timeline_wait
[324.965686] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[325.023935] [041/133] (689s left) kms_plane_scaling (planes-upscale-20x20)
[325.112216] Starting subtest: planes-upscale-20x20
[325.114434] Starting dynamic subtest: pipe-A
[325.172443] Dynamic subtest pipe-A: SUCCESS (0.062s)
[325.181672] Starting dynamic subtest: pipe-B
[326.323611] Dynamic subtest pipe-B: SUCCESS (1.149s)
[326.333690] Starting dynamic subtest: pipe-C
[327.439424] Dynamic subtest pipe-C: SUCCESS (1.115s)
[327.448594] Starting dynamic subtest: pipe-D
[328.564653] Dynamic subtest pipe-D: SUCCESS (1.124s)
[328.567093] Subtest planes-upscale-20x20: SUCCESS (3.455s)
[329.739465] [042/133] (684s left) perf_pmu (busy-idle-check-all)
[329.782441] Starting subtest: busy-idle-check-all
[329.784468] Starting dynamic subtest: rcs0
[330.431896] Dynamic subtest rcs0: SUCCESS (0.651s)
[330.448843] Starting dynamic subtest: bcs0
[331.082586] Dynamic subtest bcs0: SUCCESS (0.649s)
[331.093629] Starting dynamic subtest: vcs0
[332.886085] Dynamic subtest vcs0: SUCCESS (1.799s)
[332.897898] Starting dynamic subtest: vcs1
[334.933492] Dynamic subtest vcs1: SUCCESS (2.045s)
[334.946693] Starting dynamic subtest: vecs0
[336.917649] Dynamic subtest vecs0: SUCCESS (1.981s)
[336.927041] Starting dynamic subtest: ccs0
[337.577654] Dynamic subtest ccs0: SUCCESS (0.659s)
[337.580200] Subtest busy-idle-check-all: SUCCESS (7.798s)
[337.673607] [043/133] (676s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[337.780658] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[337.784802] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[337.866313] [044/133] (676s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[338.083514] Starting subtest: cursor-rapid-movement-128x128
[338.088409] Starting dynamic subtest: pipe-A-eDP-1
[338.643046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[338.674778] Starting dynamic subtest: pipe-D-eDP-1
[339.853655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.185s)
[339.856086] Subtest cursor-rapid-movement-128x128: SUCCESS (1.770s)
[340.713482] [045/133] (673s left) sw_sync (timeline_closed_signaled)
[340.763075] Starting subtest: timeline_closed_signaled
[340.765364] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[340.826245] [046/133] (673s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[340.927869] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[340.931983] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[341.032739] [047/133] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[341.120436] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[341.124780] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[341.217478] [048/133] (673s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[341.309956] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[341.314433] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[341.395423] [049/133] (673s left) kms_psr (psr-cursor-plane-move)
[341.482272] Starting subtest: psr-cursor-plane-move
[341.484546] Starting dynamic subtest: eDP-1
[343.191316] Dynamic subtest eDP-1: SUCCESS (1.708s)
[343.193655] Subtest psr-cursor-plane-move: SUCCESS (1.710s)
[344.073097] [050/133] (670s left) gem_exec_schedule (pi-distinct-iova)
[344.256443] Starting subtest: pi-distinct-iova
[344.258487] Starting dynamic subtest: rcs0
[344.329869] Dynamic subtest rcs0: SUCCESS (0.075s)
[344.342924] Starting dynamic subtest: vcs0
[344.390531] Dynamic subtest vcs0: SUCCESS (0.061s)
[344.400341] Starting dynamic subtest: vcs1
[344.448808] Dynamic subtest vcs1: SUCCESS (0.057s)
[344.460700] Starting dynamic subtest: vecs0
[344.516533] Dynamic subtest vecs0: SUCCESS (0.067s)
[344.527814] Starting dynamic subtest: ccs0
[344.583303] Dynamic subtest ccs0: SUCCESS (0.065s)
[344.585854] Subtest pi-distinct-iova: SUCCESS (0.330s)
[346.058381] [051/133] (668s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[346.442643] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[347.258334] [052/133] (667s left) i915_drm_fdinfo (busy-check-all)
[347.295912] Starting subtest: busy-check-all
[347.298415] Starting dynamic subtest: rcs0
[347.303232] Dynamic subtest rcs0: SKIP (0.003s)
[347.314197] Starting dynamic subtest: bcs0
[347.318438] Dynamic subtest bcs0: SKIP (0.000s)
[347.326989] Starting dynamic subtest: vcs0
[347.331423] Dynamic subtest vcs0: SKIP (0.000s)
[347.339812] Starting dynamic subtest: vcs1
[347.344235] Dynamic subtest vcs1: SKIP (0.000s)
[347.352485] Starting dynamic subtest: vecs0
[347.356925] Dynamic subtest vecs0: SKIP (0.000s)
[347.365345] Starting dynamic subtest: ccs0
[347.369824] Dynamic subtest ccs0: SKIP (0.000s)
[347.374241] Subtest busy-check-all: SKIP (0.009s)
[347.412829] [053/133] (667s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[347.535730] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[347.540217] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[347.608273] [054/133] (667s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[347.666962] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[347.671177] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[347.852456] [055/133] (667s left) gem_linear_blits (basic)
[348.225959] Starting subtest: basic
[348.231996] Subtest basic: SUCCESS (0.006s)
[348.376208] [056/133] (666s left) gem_wait (invalid-flags)
[348.473412] Starting subtest: invalid-flags
[348.475668] Subtest invalid-flags: SUCCESS (0.000s)
[348.718408] [057/133] (666s left) gem_exec_balancer (parallel-out-fence)
[348.970015] Starting subtest: parallel-out-fence
[350.070261] Subtest parallel-out-fence: SUCCESS (1.100s)
[350.183369] [058/133] (664s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[350.239717] Subtest writes-after-reads: SKIP (0.000s)
[350.312748] [059/133] (664s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[350.441294] Starting subtest: cursorB-vs-flipB-toggle
[350.445561] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[350.586211] [060/133] (664s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[350.648180] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[350.716103] [061/133] (664s left) gem_softpin (allocator-nopin)
[350.766234] Starting subtest: allocator-nopin
[350.868380] Subtest allocator-nopin: SUCCESS (0.102s)
[351.003591] [062/133] (664s left) gen7_exec_parse (batch-without-end)
[351.065052] Subtest batch-without-end: SKIP (0.000s)
[351.129469] [063/133] (664s left) kms_flip (flip-vs-suspend)
[351.217386] Starting subtest: flip-vs-suspend
[351.219920] Starting dynamic subtest: A-eDP1
[386.331360] Dynamic subtest A-eDP1: SUCCESS (5.119s)
[386.341573] Starting dynamic subtest: B-eDP1
[420.335235] Dynamic subtest B-eDP1: SUCCESS (4.189s)
[420.345663] Starting dynamic subtest: C-eDP1
[454.330696] Dynamic subtest C-eDP1: SUCCESS (4.199s)
[454.341720] Starting dynamic subtest: D-eDP1
[488.327222] Dynamic subtest D-eDP1: SUCCESS (4.141s)
[488.329936] Subtest flip-vs-suspend: SUCCESS (17.657s)
[499.538717] [064/133] (525s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[499.645626] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[499.648108] Starting dynamic subtest: pipe-A-eDP-1
[499.674158] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.686825] Starting dynamic subtest: pipe-B-eDP-1
[499.714283] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.724074] Starting dynamic subtest: pipe-C-eDP-1
[499.752478] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.761798] Starting dynamic subtest: pipe-D-eDP-1
[499.790491] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.795584] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[501.885185] [065/133] (523s left) gem_ctx_engines (invalid-engines)
[501.944870] Starting subtest: invalid-engines
[501.953241] Subtest invalid-engines: SUCCESS (0.008s)
[502.169821] [066/133] (523s left) kms_atomic_transition (plane-toggle-modeset-transition)
[502.266453] Starting subtest: plane-toggle-modeset-transition
[502.268918] Starting dynamic subtest: pipe-A-eDP-1
[515.038706] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.763s)
[515.051613] Starting dynamic subtest: pipe-B-eDP-1
[527.489204] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.443s)
[527.492264] Subtest plane-toggle-modeset-transition: SUCCESS (25.212s)
[528.305909] [067/133] (497s left) kms_psr (fbc-pr-sprite-plane-onoff)
[528.400813] Starting subtest: fbc-pr-sprite-plane-onoff
[528.406143] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[528.474993] [068/133] (497s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[528.582399] Starting subtest: fbcpsr-rgb565-draw-pwrite
[535.578166] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.999s)
[535.703339] [069/133] (489s left) gem_ccs (ctrl-surf-copy)
[535.761109] Starting subtest: ctrl-surf-copy
[535.766355] Subtest ctrl-surf-copy: SKIP (0.000s)
[535.854928] [070/133] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[535.955068] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[535.959590] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[536.038694] [071/133] (489s left) prime_vgem (fence-write-hang)
[536.115025] Subtest fence-write-hang: SKIP (0.000s)
[536.206593] [072/133] (489s left) syncobj_timeline (invalid-signal-zero-handles)
[536.272446] Starting subtest: invalid-signal-zero-handles
[536.275425] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[536.370002] [073/133] (489s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[536.462138] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[536.466767] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[536.535648] [074/133] (489s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[536.629374] Starting subtest: psr-2p-pri-indfb-multidraw
[536.633361] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[536.711232] [075/133] (489s left) kms_pipe_crc_basic (suspend-read-crc)
[536.795164] Starting subtest: suspend-read-crc
[536.797055] Starting dynamic subtest: pipe-A-eDP-1
[555.226495] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.926s)
[555.238080] Starting dynamic subtest: pipe-B-eDP-1
[574.252456] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.505s)
[574.263288] Starting dynamic subtest: pipe-C-eDP-1
[593.186779] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.529s)
[593.197751] Starting dynamic subtest: pipe-D-eDP-1
[612.159335] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.417s)
[612.161633] Subtest suspend-read-crc: SUCCESS (13.383s)
[623.034501] [076/133] (412s left) dumb_buffer (invalid-bpp)
[623.095885] Starting subtest: invalid-bpp
[623.098275] Subtest invalid-bpp: SUCCESS (0.000s)
[623.205660] [077/133] (412s left) kms_plane (plane-position-hole-dpms)
[623.306008] Starting subtest: plane-position-hole-dpms
[623.839275] Starting dynamic subtest: pipe-A-plane-1
[626.190173] Dynamic subtest pipe-A-plane-1: SUCCESS (2.350s)
[626.201054] Starting dynamic subtest: pipe-A-plane-2
[628.559720] Dynamic subtest pipe-A-plane-2: SUCCESS (2.368s)
[628.570604] Starting dynamic subtest: pipe-A-plane-3
[630.925231] Dynamic subtest pipe-A-plane-3: SUCCESS (2.359s)
[630.936536] Starting dynamic subtest: pipe-A-plane-4
[633.300422] Dynamic subtest pipe-A-plane-4: SUCCESS (2.367s)
[633.310582] Starting dynamic subtest: pipe-A-plane-5
[633.324277] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[634.494879] Starting dynamic subtest: pipe-B-plane-1
[636.914295] Dynamic subtest pipe-B-plane-1: SUCCESS (2.423s)
[636.924308] Starting dynamic subtest: pipe-B-plane-2
[639.306070] Dynamic subtest pipe-B-plane-2: SUCCESS (2.389s)
[639.315886] Starting dynamic subtest: pipe-B-plane-3
[641.659542] Dynamic subtest pipe-B-plane-3: SUCCESS (2.352s)
[641.670381] Starting dynamic subtest: pipe-B-plane-4
[644.035374] Dynamic subtest pipe-B-plane-4: SUCCESS (2.373s)
[644.047673] Starting dynamic subtest: pipe-B-plane-5
[644.062264] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[644.064565] Subtest plane-position-hole-dpms: SUCCESS (20.734s)
[644.836313] [078/133] (391s left) gem_exec_create (madvise)
[644.906349] Starting subtest: madvise
[644.908692] Starting dynamic subtest: smem
[665.071545] Dynamic subtest smem: SUCCESS (20.155s)
[665.074588] Subtest madvise: SUCCESS (20.156s)
[666.247729] [079/133] (369s left) i915_module_load (reload-no-display)
[666.288093] Starting subtest: reload-no-display
[670.713018] Subtest reload-no-display: SUCCESS (4.426s)
[670.743365] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[670.744054] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[670.747200] [080/133] (365s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[672.309209] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[672.311490] Starting dynamic subtest: pipe-A-eDP-1
[672.439794] Dynamic subtest pipe-A-eDP-1: SKIP (0.133s)
[672.449655] Starting dynamic subtest: pipe-B-eDP-1
[673.633388] Dynamic subtest pipe-B-eDP-1: SKIP (1.191s)
[673.638058] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.327s)
[674.858271] [FACT kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[674.859462] [FACT kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)] new: kernel.kmod_is_loaded.i915: true
[674.863609] [081/133] (361s left) prime_vgem (coherency-blt)
[674.950350] Starting subtest: coherency-blt
[676.076509] Subtest coherency-blt: SUCCESS (1.125s)
[676.208752] [082/133] (360s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[676.330971] Starting subtest: x-tiled-64bpp-rotate-180
[677.965780] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.634s)
[678.130192] [083/133] (358s left) gem_exec_balancer (indices)
[678.199234] Starting subtest: indices
[680.236026] Subtest indices: SUCCESS (2.035s)
[680.534567] [084/133] (355s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[680.627035] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[680.629257] Starting dynamic subtest: pipe-A-eDP-1
[681.140893] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.485s)
[681.150540] Starting dynamic subtest: pipe-B-eDP-1
[682.591046] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[682.602585] Starting dynamic subtest: pipe-C-eDP-1
[683.944607] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s)
[683.956395] Starting dynamic subtest: pipe-D-eDP-1
[685.290697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[685.292888] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.636s)
[686.479318] [085/133] (349s left) kms_sequence (queue-idle)
[686.573302] Starting subtest: queue-idle
[686.575705] Starting dynamic subtest: pipe-A-eDP-1
[688.391069] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[688.401168] Starting dynamic subtest: pipe-B-eDP-1
[690.850543] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[690.861820] Starting dynamic subtest: pipe-C-eDP-1
[693.374526] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.519s)
[693.388626] Starting dynamic subtest: pipe-D-eDP-1
[695.785420] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.412s)
[695.787728] Subtest queue-idle: SUCCESS (9.213s)
[696.593771] [086/133] (339s left) api_intel_bb (simple-bb)
[696.653359] Starting subtest: simple-bb
[696.658018] Subtest simple-bb: SUCCESS (0.006s)
[696.750151] [087/133] (339s left) gem_watchdog (default-physical)
[696.819625] Starting subtest: default-physical
[698.574435] Subtest default-physical: SUCCESS (1.766s)
[698.688460] [088/133] (337s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[698.789876] Starting subtest: fbc-pr-cursor-mmap-cpu
[698.794228] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[698.866873] [089/133] (337s left) kms_cursor_crc (cursor-sliding-256x85)
[699.127696] Starting subtest: cursor-sliding-256x85
[699.173162] Subtest cursor-sliding-256x85: SKIP (0.042s)
[699.333126] [090/133] (337s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[699.431104] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[700.454337] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.022s)
[700.565252] [091/133] (336s left) kms_lease (lease-again)
[700.676039] Starting subtest: lease-again
[700.677860] Starting dynamic subtest: pipe-A-eDP-1
[700.679429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[700.689005] Starting dynamic subtest: pipe-B-eDP-1
[700.690754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[700.700038] Starting dynamic subtest: pipe-C-eDP-1
[700.701743] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[700.710646] Starting dynamic subtest: pipe-D-eDP-1
[700.712442] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[700.714424] Subtest lease-again: SUCCESS (0.013s)
[700.800494] [092/133] (335s left) kms_prop_blob (invalid-get-prop)
[700.847801] Starting subtest: invalid-get-prop
[700.849652] Subtest invalid-get-prop: SUCCESS (0.000s)
[700.948769] [093/133] (335s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[701.038141] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[701.041774] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[701.140680] [094/133] (335s left) gem_mmap_gtt (hang-busy)
[701.187114] Subtest hang-busy: SKIP (0.000s)
[701.246703] [095/133] (335s left) kms_flip (2x-modeset-vs-vblank-race)
[701.341602] Starting subtest: 2x-modeset-vs-vblank-race
[701.353010] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[701.459563] [096/133] (335s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[701.560379] Starting subtest: 4-tiled-64bpp-rotate-0
[703.189826] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.628s)
[703.369545] [097/133] (333s left) kms_addfb_basic (basic)
[703.430170] Starting subtest: basic
[703.432407] Subtest basic: SUCCESS (0.000s)
[703.566618] [098/133] (333s left) gem_reg_read (timestamp-monotonic)
[703.643039] Starting subtest: timestamp-monotonic
[708.371870] Subtest timestamp-monotonic: SUCCESS (4.726s)
[708.447191] [099/133] (328s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[708.539959] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[708.543956] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[708.616426] [100/133] (328s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[708.704736] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[708.707038] Starting dynamic subtest: pipe-A-eDP-1
[708.728239] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[708.739064] Starting dynamic subtest: pipe-B-eDP-1
[708.759500] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[708.768099] Starting dynamic subtest: pipe-C-eDP-1
[708.788569] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[708.797213] Starting dynamic subtest: pipe-D-eDP-1
[708.817638] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[708.821679] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[710.950057] [101/133] (326s left) kms_properties (invalid-properties-legacy)
[711.047652] Starting subtest: invalid-properties-legacy
[711.153345] Subtest invalid-properties-legacy: SUCCESS (0.106s)
[711.237282] [102/133] (325s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[711.299166] Starting subtest: multi-wait-available-unsubmitted-submitted
[711.301445] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[711.417543] [103/133] (325s left) kms_properties (crtc-properties-atomic)
[711.505206] Starting subtest: crtc-properties-atomic
[711.507506] Starting dynamic subtest: pipe-A-eDP-1
[711.937408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[711.948045] Starting dynamic subtest: pipe-B-eDP-1
[713.106693] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[713.118018] Starting dynamic subtest: pipe-C-eDP-1
[714.225802] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[714.235563] Starting dynamic subtest: pipe-D-eDP-1
[715.359494] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[715.361697] Subtest crtc-properties-atomic: SUCCESS (3.853s)
[716.195626] [104/133] (320s left) i915_pm_rps (min-max-config-idle)
[716.252015] Starting subtest: min-max-config-idle
[716.256383] Subtest min-max-config-idle: SKIP (0.001s)
[716.342120] [105/133] (320s left) gem_softpin (evict-active-interruptible)
[716.399612] Starting subtest: evict-active-interruptible
[716.405700] Subtest evict-active-interruptible: SUCCESS (0.006s)
[716.493216] [106/133] (320s left) gem_exec_schedule (fairslice)
[716.560807] Starting subtest: fairslice
[716.562755] Starting dynamic subtest: rcs0
[718.576551] Dynamic subtest rcs0: SUCCESS (2.020s)
[718.586778] Starting dynamic subtest: bcs0
[720.593104] Dynamic subtest bcs0: SUCCESS (2.017s)
[720.604281] Starting dynamic subtest: vcs0
[722.614308] Dynamic subtest vcs0: SUCCESS (2.017s)
[722.624835] Starting dynamic subtest: vcs1
[724.633946] Dynamic subtest vcs1: SUCCESS (2.018s)
[724.644712] Starting dynamic subtest: vecs0
[726.653030] Dynamic subtest vecs0: SUCCESS (2.020s)
[726.664493] Starting dynamic subtest: ccs0
[728.670115] Dynamic subtest ccs0: SUCCESS (2.016s)
[728.672130] Subtest fairslice: SUCCESS (12.113s)
[728.967934] [107/133] (308s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[729.063101] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[729.065007] Starting dynamic subtest: pipe-A-eDP-1
[731.147644] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.084s)
[731.158678] Starting dynamic subtest: pipe-B-eDP-1
[733.496782] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.350s)
[733.506721] Starting dynamic subtest: pipe-C-eDP-1
[735.582203] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.086s)
[735.597005] Starting dynamic subtest: pipe-D-eDP-1
[737.616926] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.034s)
[737.618817] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.559s)
[738.832020] [108/133] (298s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[738.937704] Starting subtest: addfb25-y-tiled-legacy
[738.939671] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[739.036885] [109/133] (298s left) kms_psr (fbc-psr-suspend)
[739.133763] Starting subtest: fbc-psr-suspend
[739.136045] Starting dynamic subtest: eDP-1
[739.140160] Dynamic subtest eDP-1: SKIP (0.000s)
[739.144321] Subtest fbc-psr-suspend: SKIP (0.001s)
[739.209545] [110/133] (298s left) gem_ctx_persistence (legacy-engines-persistence)
[739.266417] Starting subtest: legacy-engines-persistence
[739.268651] Starting dynamic subtest: render
[740.039746] Dynamic subtest render: SUCCESS (0.772s)
[740.054306] Starting dynamic subtest: bsd1
[740.807961] Dynamic subtest bsd1: SUCCESS (0.765s)
[740.823319] Starting dynamic subtest: bsd2
[741.555992] Dynamic subtest bsd2: SUCCESS (0.745s)
[741.567029] Starting dynamic subtest: blt
[742.351814] Dynamic subtest blt: SUCCESS (0.794s)
[742.366576] Starting dynamic subtest: vebox
[743.111943] Dynamic subtest vebox: SUCCESS (0.757s)
[743.114690] Subtest legacy-engines-persistence: SUCCESS (3.847s)
[743.194532] [111/133] (294s left) i915_suspend (basic-s2idle-without-i915)
[743.245961] Starting subtest: basic-s2idle-without-i915
[762.786332] Subtest basic-s2idle-without-i915: SUCCESS (4.456s)
[771.910728] [112/133] (274s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[772.026584] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[772.030916] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[772.123860] [113/133] (274s left) syncobj_basic (create-signaled)
[772.183743] Starting subtest: create-signaled
[772.185702] Subtest create-signaled: SUCCESS (0.000s)
[772.307833] [114/133] (274s left) gem_exec_params (cliprects-invalid)
[772.361547] Starting subtest: cliprects-invalid
[772.363776] Subtest cliprects-invalid: SUCCESS (0.000s)
[772.478156] [115/133] (274s left) kms_invalid_mode (overflow-vrefresh)
[772.576024] Starting subtest: overflow-vrefresh
[772.578373] Starting dynamic subtest: pipe-A-eDP-1
[772.861412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[772.875794] Starting dynamic subtest: pipe-B-eDP-1
[772.877649] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[772.889061] Starting dynamic subtest: pipe-C-eDP-1
[772.891227] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[772.899869] Starting dynamic subtest: pipe-D-eDP-1
[772.902167] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[772.904402] Subtest overflow-vrefresh: SUCCESS (0.294s)
[773.733576] [116/133] (272s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[773.862244] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[773.866405] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[774.007042] [117/133] (272s left) sysfs_timeslice_duration (invalid)
[774.059856] Starting subtest: invalid
[774.062078] Starting dynamic subtest: vecs0
[774.064414] Dynamic subtest vecs0: SUCCESS (0.000s)
[774.075431] Starting dynamic subtest: ccs0
[774.077732] Dynamic subtest ccs0: SUCCESS (0.000s)
[774.086020] Starting dynamic subtest: vcs0
[774.088157] Dynamic subtest vcs0: SUCCESS (0.000s)
[774.096519] Starting dynamic subtest: bcs0
[774.098611] Dynamic subtest bcs0: SUCCESS (0.000s)
[774.107361] Starting dynamic subtest: rcs0
[774.109262] Dynamic subtest rcs0: SUCCESS (0.000s)
[774.117891] Starting dynamic subtest: vcs1
[774.119955] Dynamic subtest vcs1: SUCCESS (0.000s)
[774.122144] Subtest invalid: SUCCESS (0.006s)
[774.186508] [118/133] (272s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[774.293686] Starting subtest: cursorA-vs-flipA-varying-size
[785.466210] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.179s)
[786.266570] [119/133] (260s left) kms_async_flips (crc-atomic)
[786.358201] Starting subtest: crc-atomic
[786.744072] Starting dynamic subtest: pipe-A-eDP-1
[789.686882] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.945s)
[790.072428] Starting dynamic subtest: pipe-B-eDP-1
[793.033564] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.971s)
[793.415009] Starting dynamic subtest: pipe-C-eDP-1
[796.335993] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.930s)
[796.707076] Starting dynamic subtest: pipe-D-eDP-1
[799.557991] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.858s)
[799.560302] Subtest crc-atomic: SUCCESS (13.201s)
[800.731912] [120/133] (246s left) gem_ctx_exec (basic-norecovery)
[800.798238] Starting subtest: basic-norecovery
[800.995755] Subtest basic-norecovery: SUCCESS (0.198s)
[801.115040] [121/133] (245s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[801.222671] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[804.849827] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.630s)
[806.042659] [122/133] (240s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[806.137767] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[806.141866] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[806.246745] [123/133] (240s left) syncobj_eventfd (timeline-wait-before-signal)
[806.305287] Starting subtest: timeline-wait-before-signal
[806.335018] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[806.427227] [124/133] (240s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[806.537230] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[806.541394] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[806.636863] [125/133] (240s left) gem_ctx_param (root-set)
[806.691549] Starting subtest: root-set
[806.693869] Subtest root-set: SUCCESS (0.002s)
[806.797050] [126/133] (240s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[806.896881] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[813.732387] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.840s)
[813.858456] [127/133] (233s left) gem_eio (hibernate)
[814.017276] Starting subtest: hibernate
[828.419469] Subtest hibernate: SUCCESS (14.401s)
[838.582509] [128/133] (218s left) kms_content_protection (dp-mst-lic-type-0)
[838.735277] Starting subtest: dp-mst-lic-type-0
[838.739934] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[838.849569] [129/133] (218s left) gem_exec_reloc (basic-write-cpu-noreloc)
[838.917646] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[839.003330] [130/133] (218s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[839.068136] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[839.070588] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[839.156618] [131/133] (218s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[839.249848] Starting subtest: fbc-dirtyfb-ioctl
[839.251994] Starting dynamic subtest: A-eDP-1
[841.896849] Dynamic subtest A-eDP-1: SUCCESS (2.645s)
[841.899132] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.646s)
[842.789947] [132/133] (214s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[842.894297] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[842.898240] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[842.995589] [133/133] (214s left) kms_vblank (query-forked-busy-hang)
[843.103970] Starting subtest: query-forked-busy-hang
[843.105800] Starting dynamic subtest: pipe-A-eDP-1
[869.245421] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.140s)
[869.261066] Starting dynamic subtest: pipe-D-eDP-1
[884.221657] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[884.224164] Subtest query-forked-busy-hang: SUCCESS (41.119s)
[885.054357] 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.