[59.361271] Initializing watchdogs
[59.361317]   /dev/watchdog0
[59.375116] [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]
[59.379343] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.381565] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.385379] [001/132] (960s left) gem_mmap_gtt (basic-small-copy-odd)
[59.468786] Subtest basic-small-copy-odd: SKIP (0.000s)
[59.520376] [002/132] (960s left) gem_exec_fence (keep-in-fence)
[59.707853] Starting subtest: keep-in-fence
[59.710201] Starting dynamic subtest: rcs0
[59.774746] Dynamic subtest rcs0: SUCCESS (0.069s)
[59.787918] Starting dynamic subtest: bcs0
[59.828818] Dynamic subtest bcs0: SUCCESS (0.054s)
[59.837689] Starting dynamic subtest: vcs0
[61.312130] Dynamic subtest vcs0: SUCCESS (1.481s)
[61.323156] Starting dynamic subtest: vcs1
[63.295216] Dynamic subtest vcs1: SUCCESS (1.984s)
[63.305486] Starting dynamic subtest: vecs0
[65.279773] Dynamic subtest vecs0: SUCCESS (1.985s)
[65.288600] Starting dynamic subtest: ccs0
[65.523402] Dynamic subtest ccs0: SUCCESS (0.244s)
[65.526208] Subtest keep-in-fence: SUCCESS (5.823s)
[67.344720] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[67.347959] [003/132] (952s left) intel_hwmon (hwmon-read)
[67.405708] Subtest hwmon-read: SKIP (0.000s)
[67.474532] [004/132] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[67.572252] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[67.576590] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[67.672399] [005/132] (952s left) kms_content_protection (content-type-change)
[67.832124] Starting subtest: content-type-change
[67.836701] Subtest content-type-change: SKIP (0.000s)
[67.972542] [006/132] (952s left) kms_psr (psr-sprite-mmap-cpu)
[68.060541] Starting subtest: psr-sprite-mmap-cpu
[68.062717] Starting dynamic subtest: eDP-1
[69.786597] Dynamic subtest eDP-1: SUCCESS (1.727s)
[69.789053] Subtest psr-sprite-mmap-cpu: SUCCESS (1.728s)
[70.659066] [007/132] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[70.777585] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[70.781927] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[70.880836] [008/132] (949s left) syncobj_timeline (single-wait-for-submit-signaled)
[70.934589] Starting subtest: single-wait-for-submit-signaled
[70.936802] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[71.023523] [009/132] (949s left) gem_exec_parallel (userptr)
[71.093842] Starting subtest: userptr
[71.096323] Starting dynamic subtest: rcs0
[72.542884] Dynamic subtest rcs0: SUCCESS (1.452s)
[72.551060] Starting dynamic subtest: bcs0
[74.392081] Dynamic subtest bcs0: SUCCESS (1.848s)
[74.402391] Starting dynamic subtest: vcs0
[76.285761] Dynamic subtest vcs0: SUCCESS (1.893s)
[76.296210] Starting dynamic subtest: vcs1
[78.269844] Dynamic subtest vcs1: SUCCESS (1.983s)
[78.280817] Starting dynamic subtest: vecs0
[80.318589] Dynamic subtest vecs0: SUCCESS (2.048s)
[80.329907] Starting dynamic subtest: ccs0
[81.816816] Dynamic subtest ccs0: SUCCESS (1.499s)
[81.819698] Subtest userptr: SUCCESS (10.730s)
[82.011768] [010/132] (938s left) kms_lease (lease-revoke)
[82.103852] Starting subtest: lease-revoke
[82.106534] Starting dynamic subtest: pipe-A-eDP-1
[82.132196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[82.143731] Starting dynamic subtest: pipe-B-eDP-1
[82.164851] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.032s)
[82.173478] Starting dynamic subtest: pipe-C-eDP-1
[82.193442] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[82.201368] Starting dynamic subtest: pipe-D-eDP-1
[82.216871] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.024s)
[82.219330] Subtest lease-revoke: SUCCESS (0.116s)
[82.347963] [011/132] (937s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[82.439329] Starting subtest: fbc-rgb565-draw-pwrite
[86.980045] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.544s)
[88.134433] [012/132] (932s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[88.197090] Starting subtest: multi-wait-for-submit-available-signaled
[88.199446] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[88.292707] [013/132] (932s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[88.383793] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[97.027036] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.646s)
[97.149587] [014/132] (923s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[97.248841] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[97.252815] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[97.346655] [015/132] (923s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[97.459047] Starting subtest: cursorB-vs-flipA-legacy
[97.463435] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[97.616971] [016/132] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[97.712224] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[104.608600] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.902s)
[104.742753] [017/132] (915s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[104.844467] Starting subtest: y-tiled-64bpp-rotate-90
[104.848486] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[104.939131] [018/132] (915s left) kms_psr (psr2-primary-render)
[105.040036] Starting subtest: psr2-primary-render
[105.042278] Starting dynamic subtest: eDP-1
[106.809151] Dynamic subtest eDP-1: SUCCESS (1.769s)
[106.811492] Subtest psr2-primary-render: SUCCESS (1.770s)
[107.667222] [019/132] (912s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[107.774809] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[107.779152] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[107.855558] [020/132] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[107.972771] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[107.977081] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.075870] [021/132] (912s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[108.176026] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[108.178251] Starting dynamic subtest: pipe-A-eDP-1
[119.168903] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.997s)
[119.181220] Starting dynamic subtest: pipe-B-eDP-1
[130.870258] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.698s)
[130.872722] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.697s)
[131.737660] [022/132] (888s left) api_intel_bb (reset-bb)
[131.784889] Starting subtest: reset-bb
[131.787268] Subtest reset-bb: SUCCESS (0.004s)
[131.909452] [023/132] (888s left) perf (whitelisted-registers-userspace-config)
[132.021891] Starting subtest: whitelisted-registers-userspace-config
[132.023815] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[132.058751] [024/132] (888s left) api_intel_allocator (execbuf-with-allocator)
[132.109720] Starting subtest: execbuf-with-allocator
[132.117067] Subtest execbuf-with-allocator: SUCCESS (0.009s)
[132.250998] [025/132] (888s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[132.367509] Starting subtest: x-tiled-64bpp-rotate-270
[132.388689] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s)
[132.498726] [026/132] (888s left) prime_mmap_coherency (ioctl-errors)
[132.550158] Starting subtest: ioctl-errors
[135.495688] Subtest ioctl-errors: SUCCESS (2.946s)
[135.639833] [027/132] (885s left) gem_exec_whisper (basic-fds-forked)
[135.732451] Starting subtest: basic-fds-forked
[159.787049] Subtest basic-fds-forked: SUCCESS (23.998s)
[159.930649] [028/132] (861s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[160.031742] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[160.034463] Starting dynamic subtest: pipe-A
[160.054183] Dynamic subtest pipe-A: SKIP (0.018s)
[160.068255] Starting dynamic subtest: pipe-B
[160.085016] Dynamic subtest pipe-B: SKIP (0.032s)
[160.098209] Starting dynamic subtest: pipe-C
[160.119784] Dynamic subtest pipe-C: SKIP (0.033s)
[160.128908] Starting dynamic subtest: pipe-D
[160.151967] Dynamic subtest pipe-D: SKIP (0.033s)
[160.155818] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.117s)
[160.250413] [029/132] (860s left) perf_pmu (busy-double-start)
[160.292884] Starting subtest: busy-double-start
[160.295095] Starting dynamic subtest: rcs0
[163.938619] Dynamic subtest rcs0: FAIL (3.590s)
[163.949213] Starting dynamic subtest: bcs0
[167.450922] Dynamic subtest bcs0: SUCCESS (3.569s)
[167.461778] Starting dynamic subtest: vcs0
[171.837059] Dynamic subtest vcs0: SUCCESS (4.384s)
[171.848256] Starting dynamic subtest: vcs1
[175.809034] Dynamic subtest vcs1: SUCCESS (3.971s)
[175.820117] Starting dynamic subtest: vecs0
[179.850760] Dynamic subtest vecs0: SUCCESS (4.040s)
[179.861414] Starting dynamic subtest: ccs0
[183.489313] Dynamic subtest ccs0: FAIL (3.567s)
[183.491347] Subtest busy-double-start: FAIL (23.127s)
[183.537873] [030/132] (837s left) kms_rotation_crc (primary-rotation-270)
[183.633020] Starting subtest: primary-rotation-270
[183.637225] Subtest primary-rotation-270: SKIP (0.001s)
[183.703701] [031/132] (837s left) syncobj_eventfd (timeline-wait)
[183.760756] Starting subtest: timeline-wait
[183.771726] Subtest timeline-wait: SUCCESS (0.011s)
[183.846926] [032/132] (837s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[183.936407] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[183.940570] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[184.032426] [033/132] (837s left) perf (mi-rpc)
[184.132329] Starting subtest: mi-rpc
[184.137031] Subtest mi-rpc: SKIP (0.000s)
[184.174844] [034/132] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[184.271260] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[184.275323] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[184.374055] [035/132] (836s left) i915_drm_fdinfo (busy-idle)
[184.414647] Starting subtest: busy-idle
[184.416532] Starting dynamic subtest: rcs0
[184.436078] Dynamic subtest rcs0: SKIP (0.021s)
[184.446740] Starting dynamic subtest: bcs0
[184.450162] Dynamic subtest bcs0: SKIP (0.000s)
[184.458801] Starting dynamic subtest: vcs0
[184.462565] Dynamic subtest vcs0: SKIP (0.000s)
[184.472813] Starting dynamic subtest: vcs1
[184.476270] Dynamic subtest vcs1: SKIP (0.000s)
[184.484294] Starting dynamic subtest: vecs0
[184.487636] Dynamic subtest vecs0: SKIP (0.000s)
[184.495546] Starting dynamic subtest: ccs0
[184.498821] Dynamic subtest ccs0: SKIP (0.000s)
[184.502173] Subtest busy-idle: SKIP (0.024s)
[184.535243] [036/132] (836s left) syncobj_wait (single-wait-all-signaled)
[184.586916] Starting subtest: single-wait-all-signaled
[184.588717] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[184.686812] [037/132] (836s left) gem_exec_suspend (basic-s3-devices)
[184.739349] Starting subtest: basic-S3-devices
[184.741322] Starting dynamic subtest: smem
[196.286166] Dynamic subtest smem: SUCCESS (11.544s)
[196.289059] Subtest basic-S3-devices: SUCCESS (11.546s)
[196.487107] [038/132] (824s left) kms_cursor_legacy (forked-bo)
[196.624553] Starting subtest: forked-bo
[196.626913] Starting dynamic subtest: pipe-A
[202.149429] Dynamic subtest pipe-A: SUCCESS (5.469s)
[202.160982] Starting dynamic subtest: pipe-B
[207.569871] Dynamic subtest pipe-B: SUCCESS (5.471s)
[207.581814] Starting dynamic subtest: pipe-C
[213.099570] Dynamic subtest pipe-C: SUCCESS (5.475s)
[213.112239] Starting dynamic subtest: pipe-D
[218.572252] Dynamic subtest pipe-D: SUCCESS (5.471s)
[218.585380] Starting dynamic subtest: all-pipes
[224.067453] Dynamic subtest all-pipes: SUCCESS (5.494s)
[224.069535] Subtest forked-bo: SUCCESS (27.387s)
[224.166238] [039/132] (797s left) syncobj_timeline (multi-wait-all-available-signaled)
[224.232721] Starting subtest: multi-wait-all-available-signaled
[224.235051] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[224.330230] [040/132] (797s left) syncobj_wait (single-wait-signaled)
[224.402576] Starting subtest: single-wait-signaled
[224.404757] Subtest single-wait-signaled: SUCCESS (0.000s)
[224.516445] [041/132] (796s left) i915_selftest (mock)
[226.338224] Starting subtest: mock
[226.340866] Starting dynamic subtest: sanitycheck
[227.045261] Dynamic subtest sanitycheck: SUCCESS (0.706s)
[227.061499] Starting dynamic subtest: shmem
[227.703266] Dynamic subtest shmem: SUCCESS (0.657s)
[227.712955] Starting dynamic subtest: fence
[235.459369] Dynamic subtest fence: SUCCESS (7.754s)
[235.472662] Starting dynamic subtest: scatterlist
[237.154816] Dynamic subtest scatterlist: SUCCESS (1.694s)
[237.164980] Starting dynamic subtest: syncmap
[240.497657] Dynamic subtest syncmap: SUCCESS (3.341s)
[240.508153] Starting dynamic subtest: uncore
[241.139224] Dynamic subtest uncore: SUCCESS (0.641s)
[241.149818] Starting dynamic subtest: ring
[241.793263] Dynamic subtest ring: SUCCESS (0.653s)
[241.803661] Starting dynamic subtest: engine
[242.448160] Dynamic subtest engine: SUCCESS (0.654s)
[242.458463] Starting dynamic subtest: timelines
[246.249036] Dynamic subtest timelines: SUCCESS (3.799s)
[246.259124] Starting dynamic subtest: requests
[249.955242] Dynamic subtest requests: SUCCESS (3.705s)
[249.964883] Starting dynamic subtest: objects
[250.706034] Dynamic subtest objects: SUCCESS (0.751s)
[250.715639] Starting dynamic subtest: phys
[251.438016] Dynamic subtest phys: SUCCESS (0.731s)
[251.445515] Starting dynamic subtest: dmabuf
[252.150120] Dynamic subtest dmabuf: SUCCESS (0.711s)
[252.160231] Starting dynamic subtest: vma
[257.679442] Dynamic subtest vma: SUCCESS (5.528s)
[257.689630] Starting dynamic subtest: evict
[259.037788] Dynamic subtest evict: SUCCESS (1.357s)
[259.048296] Starting dynamic subtest: gtt
[262.258193] Dynamic subtest gtt: SUCCESS (3.219s)
[262.267990] Starting dynamic subtest: hugepages
[263.162686] Dynamic subtest hugepages: SUCCESS (0.903s)
[263.172577] Starting dynamic subtest: memory_region
[265.609215] Dynamic subtest memory_region: SUCCESS (2.445s)
[265.612064] Subtest mock: SUCCESS (39.269s)
[265.641340] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[265.642054] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[265.645058] [042/132] (755s left) kms_psr (pr-primary-render)
[267.196952] Starting subtest: pr-primary-render
[267.201317] Subtest pr-primary-render: SKIP (0.000s)
[267.291841] [FACT kms_psr (pr-primary-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[267.293068] [FACT kms_psr (pr-primary-render)] new: kernel.kmod_is_loaded.i915: true
[267.296611] [043/132] (754s left) prime_mmap (test_dup)
[267.360950] Starting subtest: test_dup
[267.363616] Starting dynamic subtest: test_dup-smem
[267.392551] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[267.394994] Subtest test_dup: SUCCESS (0.032s)
[267.479178] [044/132] (754s left) perf_pmu (pmu-read)
[267.519814] Starting subtest: pmu-read
[267.522123] Subtest pmu-read: SUCCESS (0.002s)
[267.623805] [045/132] (754s left) gem_ctx_sseu (invalid-sseu)
[267.683157] Subtest invalid-sseu: SKIP (0.000s)
[267.739651] [046/132] (753s left) kms_tiled_display (basic-test-pattern)
[267.839369] Subtest basic-test-pattern: SKIP (0.000s)
[267.884988] [047/132] (753s left) kms_cursor_crc (cursor-alpha-transparent)
[267.973612] Starting subtest: cursor-alpha-transparent
[267.975694] Starting dynamic subtest: pipe-A-eDP-1
[268.661487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[268.670479] Starting dynamic subtest: pipe-D-eDP-1
[269.920924] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[269.922797] Subtest cursor-alpha-transparent: SUCCESS (1.948s)
[270.789717] [048/132] (751s left) gem_lmem_swapping (heavy-verify-random)
[270.838466] Subtest heavy-verify-random: SKIP (0.000s)
[270.889121] [049/132] (750s left) syncobj_wait (wait-for-submit-snapshot)
[270.939044] Starting subtest: wait-for-submit-snapshot
[271.019294] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[271.098557] [050/132] (750s left) gem_exec_reloc (basic-cpu)
[271.160087] Subtest basic-cpu: SKIP (0.000s)
[271.232702] [051/132] (750s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[271.322512] Starting subtest: plane-lut1d-pre-ctm3x4
[271.446791] Starting dynamic subtest: pipe-A-plane-0
[271.591065] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[271.600980] Starting dynamic subtest: pipe-A-plane-1
[271.723959] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[271.733051] Starting dynamic subtest: pipe-A-plane-2
[271.868500] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[273.076124] Starting dynamic subtest: pipe-B-plane-0
[273.213092] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[273.222825] Starting dynamic subtest: pipe-B-plane-1
[273.357327] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[273.366489] Starting dynamic subtest: pipe-B-plane-2
[273.490750] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[274.702558] Starting dynamic subtest: pipe-C-plane-0
[274.839434] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[274.849321] Starting dynamic subtest: pipe-C-plane-1
[274.983487] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[274.993244] Starting dynamic subtest: pipe-C-plane-2
[275.128218] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[276.345437] Starting dynamic subtest: pipe-D-plane-0
[276.482290] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[276.491834] Starting dynamic subtest: pipe-D-plane-1
[276.626609] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[276.636223] Starting dynamic subtest: pipe-D-plane-2
[276.771042] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[277.057745] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.735s)
[277.910358] [052/132] (744s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[278.009855] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[278.013762] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[278.082719] [053/132] (743s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[278.180318] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[278.182563] Starting dynamic subtest: pipe-A-eDP-1
[289.499744] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.323s)
[289.509254] Starting dynamic subtest: pipe-B-eDP-1
[301.518373] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.017s)
[301.520707] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.343s)
[302.375080] [054/132] (719s left) gem_ringfill (legacy-basic)
[308.289634] Starting subtest: legacy-basic
[308.292273] Starting dynamic subtest: default
[308.359955] Dynamic subtest default: SUCCESS (0.070s)
[308.372257] Starting dynamic subtest: render
[308.403047] Dynamic subtest render: SUCCESS (0.041s)
[308.413461] Starting dynamic subtest: bsd
[308.446057] Dynamic subtest bsd: SUCCESS (0.041s)
[308.459135] Starting dynamic subtest: bsd1
[308.488312] Dynamic subtest bsd1: SUCCESS (0.040s)
[308.498714] Starting dynamic subtest: bsd2
[308.529217] Dynamic subtest bsd2: SUCCESS (0.038s)
[308.540457] Starting dynamic subtest: blt
[308.574986] Dynamic subtest blt: SUCCESS (0.044s)
[308.585129] Starting dynamic subtest: vebox
[308.617046] Dynamic subtest vebox: SUCCESS (0.040s)
[308.619419] Subtest legacy-basic: SUCCESS (0.330s)
[308.707880] [055/132] (713s left) gem_exec_schedule (u-submit-early-slice)
[308.777618] Starting subtest: u-submit-early-slice
[308.779980] Starting dynamic subtest: rcs0
[308.825428] Dynamic subtest rcs0: SUCCESS (0.057s)
[308.839949] Starting dynamic subtest: bcs0
[308.892642] Dynamic subtest bcs0: SUCCESS (0.066s)
[308.907045] Starting dynamic subtest: vcs0
[308.958681] Dynamic subtest vcs0: SUCCESS (0.065s)
[308.969051] Starting dynamic subtest: vcs1
[309.006556] Dynamic subtest vcs1: SUCCESS (0.047s)
[309.018833] Starting dynamic subtest: vecs0
[309.048637] Dynamic subtest vecs0: SUCCESS (0.042s)
[309.059666] Starting dynamic subtest: ccs0
[309.105578] Dynamic subtest ccs0: SUCCESS (0.056s)
[309.108698] Subtest u-submit-early-slice: SUCCESS (0.338s)
[310.345112] [056/132] (711s left) kms_psr (fbc-pr-primary-mmap-gtt)
[310.436707] Starting subtest: fbc-pr-primary-mmap-gtt
[310.441154] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[310.511527] [057/132] (711s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[310.623425] Starting subtest: cursorB-vs-flipA-atomic-transitions
[310.627809] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[310.767093] [058/132] (711s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[310.865038] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[310.869543] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[310.984750] [059/132] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[311.080080] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[317.622047] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.545s)
[317.722382] [060/132] (704s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[317.831850] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[324.804307] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.974s)
[324.927537] [061/132] (697s left) gem_exec_schedule (noreorder)
[325.117696] Starting subtest: noreorder
[325.120666] Starting dynamic subtest: rcs0
[325.188467] Dynamic subtest rcs0: SUCCESS (0.072s)
[325.201101] Starting dynamic subtest: vcs0
[326.244755] Dynamic subtest vcs0: SUCCESS (1.053s)
[326.258330] Starting dynamic subtest: vcs1
[328.311420] Dynamic subtest vcs1: SUCCESS (2.064s)
[328.325703] Starting dynamic subtest: vecs0
[330.275991] Dynamic subtest vecs0: SUCCESS (1.961s)
[330.288388] Starting dynamic subtest: ccs0
[330.366854] Dynamic subtest ccs0: SUCCESS (0.090s)
[330.369612] Subtest noreorder: SUCCESS (5.252s)
[330.558520] [062/132] (691s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[330.662687] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[334.639793] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.981s)
[335.811395] [063/132] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[335.919716] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[335.924046] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[336.006321] [064/132] (686s left) kms_psr (fbc-psr-primary-render)
[336.093247] Starting subtest: fbc-psr-primary-render
[336.095509] Starting dynamic subtest: eDP-1
[336.099677] Dynamic subtest eDP-1: SKIP (0.000s)
[336.103915] Subtest fbc-psr-primary-render: SKIP (0.001s)
[336.164443] [065/132] (686s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[336.257087] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[336.259341] Starting dynamic subtest: pipe-A-default-mode
[338.951086] Dynamic subtest pipe-A-default-mode: SUCCESS (2.693s)
[338.953356] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.695s)
[339.810395] [066/132] (682s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[339.885550] Subtest tiled-to-tiled: SKIP (0.000s)
[339.972176] [067/132] (682s left) gem_busy (parallel)
[340.150046] Starting subtest: parallel
[340.152245] Starting dynamic subtest: rcs0
[341.310244] Dynamic subtest rcs0: SUCCESS (1.161s)
[341.322876] Starting dynamic subtest: bcs0
[343.294931] Dynamic subtest bcs0: SUCCESS (1.981s)
[343.306830] Starting dynamic subtest: vcs0
[345.278626] Dynamic subtest vcs0: SUCCESS (1.980s)
[345.290299] Starting dynamic subtest: vcs1
[347.262345] Dynamic subtest vcs1: SUCCESS (1.981s)
[347.275940] Starting dynamic subtest: vecs0
[349.361565] Dynamic subtest vecs0: SUCCESS (2.044s)
[349.374046] Starting dynamic subtest: ccs0
[351.294571] Dynamic subtest ccs0: SUCCESS (1.982s)
[351.297408] Subtest parallel: SUCCESS (11.148s)
[351.532569] [068/132] (671s left) gem_mmap_gtt (cpuset-big-copy-odd)
[351.588716] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[351.647229] [069/132] (671s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[351.748915] Starting subtest: 4-tiled-16bpp-rotate-270
[351.768717] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[351.875428] [070/132] (670s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[351.937874] Starting subtest: x-tiled-to-vebox-yf-tiled
[351.942301] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[352.126498] [071/132] (670s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[352.230264] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[352.232622] Starting dynamic subtest: pipe-A-eDP-1
[352.256228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.267391] Starting dynamic subtest: pipe-B-eDP-1
[352.289813] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.299183] Starting dynamic subtest: pipe-C-eDP-1
[352.319582] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.328590] Starting dynamic subtest: pipe-D-eDP-1
[352.350235] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.354629] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[354.472158] [072/132] (668s left) syncobj_wait (invalid-wait-bad-flags)
[354.538110] Starting subtest: invalid-wait-bad-flags
[354.540599] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[354.641059] [073/132] (668s left) gem_userptr_blits (access-control)
[354.713076] Starting subtest: access-control
[354.716996] Subtest access-control: SKIP (0.000s)
[354.823146] [074/132] (668s left) gem_mmap_gtt (basic-wc)
[354.874301] Subtest basic-wc: SKIP (0.000s)
[354.937884] [075/132] (667s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[355.063122] Starting subtest: flip-vs-cursor-varying-size
[363.992678] Subtest flip-vs-cursor-varying-size: SUCCESS (8.929s)
[364.802680] [076/132] (658s left) kms_cdclk (mode-transition-all-outputs)
[364.891494] Starting subtest: mode-transition-all-outputs
[365.190796] Subtest mode-transition-all-outputs: SKIP (0.295s)
[366.045183] [077/132] (656s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[366.140139] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[372.904963] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.766s)
[373.031519] [078/132] (649s left) gem_caching (writes)
[373.090841] Subtest writes: SKIP (0.000s)
[373.155439] [079/132] (649s left) gem_ccs (large-ctrl-surf-copy)
[373.215749] Starting subtest: large-ctrl-surf-copy
[373.220200] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[373.313994] [080/132] (649s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[373.413227] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[374.504770] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.092s)
[374.651203] [081/132] (648s left) kms_cursor_crc (cursor-sliding-128x42)
[374.891204] Starting subtest: cursor-sliding-128x42
[374.977749] Subtest cursor-sliding-128x42: SKIP (0.081s)
[375.195782] [082/132] (647s left) gem_exec_reloc (basic-write-cpu-noreloc)
[375.258082] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[375.334083] [083/132] (647s left) gem_ppgtt (shrink-vs-evict-any)
[375.398224] Starting subtest: shrink-vs-evict-any
[381.331271] Subtest shrink-vs-evict-any: SUCCESS (5.869s)
[381.375765] [084/132] (641s left) gem_exec_reloc (basic-write-wc-active)
[381.434704] Subtest basic-write-wc-active: SKIP (0.000s)
[381.506309] [085/132] (641s left) i915_pm_rpm (debugfs-read)
[383.435199] Starting subtest: debugfs-read
[384.599562] Subtest debugfs-read: SUCCESS (1.159s)
[384.976571] [086/132] (638s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[385.069472] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[385.073674] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[385.176144] [087/132] (638s left) gem_exec_balancer (individual)
[385.253680] Starting subtest: individual
[387.327380] Subtest individual: SUCCESS (2.075s)
[387.662287] [088/132] (635s left) gem_ctx_persistence (many-contexts)
[387.727573] Starting subtest: many-contexts
[432.956059] Subtest many-contexts: SUCCESS (45.227s)
[433.052341] [089/132] (590s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[433.163978] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[433.999687] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[434.167855] [090/132] (589s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[434.264057] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[434.275364] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[434.361445] [091/132] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[434.462300] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[441.187304] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.727s)
[441.326115] [092/132] (582s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[441.415261] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[441.417608] Starting dynamic subtest: pipe-A-eDP-1
[441.440514] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[441.452403] Starting dynamic subtest: pipe-B-eDP-1
[441.474083] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[441.483320] Starting dynamic subtest: pipe-C-eDP-1
[441.505048] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[441.514062] Starting dynamic subtest: pipe-D-eDP-1
[441.535822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[441.540251] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[443.644591] [093/132] (580s left) kms_joiner (invalid-modeset-big-joiner)
[443.760245] Starting subtest: invalid-modeset-big-joiner
[443.764572] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[443.837014] [094/132] (579s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[443.928974] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[443.931259] Starting dynamic subtest: pipe-A
[444.311365] Dynamic subtest pipe-A: SUCCESS (0.384s)
[444.321744] Starting dynamic subtest: pipe-B
[445.734908] Dynamic subtest pipe-B: SUCCESS (1.422s)
[445.744520] Starting dynamic subtest: pipe-C
[447.169536] Dynamic subtest pipe-C: SUCCESS (1.433s)
[447.180062] Starting dynamic subtest: pipe-D
[448.638596] Dynamic subtest pipe-D: SUCCESS (1.468s)
[448.640762] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.713s)
[449.798770] [095/132] (573s left) kms_async_flips (invalid-async-flip)
[449.898832] Starting subtest: invalid-async-flip
[450.274856] Starting dynamic subtest: pipe-A-eDP-1
[451.099567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[451.462768] Starting dynamic subtest: pipe-B-eDP-1
[452.241210] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[452.603247] Starting dynamic subtest: pipe-C-eDP-1
[453.359752] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[453.709860] Starting dynamic subtest: pipe-D-eDP-1
[454.501759] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.799s)
[454.504072] Subtest invalid-async-flip: SUCCESS (4.606s)
[455.652650] [096/132] (568s left) kms_atomic_transition (plane-all-transition-nonblocking)
[455.762867] Starting subtest: plane-all-transition-nonblocking
[455.765143] Starting dynamic subtest: pipe-A-eDP-1
[458.258836] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[458.564721] Starting dynamic subtest: pipe-B-eDP-1
[461.784522] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s)
[462.088549] Subtest plane-all-transition-nonblocking: SUCCESS (6.325s)
[462.932831] [097/132] (560s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[463.329636] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[464.108509] [098/132] (559s left) gem_mmap_offset (bad-extensions)
[464.162769] Starting subtest: bad-extensions
[464.164990] Subtest bad-extensions: SUCCESS (0.000s)
[464.256869] [099/132] (559s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[464.346878] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[464.350921] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[464.442624] [100/132] (559s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[464.533166] Starting subtest: read-crc-frame-sequence
[464.534969] Starting dynamic subtest: pipe-A-eDP-1
[465.237778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[465.251134] Starting dynamic subtest: pipe-B-eDP-1
[466.630809] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s)
[466.641930] Starting dynamic subtest: pipe-C-eDP-1
[467.999453] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[468.010426] Starting dynamic subtest: pipe-D-eDP-1
[469.327280] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[469.329844] Subtest read-crc-frame-sequence: SUCCESS (4.797s)
[470.170427] [101/132] (553s left) kms_dp_link_training (uhbr-sst)
[470.264299] Starting subtest: uhbr-sst
[470.272895] Subtest uhbr-sst: SKIP (0.000s)
[470.347504] [102/132] (553s left) gem_vm_create (create-ext)
[470.394708] Starting subtest: create-ext
[470.401238] Subtest create-ext: SUCCESS (0.006s)
[470.550630] [103/132] (553s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[470.647066] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[470.651136] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[470.736420] [104/132] (553s left) gem_exec_reloc (basic-write-read-active)
[470.801518] Subtest basic-write-read-active: SKIP (0.000s)
[470.879094] [105/132] (553s left) kms_vblank (query-forked-busy)
[470.975762] Starting subtest: query-forked-busy
[470.977976] Starting dynamic subtest: pipe-A-eDP-1
[472.850035] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[472.867096] Starting dynamic subtest: pipe-D-eDP-1
[475.422868] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.571s)
[475.425278] Subtest query-forked-busy: SUCCESS (4.449s)
[476.223054] [106/132] (547s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[476.321376] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[476.333636] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[476.416124] [107/132] (547s left) gen9_exec_parse (allowed-single)
[476.487945] Subtest allowed-single: SKIP (0.000s)
[476.548752] [108/132] (547s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[476.671759] Starting subtest: short-flip-after-cursor-toggle
[477.595598] Subtest short-flip-after-cursor-toggle: SUCCESS (0.923s)
[478.458561] [109/132] (545s left) kms_setmode (basic-clone-single-crtc)
[478.518024] Starting subtest: basic-clone-single-crtc
[478.524142] Subtest basic-clone-single-crtc: SKIP (0.000s)
[478.604726] [110/132] (545s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[478.689619] Starting subtest: psr-rgb101010-draw-mmap-cpu
[485.710277] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.024s)
[485.813278] [111/132] (538s left) syncobj_wait (wait-for-submit-complex)
[485.872151] Starting subtest: wait-for-submit-complex
[485.933323] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[486.009338] [112/132] (538s left) gem_exec_balancer (sequential)
[486.058773] Starting subtest: sequential
[489.104842] Subtest sequential: SUCCESS (3.046s)
[489.427148] [113/132] (535s left) gem_ctx_isolation (nonpriv)
[489.503806] Starting subtest: nonpriv
[489.506201] Starting dynamic subtest: rcs0
[489.797055] Dynamic subtest rcs0: SUCCESS (0.293s)
[489.810138] Starting dynamic subtest: bcs0
[490.104052] Dynamic subtest bcs0: SUCCESS (0.306s)
[490.116833] Starting dynamic subtest: vcs0
[490.385112] Dynamic subtest vcs0: SUCCESS (0.280s)
[490.396866] Starting dynamic subtest: vcs1
[491.496449] Dynamic subtest vcs1: SUCCESS (1.110s)
[491.508820] Starting dynamic subtest: vecs0
[493.529846] Dynamic subtest vecs0: SUCCESS (2.033s)
[493.541917] Starting dynamic subtest: ccs0
[495.556581] Dynamic subtest ccs0: SUCCESS (2.026s)
[495.558994] Subtest nonpriv: SUCCESS (6.053s)
[495.791617] [114/132] (528s left) kms_cursor_crc (cursor-sliding-512x512)
[496.065681] Starting subtest: cursor-sliding-512x512
[496.070290] Subtest cursor-sliding-512x512: SKIP (0.001s)
[496.261436] [115/132] (528s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[496.321509] Starting subtest: map-fixed-invalidate-overlap
[496.325900] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[496.433654] [116/132] (528s left) device_reset (unbind-reset-rebind)
[496.482465] Starting subtest: unbind-reset-rebind
[499.774323] Subtest unbind-reset-rebind: SUCCESS (3.286s)
[499.820132] [117/132] (524s left) gem_userptr_blits (forbidden-operations)
[499.896858] Starting subtest: forbidden-operations
[499.901397] Subtest forbidden-operations: SKIP (0.000s)
[500.039464] [118/132] (524s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[500.435385] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[501.238445] [119/132] (523s left) kms_pm_lpsp (screens-disabled)
[502.335928] Starting subtest: screens-disabled
[502.340396] Subtest screens-disabled: SKIP (0.000s)
[502.405969] [120/132] (522s left) kms_atomic_interruptible (atomic-setmode)
[502.499799] Starting subtest: atomic-setmode
[502.502093] Starting dynamic subtest: pipe-A-eDP-1
[509.392418] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.891s)
[509.394810] Subtest atomic-setmode: SUCCESS (6.893s)
[510.191879] [121/132] (514s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[510.252041] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[510.315869] [122/132] (514s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[510.414314] Starting subtest: fbc-rgb101010-draw-render
[515.013065] Subtest fbc-rgb101010-draw-render: SUCCESS (4.601s)
[516.192831] [123/132] (508s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[516.255537] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[516.257689] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[516.349210] [124/132] (508s left) kms_plane (pixel-format-linear-modifier)
[516.455745] Starting subtest: pixel-format-linear-modifier
[516.488787] Starting dynamic subtest: pipe-A-plane-0
[520.031787] Dynamic subtest pipe-A-plane-0: SUCCESS (3.543s)
[520.041630] Starting dynamic subtest: pipe-A-plane-3
[521.676483] Dynamic subtest pipe-A-plane-3: SUCCESS (1.644s)
[521.687411] Starting dynamic subtest: pipe-A-plane-5
[521.887677] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[522.969185] Starting dynamic subtest: pipe-B-plane-0
[526.560502] Dynamic subtest pipe-B-plane-0: SUCCESS (3.600s)
[526.575197] Starting dynamic subtest: pipe-B-plane-3
[528.249275] Dynamic subtest pipe-B-plane-3: SUCCESS (1.688s)
[528.259822] Starting dynamic subtest: pipe-B-plane-5
[528.460251] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[528.780511] Subtest pixel-format-linear-modifier: SUCCESS (12.323s)
[529.648377] [125/132] (495s left) perf (polling-small-buf)
[529.784621] Starting subtest: polling-small-buf
[529.875376] Subtest polling-small-buf: SUCCESS (0.089s)
[529.924479] [126/132] (495s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[530.009727] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[530.014310] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[531.173942] [127/132] (493s left) sysfs_timeslice_duration (idempotent)
[531.229884] Starting subtest: idempotent
[531.232308] Starting dynamic subtest: vecs0
[531.234607] Dynamic subtest vecs0: SUCCESS (0.000s)
[531.250757] Starting dynamic subtest: ccs0
[531.253129] Dynamic subtest ccs0: SUCCESS (0.000s)
[531.267444] Starting dynamic subtest: vcs0
[531.269400] Dynamic subtest vcs0: SUCCESS (0.000s)
[531.279033] Starting dynamic subtest: bcs0
[531.281345] Dynamic subtest bcs0: SUCCESS (0.000s)
[531.295472] Starting dynamic subtest: rcs0
[531.297631] Dynamic subtest rcs0: SUCCESS (0.000s)
[531.311757] Starting dynamic subtest: vcs1
[531.313953] Dynamic subtest vcs1: SUCCESS (0.000s)
[531.316183] Subtest idempotent: SUCCESS (0.006s)
[531.354280] [128/132] (493s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[531.440224] Starting subtest: bad-aux-stride-y-tiled-ccs
[531.442364] Starting dynamic subtest: pipe-A-eDP-1
[531.464187] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[531.477961] Starting dynamic subtest: pipe-B-eDP-1
[531.498078] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[531.507847] Starting dynamic subtest: pipe-C-eDP-1
[531.528669] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[531.538427] Starting dynamic subtest: pipe-D-eDP-1
[531.560595] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[531.564879] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[533.738111] [129/132] (491s left) gem_mmap_gtt (basic-small-bo-tiledx)
[533.811642] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[533.880465] [130/132] (491s left) gem_exec_params (dr4-dirt)
[533.951209] Starting subtest: DR4-dirt
[533.953582] Subtest DR4-dirt: SUCCESS (0.000s)
[534.066252] [131/132] (491s left) gem_softpin (safe-alignment)
[534.132669] Starting subtest: safe-alignment
[534.155072] Subtest safe-alignment: SUCCESS (0.025s)
[535.272447] [132/132] (490s left) i915_pm_freq_api (freq-basic-api)
[535.329724] Starting subtest: freq-basic-api
[535.332047] Starting dynamic subtest: gt0
[535.334226] Dynamic subtest gt0: SUCCESS (0.003s)
[535.344664] Starting dynamic subtest: gt1
[535.346778] Dynamic subtest gt1: SUCCESS (0.003s)
[535.348834] Subtest freq-basic-api: SUCCESS (0.008s)
[535.410551] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: intel_hwmon
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_content_protection
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_exec_parallel
results: parsing output: 9/ for test: kms_lease
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: api_intel_bb
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: prime_mmap_coherency
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: syncobj_eventfd
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_exec_suspend
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: i915_selftest
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: prime_mmap
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: gem_ctx_sseu
results: parsing output: 45/ for test: kms_tiled_display
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: gem_lmem_swapping
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_color_pipeline
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: gem_ringfill
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_set_tiling_vs_blt
results: parsing output: 66/ for test: gem_busy
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_cdclk
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_caching
results: parsing output: 78/ for test: gem_ccs
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: i915_pm_rpm
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_joiner
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: gem_mmap_offset
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: kms_dp_link_training
results: parsing output: 101/ for test: gem_vm_create
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gen9_exec_parse
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_setmode
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_exec_balancer
results: parsing output: 112/ for test: gem_ctx_isolation
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: device_reset
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_chamelium_edid
results: parsing output: 118/ for test: kms_pm_lpsp
results: parsing output: 119/ for test: kms_atomic_interruptible
results: parsing output: 120/ for test: kms_pipe_b_c_ivb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: sysfs_timeslice_duration
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: i915_pm_freq_api
Done.