[58.979814] Initializing watchdogs
[58.979863]   /dev/watchdog0
[58.994155] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.998304] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.000407] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.004120] [001/132] (960s left) gem_pxp (create-regular-context-2)
[59.150920] Starting subtest: create-regular-context-2
[59.153584] Subtest create-regular-context-2: SUCCESS (0.003s)
[59.262625] [002/132] (960s left) gem_workarounds (reset-fd)
[59.339657] Starting subtest: reset-fd
[59.451877] Subtest reset-fd: SUCCESS (0.113s)
[59.581212] [003/132] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[59.686769] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[59.690838] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[59.775454] [004/132] (959s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[59.843142] Starting subtest: fbc-psr-sprite-mmap-gtt
[59.845148] Starting dynamic subtest: eDP-1
[59.848853] Dynamic subtest eDP-1: SKIP (0.000s)
[59.852600] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[59.910739] [005/132] (959s left) gem_create (create-ext-placement-each)
[60.077245] Starting subtest: create-ext-placement-each
[60.079596] Subtest create-ext-placement-each: SUCCESS (0.000s)
[60.179572] [006/132] (959s left) kms_rmfb (rmfb-ioctl)
[60.244646] Starting subtest: rmfb-ioctl
[60.246998] Starting dynamic subtest: pipe-A-eDP-1
[60.360661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.117s)
[60.370581] Starting dynamic subtest: pipe-B-eDP-1
[61.502870] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[61.513047] Starting dynamic subtest: pipe-C-eDP-1
[62.635577] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.137s)
[62.644717] Starting dynamic subtest: pipe-D-eDP-1
[63.780505] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s)
[63.782772] Subtest rmfb-ioctl: SUCCESS (3.556s)
[64.921925] [007/132] (954s left) gem_lmem_swapping (massive)
[64.964094] Subtest massive: SKIP (0.000s)
[65.006241] [008/132] (954s left) syncobj_timeline (wait-all-delayed-signal)
[65.058705] Starting subtest: wait-all-delayed-signal
[65.162996] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[65.248966] [009/132] (954s left) i915_pm_rc6_residency (rc6-idle)
[65.302063] Starting subtest: rc6-idle
[65.317102] Starting dynamic subtest: gt0-rcs0
[89.673348] Dynamic subtest gt0-rcs0: SUCCESS (24.376s)
[89.680567] Starting dynamic subtest: gt0-bcs0
[113.954927] Dynamic subtest gt0-bcs0: SUCCESS (24.279s)
[113.965450] Starting dynamic subtest: gt0-ccs0
[138.294500] Dynamic subtest gt0-ccs0: SUCCESS (24.338s)
[138.302768] Starting dynamic subtest: gt1-vcs0
[144.467882] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[144.478036] Starting dynamic subtest: gt1-vecs0
[150.641774] Dynamic subtest gt1-vecs0: SUCCESS (6.172s)
[150.644721] Subtest rc6-idle: SUCCESS (85.360s)
[150.718773] [010/132] (869s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[150.795999] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[150.800494] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[150.894313] [011/132] (868s left) gem_softpin (noreloc-s3)
[150.945135] Starting subtest: noreloc-S3
[171.063737] Subtest noreloc-S3: SUCCESS (5.398s)
[171.188920] [012/132] (848s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[171.299491] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[171.303741] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[171.391186] [013/132] (848s left) sysfs_heartbeat_interval (precise)
[171.449899] Starting subtest: precise
[171.452301] Starting dynamic subtest: vecs0
[178.688408] Dynamic subtest vecs0: SUCCESS (7.342s)
[178.713612] Starting dynamic subtest: ccs0
[181.257063] Dynamic subtest ccs0: SUCCESS (2.587s)
[181.266796] Starting dynamic subtest: vcs0
[188.668327] Dynamic subtest vcs0: SUCCESS (7.442s)
[188.687787] Starting dynamic subtest: bcs0
[189.888968] Dynamic subtest bcs0: SUCCESS (1.223s)
[189.899845] Starting dynamic subtest: rcs0
[191.017990] Dynamic subtest rcs0: SUCCESS (1.132s)
[191.027872] Starting dynamic subtest: vcs1
[198.661447] Dynamic subtest vcs1: SUCCESS (7.653s)
[198.663916] Subtest precise: SUCCESS (27.386s)
[198.740340] [014/132] (821s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[198.807509] Starting subtest: multi-wait-available-unsubmitted-submitted
[198.809843] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[198.894313] [015/132] (821s left) kms_rotation_crc (primary-rotation-180)
[198.971041] Starting subtest: primary-rotation-180
[205.884332] Subtest primary-rotation-180: SUCCESS (6.913s)
[207.055277] [016/132] (813s left) vgem_basic (dmabuf-fence)
[207.163858] Starting subtest: dmabuf-fence
[207.166081] Subtest dmabuf-fence: SUCCESS (0.001s)
[207.218953] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[207.222378] [017/132] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[207.303235] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[207.307735] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[207.401351] [018/132] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[207.485577] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[214.496028] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.015s)
[214.608936] [019/132] (805s left) syncobj_eventfd (timeline-wait-before-signal)
[214.666694] Starting subtest: timeline-wait-before-signal
[214.697796] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[214.778639] [020/132] (805s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[214.859901] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[214.863715] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[214.961023] [021/132] (805s left) kms_vblank (ts-continuation-dpms-suspend)
[215.037012] Starting subtest: ts-continuation-dpms-suspend
[215.039237] Starting dynamic subtest: pipe-A-eDP-1
[232.737799] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.912s)
[232.752962] Starting dynamic subtest: pipe-D-eDP-1
[250.730013] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[250.732930] Subtest ts-continuation-dpms-suspend: SUCCESS (4.477s)
[251.508569] [022/132] (768s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[251.591711] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[251.594276] Starting dynamic subtest: pipe-A-eDP-1
[251.752333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.157s)
[251.762886] Starting dynamic subtest: pipe-B-eDP-1
[251.785836] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[251.794879] Starting dynamic subtest: pipe-C-eDP-1
[251.817011] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s)
[251.825467] Starting dynamic subtest: pipe-D-eDP-1
[251.847773] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[251.849878] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.194s)
[254.019137] [023/132] (766s left) gem_mmap_wc (fault-concurrent)
[254.076960] Subtest fault-concurrent: SKIP (0.000s)
[254.135095] [024/132] (766s left) i915_module_load (resize-bar)
[254.172926] Starting subtest: resize-bar
[254.180862] Subtest resize-bar: SKIP (0.005s)
[254.224490] [025/132] (766s left) kms_fb_coherency (memset-crc)
[254.299408] Starting subtest: memset-crc
[254.301880] Starting dynamic subtest: mmap-offset-wc
[254.683661] Dynamic subtest mmap-offset-wc: SUCCESS (0.392s)
[254.979320] Starting dynamic subtest: mmap-offset-uc
[261.023614] Dynamic subtest mmap-offset-uc: SUCCESS (6.137s)
[261.314977] Subtest memset-crc: SUCCESS (7.111s)
[262.169750] [026/132] (758s left) gem_exec_params (no-bsd)
[262.228264] Starting subtest: no-bsd
[262.230974] Subtest no-bsd: SUCCESS (0.002s)
[264.066220] [027/132] (756s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[264.138935] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[264.141620] Starting dynamic subtest: pipe-A-eDP-1
[265.329195] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.198s)
[265.339966] Starting dynamic subtest: pipe-B-eDP-1
[267.611130] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.291s)
[267.621944] Starting dynamic subtest: pipe-C-eDP-1
[269.839027] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.235s)
[269.848539] Starting dynamic subtest: pipe-D-eDP-1
[272.064086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.230s)
[272.066969] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (7.959s)
[273.240914] [028/132] (747s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[273.340603] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[274.007945] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[274.187805] [029/132] (746s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[274.247941] Starting subtest: framebuffer-vs-set-tiling
[274.253089] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[274.370353] [030/132] (746s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[274.444933] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[274.449872] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[274.516825] [031/132] (746s left) kms_chamelium_frames (hdmi-crc-fast)
[274.890769] Subtest hdmi-crc-fast: SKIP (0.000s)
[275.666028] [032/132] (745s left) kms_frontbuffer_tracking (fbc-tiling-4)
[275.752076] Starting subtest: fbc-tiling-4
[279.970717] Subtest fbc-tiling-4: SUCCESS (4.230s)
[281.179912] [033/132] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[281.263829] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[281.268857] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[281.355299] [034/132] (739s left) gem_exec_params (sol-reset-invalid)
[281.412207] Starting subtest: sol-reset-invalid
[281.417683] Subtest sol-reset-invalid: SUCCESS (0.003s)
[283.029353] [035/132] (737s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[283.117417] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[283.122900] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[283.215880] [036/132] (737s left) kms_content_protection (suspend-resume)
[283.349901] Starting subtest: suspend-resume
[283.355209] Subtest suspend-resume: SKIP (0.000s)
[283.483266] [037/132] (737s left) kms_psr (psr-sprite-blt)
[283.562958] Starting subtest: psr-sprite-blt
[283.565878] Starting dynamic subtest: eDP-1
[285.303749] Dynamic subtest eDP-1: SUCCESS (1.739s)
[285.306434] Subtest psr-sprite-blt: SUCCESS (1.739s)
[286.147493] [038/132] (734s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[286.225102] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[286.227546] Starting dynamic subtest: pipe-A-eDP-1
[286.288312] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[286.297549] Starting dynamic subtest: pipe-B-eDP-1
[286.364858] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[286.375091] Starting dynamic subtest: pipe-C-eDP-1
[286.442309] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[286.452382] Starting dynamic subtest: pipe-D-eDP-1
[286.520749] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[286.525162] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[288.550096] [039/132] (732s left) prime_mmap (test_aperture_limit)
[288.598955] Starting subtest: test_aperture_limit
[288.601556] Starting dynamic subtest: test_aperture_limit-smem
[288.609811] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s)
[288.614852] Subtest test_aperture_limit: SKIP (0.011s)
[288.711282] [040/132] (732s left) intel_hwmon (hwmon-read)
[288.767144] Subtest hwmon-read: SKIP (0.000s)
[288.820370] [041/132] (732s left) kms_psr (pr-basic)
[288.886846] Starting subtest: pr-basic
[288.891419] Subtest pr-basic: SKIP (0.000s)
[288.958444] [042/132] (732s left) kms_big_fb (4-tiled-addfb-size-overflow)
[289.041078] Starting subtest: 4-tiled-addfb-size-overflow
[289.043967] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[289.125417] [043/132] (732s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[289.207881] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[289.210765] Starting dynamic subtest: pipe-A-eDP-1
[289.303064] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[289.314779] Starting dynamic subtest: pipe-B-eDP-1
[290.479033] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s)
[290.484244] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.276s)
[291.676692] [044/132] (729s left) kms_addfb_basic (no-handle)
[291.743908] Starting subtest: no-handle
[291.746503] Subtest no-handle: SUCCESS (0.000s)
[291.854495] [045/132] (729s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[291.921055] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[291.923943] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[292.029362] [046/132] (729s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[292.110866] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[299.761321] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.651s)
[300.902491] [047/132] (720s left) gem_softpin (allocator-evict)
[300.968160] Starting subtest: allocator-evict
[300.971015] Starting dynamic subtest: rcs0
[324.501636] Dynamic subtest rcs0: SUCCESS (23.533s)
[324.514177] Starting dynamic subtest: bcs0
[348.173545] Dynamic subtest bcs0: SUCCESS (23.674s)
[348.186195] Starting dynamic subtest: vcs0
[371.902133] Dynamic subtest vcs0: SUCCESS (23.722s)
[371.912579] Starting dynamic subtest: vcs1
[395.458009] Dynamic subtest vcs1: SUCCESS (23.555s)
[395.468670] Starting dynamic subtest: vecs0
[418.994169] Dynamic subtest vecs0: SUCCESS (23.537s)
[419.004902] Starting dynamic subtest: ccs0
[442.497465] Dynamic subtest ccs0: SUCCESS (23.506s)
[442.500144] Subtest allocator-evict: SUCCESS (141.532s)
[442.583469] [048/132] (578s left) gem_exec_balancer (waits)
[442.697840] Starting subtest: waits
[449.204312] Subtest waits: SUCCESS (6.506s)
[449.517339] [049/132] (571s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[449.599167] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[449.602054] Starting dynamic subtest: pipe-A-eDP-1
[449.629388] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[449.640855] Starting dynamic subtest: pipe-B-eDP-1
[449.668852] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[449.679662] Starting dynamic subtest: pipe-C-eDP-1
[449.705929] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[449.717657] Starting dynamic subtest: pipe-D-eDP-1
[449.743279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[449.748575] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[451.847820] [050/132] (569s left) gem_exec_fence (submit-chain)
[452.034772] Starting subtest: submit-chain
[452.063176] Subtest submit-chain: SUCCESS (0.031s)
[454.038781] [051/132] (567s left) gem_exec_fence (syncobj-unused-fence)
[454.459380] Starting subtest: syncobj-unused-fence
[454.466625] Subtest syncobj-unused-fence: SUCCESS (0.007s)
[456.013831] [052/132] (565s left) gem_exec_whisper (basic-contexts-priority)
[456.074406] Starting subtest: basic-contexts-priority
[479.371362] Subtest basic-contexts-priority: SUCCESS (23.293s)
[479.560791] [053/132] (542s left) kms_psr (psr2-sprite-mmap-cpu)
[479.637930] Starting subtest: psr2-sprite-mmap-cpu
[479.640743] Starting dynamic subtest: eDP-1
[481.341942] Dynamic subtest eDP-1: SUCCESS (1.703s)
[481.344490] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.704s)
[482.199302] [054/132] (539s left) kms_cursor_edge_walk (128x128-right-edge)
[482.278446] Starting subtest: 128x128-right-edge
[482.281038] Starting dynamic subtest: pipe-A-eDP-1
[485.763013] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.482s)
[485.774179] Starting dynamic subtest: pipe-D-eDP-1
[488.890050] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[488.893027] Subtest 128x128-right-edge: SUCCESS (6.610s)
[489.689336] [055/132] (532s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[489.764100] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[493.755972] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.995s)
[494.897500] [056/132] (526s left) gem_exec_schedule (timeslicing)
[494.971849] Starting subtest: timeslicing
[494.974157] Starting dynamic subtest: rcs0
[494.986392] Dynamic subtest rcs0: SUCCESS (0.022s)
[495.000638] Starting dynamic subtest: bcs0
[495.009710] Dynamic subtest bcs0: SUCCESS (0.023s)
[495.019985] Starting dynamic subtest: vcs0
[495.031972] Dynamic subtest vcs0: SUCCESS (0.022s)
[495.041992] Starting dynamic subtest: vcs1
[495.053519] Dynamic subtest vcs1: SUCCESS (0.021s)
[495.063154] Starting dynamic subtest: vecs0
[495.076946] Dynamic subtest vecs0: SUCCESS (0.023s)
[495.087397] Starting dynamic subtest: ccs0
[495.099663] Dynamic subtest ccs0: SUCCESS (0.022s)
[495.102182] Subtest timeslicing: SUCCESS (0.136s)
[497.007064] [057/132] (524s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[497.092928] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[498.061782] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.968s)
[498.187850] [058/132] (523s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[498.263923] Starting subtest: compare-crc-sanitycheck-nv12
[498.266268] Starting dynamic subtest: pipe-A-eDP-1
[498.960969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.694s)
[498.972488] Starting dynamic subtest: pipe-B-eDP-1
[500.294179] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.331s)
[500.304857] Starting dynamic subtest: pipe-C-eDP-1
[501.564123] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.271s)
[501.578131] Starting dynamic subtest: pipe-D-eDP-1
[502.769086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.202s)
[502.771944] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.504s)
[503.614612] [059/132] (518s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[503.704724] Starting subtest: primary-yf-tiled-reflect-x-180
[503.764066] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[503.874500] [060/132] (518s left) gem_media_vme
[504.002492] [061/132] (518s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[504.073919] Starting subtest: pixel-format-linear-modifier-source-clamping
[504.102371] Starting dynamic subtest: pipe-A-plane-0
[507.635715] Dynamic subtest pipe-A-plane-0: SUCCESS (3.533s)
[507.647524] Starting dynamic subtest: pipe-A-plane-3
[509.325593] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s)
[510.405836] Starting dynamic subtest: pipe-B-plane-0
[514.173055] Dynamic subtest pipe-B-plane-0: SUCCESS (3.778s)
[514.183815] Starting dynamic subtest: pipe-B-plane-3
[515.830391] Dynamic subtest pipe-B-plane-3: SUCCESS (1.654s)
[516.141292] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.062s)
[516.973921] [062/132] (505s left) api_intel_bb (intel-bb-blit-x)
[517.031932] Starting subtest: intel-bb-blit-x
[520.372517] Subtest intel-bb-blit-x: SUCCESS (3.342s)
[520.499143] [063/132] (501s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[520.574563] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[520.579611] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[520.667598] [064/132] (501s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[520.746278] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[520.750953] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[520.845961] [065/132] (501s left) kms_fbcon_fbt (fbc)
[520.904359] Starting subtest: fbc
[527.206973] Subtest fbc: SUCCESS (6.302s)
[528.288656] [066/132] (493s left) kms_prop_blob (invalid-get-prop)
[528.354844] Starting subtest: invalid-get-prop
[528.357587] Subtest invalid-get-prop: SUCCESS (0.000s)
[528.460626] [067/132] (493s left) kms_selftest (drm_damage_helper)
[528.503166] Starting subtest: drm_damage_helper
[528.544865] Starting dynamic subtest: drm_test_damage_iter_no_damage
[528.648793] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.102s)
[528.660180] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[528.733166] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.083s)
[528.754982] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[528.812992] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.080s)
[528.833834] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[528.904926] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.090s)
[528.927039] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[528.979540] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.074s)
[528.998081] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[529.070027] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.089s)
[529.080265] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[529.166280] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.095s)
[529.176591] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[529.243105] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.078s)
[529.253175] Starting dynamic subtest: drm_test_damage_iter_single_damage
[529.362164] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.116s)
[529.372621] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[529.453947] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.092s)
[529.464042] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[529.538074] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.082s)
[529.548306] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[529.629188] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.091s)
[529.639592] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[529.715898] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.086s)
[529.726431] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[529.802920] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.087s)
[529.814503] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[529.885087] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.081s)
[529.896435] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[529.986951] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.097s)
[529.997911] Starting dynamic subtest: drm_test_damage_iter_damage
[530.065997] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.081s)
[530.077395] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[530.156334] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.088s)
[530.167205] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[530.238151] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.081s)
[530.248756] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[530.322188] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.084s)
[530.333822] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[530.404932] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.083s)
[530.407582] Subtest drm_damage_helper: SUCCESS (1.904s)
[530.557757] [068/132] (491s left) kms_flip (2x-flip-vs-panning)
[530.634614] Starting subtest: 2x-flip-vs-panning
[530.642537] Subtest 2x-flip-vs-panning: SKIP (0.007s)
[530.734414] [069/132] (491s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[530.844016] Starting subtest: 2x-cursor-vs-flip-legacy
[530.848375] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[530.994949] [070/132] (491s left) kms_plane_lowres (tiling-x)
[531.070707] Starting subtest: tiling-x
[531.072628] Starting dynamic subtest: pipe-A-eDP-1
[531.076649] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[531.367411] Starting dynamic subtest: pipe-B-eDP-1
[531.372823] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[531.382982] Starting dynamic subtest: pipe-C-eDP-1
[531.387994] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[531.398274] Starting dynamic subtest: pipe-D-eDP-1
[531.403306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[531.408291] Subtest tiling-x: SKIP (0.293s)
[532.232956] [071/132] (490s left) perf_pmu (busy-idle)
[532.281411] Starting subtest: busy-idle
[532.284133] Starting dynamic subtest: rcs0
[532.974218] Dynamic subtest rcs0: SUCCESS (0.694s)
[532.993325] Starting dynamic subtest: bcs0
[533.647615] Dynamic subtest bcs0: SUCCESS (0.671s)
[533.662148] Starting dynamic subtest: vcs0
[534.983844] Dynamic subtest vcs0: SUCCESS (1.333s)
[534.997184] Starting dynamic subtest: vcs1
[536.968028] Dynamic subtest vcs1: SUCCESS (1.981s)
[536.982351] Starting dynamic subtest: vecs0
[538.950817] Dynamic subtest vecs0: SUCCESS (1.981s)
[538.961902] Starting dynamic subtest: ccs0
[539.626791] Dynamic subtest ccs0: SUCCESS (0.674s)
[539.629595] Subtest busy-idle: SUCCESS (7.348s)
[539.735627] [072/132] (482s left) syncobj_timeline (invalid-signal-illegal-handle)
[539.786955] Starting subtest: invalid-signal-illegal-handle
[539.789814] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[539.873258] [073/132] (482s left) gem_mmap_offset (perf)
[539.925691] Starting subtest: perf
[539.928101] Starting dynamic subtest: smem0
[540.344844] Dynamic subtest smem0: SUCCESS (0.418s)
[540.348079] Subtest perf: SUCCESS (0.419s)
[540.451972] [074/132] (482s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[540.521581] Starting subtest: plane-downscale-factor-0-5-with-rotation
[540.524015] Starting dynamic subtest: pipe-A
[540.543102] Dynamic subtest pipe-A: SKIP (0.017s)
[540.553583] Starting dynamic subtest: pipe-B
[540.573493] Dynamic subtest pipe-B: SKIP (0.030s)
[540.586325] Starting dynamic subtest: pipe-C
[540.605144] Dynamic subtest pipe-C: SKIP (0.029s)
[540.616061] Starting dynamic subtest: pipe-D
[540.633830] Dynamic subtest pipe-D: SKIP (0.029s)
[540.638985] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.106s)
[540.730927] [075/132] (481s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[540.808670] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[545.112444] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.308s)
[546.253080] [076/132] (476s left) gen7_exec_parse (basic-offset)
[546.337148] Subtest basic-offset: SKIP (0.000s)
[546.414751] [077/132] (476s left) i915_drm_fdinfo (memory-info-active)
[546.461233] Starting subtest: memory-info-active
[546.464062] Starting dynamic subtest: smem0
[549.358602] Dynamic subtest smem0: SUCCESS (2.900s)
[549.361590] Subtest memory-info-active: SUCCESS (2.901s)
[549.439788] [078/132] (473s left) kms_cursor_crc (cursor-random-256x85)
[549.696495] Starting subtest: cursor-random-256x85
[549.744963] Subtest cursor-random-256x85: SKIP (0.043s)
[549.901187] [079/132] (472s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[549.991915] Starting subtest: 2x-long-flip-vs-cursor-atomic
[549.995786] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[550.137748] [080/132] (472s left) perf_pmu (busy-accuracy-50)
[550.179460] Starting subtest: busy-accuracy-50
[550.181596] Starting dynamic subtest: rcs0
[551.715030] Dynamic subtest rcs0: SUCCESS (1.535s)
[551.729047] Starting dynamic subtest: bcs0
[553.255650] Dynamic subtest bcs0: SUCCESS (1.538s)
[553.268374] Starting dynamic subtest: vcs0
[554.798175] Dynamic subtest vcs0: SUCCESS (1.541s)
[554.811152] Starting dynamic subtest: vcs1
[556.342968] Dynamic subtest vcs1: SUCCESS (1.543s)
[556.355900] Starting dynamic subtest: vecs0
[557.888134] Dynamic subtest vecs0: SUCCESS (1.542s)
[557.900882] Starting dynamic subtest: ccs0
[559.432852] Dynamic subtest ccs0: SUCCESS (1.542s)
[559.436383] Subtest busy-accuracy-50: SUCCESS (9.255s)
[559.548091] [081/132] (463s left) syncobj_wait (wait-for-submit-delayed-submit)
[559.608703] Starting subtest: wait-for-submit-delayed-submit
[559.710888] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[559.794673] [082/132] (463s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[559.883602] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[559.888810] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[559.977641] [083/132] (462s left) kms_psr2_su (page_flip-p010)
[560.033705] Subtest page_flip-P010: SKIP (0.000s)
[560.090367] [084/132] (462s left) gem_userptr_blits (forbidden-operations)
[560.158391] Starting subtest: forbidden-operations
[560.162881] Subtest forbidden-operations: SKIP (0.000s)
[560.271092] [085/132] (462s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[560.330871] Starting subtest: map-fixed-invalidate-overlap-busy
[560.335469] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[560.449459] [086/132] (462s left) gem_eio (in-flight-contexts-10ms)
[560.632549] Starting subtest: in-flight-contexts-10ms
[573.976570] Subtest in-flight-contexts-10ms: SUCCESS (13.342s)
[574.125698] [087/132] (448s left) syncobj_timeline (etime-single-wait-submitted)
[574.191167] Starting subtest: etime-single-wait-submitted
[574.292475] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[574.373095] [088/132] (448s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[574.492909] Starting subtest: cursorA-vs-flipA-atomic-transitions
[585.704596] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.215s)
[586.578777] [089/132] (436s left) kms_pm_rpm (fences)
[588.094068] Starting subtest: fences
[588.099710] Subtest fences: SKIP (0.000s)
[588.824274] [090/132] (434s left) syncobj_wait (invalid-wait-illegal-handle)
[588.886164] Starting subtest: invalid-wait-illegal-handle
[588.888959] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[588.977925] [091/132] (434s left) kms_cursor_crc (cursor-offscreen-32x32)
[589.103161] Starting subtest: cursor-offscreen-32x32
[589.151543] Subtest cursor-offscreen-32x32: SKIP (0.042s)
[589.423390] [092/132] (433s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[589.511095] Starting subtest: y-tiled-addfb-size-offset-overflow
[589.516529] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[589.610084] [093/132] (433s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[589.692013] Starting subtest: fb-8bpc-vs-panel-6bpc
[589.694201] Starting dynamic subtest: pipe-A-eDP-1
[591.104142] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.410s)
[591.106613] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.411s)
[591.954684] [094/132] (431s left) kms_invalid_mode (bad-vsync-start)
[592.030310] Starting subtest: bad-vsync-start
[592.032718] Starting dynamic subtest: pipe-A-eDP-1
[592.319678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[592.330778] Starting dynamic subtest: pipe-B-eDP-1
[592.333318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[592.343531] Starting dynamic subtest: pipe-C-eDP-1
[592.346140] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[592.356047] Starting dynamic subtest: pipe-D-eDP-1
[592.358853] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[592.361473] Subtest bad-vsync-start: SUCCESS (0.296s)
[593.195627] [095/132] (430s left) dmabuf_sync_file (import-multiple-read-only)
[593.252700] Starting subtest: import-multiple-read-only
[593.255721] Subtest import-multiple-read-only: SUCCESS (0.003s)
[593.311581] [096/132] (430s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[593.384967] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[593.386998] Starting dynamic subtest: pipe-A-eDP-1
[595.494717] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[595.505086] Starting dynamic subtest: pipe-B-eDP-1
[597.866404] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.368s)
[597.885689] Starting dynamic subtest: pipe-C-eDP-1
[600.045656] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.181s)
[600.055927] Starting dynamic subtest: pipe-D-eDP-1
[602.118029] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.069s)
[602.121055] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.734s)
[603.319140] [097/132] (420s left) syncobj_wait (invalid-signal-one-illegal-handle)
[603.390964] Starting subtest: invalid-signal-one-illegal-handle
[603.393444] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[603.489444] [098/132] (420s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[603.573974] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[603.578971] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[603.667312] [099/132] (419s left) gem_exec_reloc (basic-gtt-cpu)
[603.732673] Subtest basic-gtt-cpu: SKIP (0.000s)
[603.808700] [100/132] (419s left) gem_wait (write-busy)
[603.870063] Starting subtest: write-busy
[603.872836] Starting dynamic subtest: all-engines
[604.450580] Dynamic subtest all-engines: SUCCESS (0.580s)
[604.469852] Starting dynamic subtest: rcs0
[605.010463] Dynamic subtest rcs0: SUCCESS (0.558s)
[605.026639] Starting dynamic subtest: bcs0
[605.561505] Dynamic subtest bcs0: SUCCESS (0.549s)
[605.578931] Starting dynamic subtest: vcs0
[606.983146] Dynamic subtest vcs0: SUCCESS (1.420s)
[607.001160] Starting dynamic subtest: vcs1
[608.967561] Dynamic subtest vcs1: SUCCESS (1.981s)
[608.986183] Starting dynamic subtest: vecs0
[610.952325] Dynamic subtest vecs0: SUCCESS (1.982s)
[610.976000] Starting dynamic subtest: ccs0
[611.507053] Dynamic subtest ccs0: SUCCESS (0.553s)
[611.509872] Subtest write-busy: SUCCESS (7.638s)
[611.706359] [101/132] (412s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[612.081480] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[612.930042] [102/132] (410s left) api_intel_allocator (gem-pool)
[612.983957] Starting subtest: gem-pool
[612.990749] Subtest gem-pool: SUCCESS (0.009s)
[613.107484] [103/132] (410s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[613.187705] Starting subtest: fbcpsr-rgb565-draw-pwrite
[620.209509] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.026s)
[620.322678] [104/132] (403s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[620.383506] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[620.388392] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[620.565985] [105/132] (403s left) gem_ctx_persistence (legacy-engines-mixed)
[620.629957] Starting subtest: legacy-engines-mixed
[620.633032] Starting dynamic subtest: render
[620.702693] Dynamic subtest render: SUCCESS (0.072s)
[620.716304] Starting dynamic subtest: bsd1
[620.757444] Dynamic subtest bsd1: SUCCESS (0.053s)
[620.770993] Starting dynamic subtest: bsd2
[620.800297] Dynamic subtest bsd2: SUCCESS (0.040s)
[620.811215] Starting dynamic subtest: blt
[620.844080] Dynamic subtest blt: SUCCESS (0.042s)
[620.854770] Starting dynamic subtest: vebox
[620.888099] Dynamic subtest vebox: SUCCESS (0.042s)
[620.890797] Subtest legacy-engines-mixed: SUCCESS (0.259s)
[620.967086] [106/132] (402s left) kms_lease (lease-again)
[621.042089] Starting subtest: lease-again
[621.044267] Starting dynamic subtest: pipe-A-eDP-1
[621.046497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[621.057486] Starting dynamic subtest: pipe-B-eDP-1
[621.059699] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[621.069987] Starting dynamic subtest: pipe-C-eDP-1
[621.072568] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[621.082468] Starting dynamic subtest: pipe-D-eDP-1
[621.084952] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[621.087384] Subtest lease-again: SUCCESS (0.014s)
[621.155527] [107/132] (402s left) syncobj_wait (multi-wait-submitted-signaled)
[621.200021] Starting subtest: multi-wait-submitted-signaled
[621.203078] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[621.303594] [108/132] (402s left) gem_exec_balancer (individual)
[621.361767] Starting subtest: individual
[622.979637] Subtest individual: SUCCESS (1.616s)
[623.304601] [109/132] (400s left) kms_hdr (invalid-hdr)
[623.384930] Starting subtest: invalid-hdr
[625.504319] Starting dynamic subtest: pipe-A-eDP-1
[628.465203] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.961s)
[628.467991] Subtest invalid-hdr: SUCCESS (5.084s)
[628.580601] [110/132] (395s left) gem_userptr_blits (process-exit)
[628.650195] Starting subtest: process-exit
[628.657810] Subtest process-exit: SUCCESS (0.008s)
[628.787035] [111/132] (395s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[628.872124] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[635.817987] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.950s)
[635.932706] [112/132] (388s left) gem_exec_schedule (preempt-queue-contexts)
[636.024909] Subtest preempt-queue-contexts: SKIP (0.000s)
[636.305521] [113/132] (387s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[636.385901] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[636.391153] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[636.484843] [114/132] (387s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[636.553189] Starting subtest: mixed-tiled-to-y-tiled-ccs
[636.558956] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[636.742468] [115/132] (387s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[636.811740] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[636.815933] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[636.913875] [116/132] (387s left) kms_async_flips (test-time-stamp)
[636.987685] Starting subtest: test-time-stamp
[637.361689] Starting dynamic subtest: pipe-A-eDP-1
[638.148351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s)
[638.517739] Starting dynamic subtest: pipe-B-eDP-1
[639.278156] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[639.659147] Starting dynamic subtest: pipe-C-eDP-1
[640.416627] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[640.782845] Starting dynamic subtest: pipe-D-eDP-1
[641.544168] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[641.546964] Subtest test-time-stamp: SUCCESS (4.555s)
[642.702147] [117/132] (381s left) kms_psr (fbc-pr-primary-mmap-gtt)
[642.780582] Starting subtest: fbc-pr-primary-mmap-gtt
[642.784777] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[642.852555] [118/132] (381s left) gem_userptr_blits (sync-unmap-cycles)
[642.921767] Starting subtest: sync-unmap-cycles
[648.300624] Subtest sync-unmap-cycles: SUCCESS (5.379s)
[648.453738] [119/132] (376s left) i915_pm_rps (thresholds-park)
[648.512917] Starting subtest: thresholds-park
[648.517595] Subtest thresholds-park: SKIP (0.001s)
[648.620720] [120/132] (375s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[648.700737] Starting subtest: plane-lut1d-ctm3x4
[648.835939] Starting dynamic subtest: pipe-A-plane-0
[649.013757] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[649.024732] Starting dynamic subtest: pipe-A-plane-1
[649.158620] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[649.169044] Starting dynamic subtest: pipe-A-plane-2
[649.291665] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[650.504903] Starting dynamic subtest: pipe-B-plane-0
[650.672674] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[650.683962] Starting dynamic subtest: pipe-B-plane-1
[650.828486] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[650.839598] Starting dynamic subtest: pipe-B-plane-2
[651.028724] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s)
[652.223261] Starting dynamic subtest: pipe-C-plane-0
[652.356438] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[652.375548] Starting dynamic subtest: pipe-C-plane-1
[652.500877] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[652.512448] Starting dynamic subtest: pipe-C-plane-2
[652.656036] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[653.878028] Starting dynamic subtest: pipe-D-plane-0
[654.023936] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[654.035546] Starting dynamic subtest: pipe-D-plane-1
[654.179758] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[654.191209] Starting dynamic subtest: pipe-D-plane-2
[654.324049] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[654.614015] Subtest plane-lut1d-ctm3x4: SUCCESS (5.911s)
[655.423783] [121/132] (369s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[655.484175] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[655.577937] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.031s)
[655.620515] [122/132] (368s left) gem_fence_thrash (bo-write-verify-y)
[655.663714] Starting subtest: bo-write-verify-y
[655.676593] Subtest bo-write-verify-y: SKIP (0.012s)
[655.733049] [123/132] (368s left) gem_ctx_shared (detached-shared-gtt)
[655.801620] Starting subtest: detached-shared-gtt
[657.955767] Subtest detached-shared-gtt: SUCCESS (2.155s)
[658.314938] [124/132] (366s left) perf_pmu (invalid-init)
[658.353744] Starting subtest: invalid-init
[658.356457] Subtest invalid-init: SUCCESS (0.000s)
[658.477804] [125/132] (366s left) prime_vgem (basic-gtt)
[658.552048] Starting subtest: basic-gtt
[658.557819] Subtest basic-gtt: SKIP (0.000s)
[658.649395] [126/132] (366s left) dumb_buffer (map-valid)
[658.705697] Starting subtest: map-valid
[658.708183] Subtest map-valid: SUCCESS (0.000s)
[658.808769] [127/132] (366s left) gem_exec_schedule (smoketest-all)
[658.888714] Starting subtest: smoketest-all
[691.345843] Subtest smoketest-all: SUCCESS (32.410s)
[693.023885] [128/132] (331s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[693.113155] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[697.219593] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.111s)
[698.422497] [129/132] (326s left) gem_userptr_blits (map-fixed-invalidate)
[698.490157] Starting subtest: map-fixed-invalidate
[698.495615] Subtest map-fixed-invalidate: SKIP (0.000s)
[698.606248] [130/132] (326s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[698.673777] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[698.678397] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[698.751468] [131/132] (326s left) gem_ctx_persistence (engines-mixed)
[698.810990] Starting subtest: engines-mixed
[698.813434] Starting dynamic subtest: rcs0
[698.880836] Dynamic subtest rcs0: SUCCESS (0.070s)
[698.893106] Starting dynamic subtest: bcs0
[698.934754] Dynamic subtest bcs0: SUCCESS (0.052s)
[698.947140] Starting dynamic subtest: vcs0
[698.984012] Dynamic subtest vcs0: SUCCESS (0.048s)
[698.995907] Starting dynamic subtest: vcs1
[699.036956] Dynamic subtest vcs1: SUCCESS (0.051s)
[699.048052] Starting dynamic subtest: vecs0
[699.083825] Dynamic subtest vecs0: SUCCESS (0.046s)
[699.094975] Starting dynamic subtest: ccs0
[699.127839] Dynamic subtest ccs0: SUCCESS (0.043s)
[699.130400] Subtest engines-mixed: SUCCESS (0.318s)
[699.207438] [132/132] (325s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[699.276703] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[699.279057] Starting dynamic subtest: pipe-A
[699.300451] Dynamic subtest pipe-A: SKIP (0.017s)
[699.311574] Starting dynamic subtest: pipe-B
[699.329550] Dynamic subtest pipe-B: SKIP (0.030s)
[699.340327] Starting dynamic subtest: pipe-C
[699.360156] Dynamic subtest pipe-C: SKIP (0.031s)
[699.370301] Starting dynamic subtest: pipe-D
[699.391646] Dynamic subtest pipe-D: SKIP (0.030s)
[699.395549] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.110s)
[699.481073] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: gem_workarounds
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_create
results: parsing output: 5/ for test: kms_rmfb
results: parsing output: 6/ for test: gem_lmem_swapping
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: i915_pm_rc6_residency
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: sysfs_heartbeat_interval
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: vgem_basic
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_eventfd
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: i915_module_load
results: parsing output: 24/ for test: kms_fb_coherency
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: prime_mmap
results: parsing output: 39/ for test: intel_hwmon
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_pipe_crc_basic
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: gem_media_vme
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: api_intel_bb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_fbcon_fbt
results: parsing output: 65/ for test: kms_prop_blob
results: parsing output: 66/ for test: kms_selftest
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_plane_lowres
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_mmap_offset
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_psr2_su
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_dither
results: parsing output: 93/ for test: kms_invalid_mode
results: parsing output: 94/ for test: dmabuf_sync_file
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: gem_wait
results: parsing output: 100/ for test: kms_chamelium_hpd
results: parsing output: 101/ for test: api_intel_allocator
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_lease
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_hdr
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: kms_color_pipeline
results: parsing output: 120/ for test: sriov_basic
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: gem_ctx_shared
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: prime_vgem
results: parsing output: 125/ for test: dumb_buffer
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: kms_plane_scaling
Done.