[61.558077] Initializing watchdogs
[61.558125]   /dev/watchdog0
[61.572495] [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]
[61.576779] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.578961] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.582397] [001/132] (960s left) gem_exec_store (cachelines)
[61.671584] Starting subtest: cachelines
[61.674053] Starting dynamic subtest: rcs0
[61.757978] Dynamic subtest rcs0: SUCCESS (0.086s)
[61.767489] Starting dynamic subtest: bcs0
[61.821142] Dynamic subtest bcs0: SUCCESS (0.062s)
[61.829993] Starting dynamic subtest: vcs0
[61.881259] Dynamic subtest vcs0: SUCCESS (0.059s)
[61.888116] Starting dynamic subtest: vcs1
[61.941065] Dynamic subtest vcs1: SUCCESS (0.059s)
[61.947676] Starting dynamic subtest: vecs0
[62.005878] Dynamic subtest vecs0: SUCCESS (0.064s)
[62.014931] Starting dynamic subtest: ccs0
[62.061072] Dynamic subtest ccs0: SUCCESS (0.054s)
[62.063424] Subtest cachelines: SUCCESS (0.388s)
[62.268157] [002/132] (959s left) gem_pread (bench)
[62.331830] Subtest bench: SKIP (0.000s)
[62.401238] [003/132] (959s left) syncobj_wait (invalid-signal-illegal-handle)
[62.464288] Starting subtest: invalid-signal-illegal-handle
[62.466603] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[62.604430] [004/132] (959s left) kms_vblank (query-forked-busy-hang)
[62.704648] Starting subtest: query-forked-busy-hang
[62.706967] Starting dynamic subtest: pipe-A-eDP-1
[89.696503] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.954s)
[89.709538] Starting dynamic subtest: pipe-D-eDP-1
[104.664316] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.961s)
[104.666722] Subtest query-forked-busy-hang: SUCCESS (41.918s)
[105.565986] [005/132] (916s left) kms_psr (fbc-pr-primary-mmap-cpu)
[105.654447] Starting subtest: fbc-pr-primary-mmap-cpu
[105.659028] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[105.743427] [006/132] (916s left) kms_plane_cursor (overlay)
[105.853663] Starting subtest: overlay
[105.857880] Starting dynamic subtest: pipe-A-eDP-1-size-64
[108.378588] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.526s)
[108.436709] Starting dynamic subtest: pipe-A-eDP-1-size-128
[110.923190] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[110.985037] Starting dynamic subtest: pipe-A-eDP-1-size-256
[113.525602] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[113.882567] Starting dynamic subtest: pipe-B-eDP-1-size-64
[117.035749] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.163s)
[117.094158] Starting dynamic subtest: pipe-B-eDP-1-size-128
[119.593486] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.505s)
[119.653580] Starting dynamic subtest: pipe-B-eDP-1-size-256
[122.172982] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[122.518961] Starting dynamic subtest: pipe-C-eDP-1-size-64
[125.357169] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.847s)
[125.395039] Starting dynamic subtest: pipe-C-eDP-1-size-128
[127.524634] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.135s)
[127.561412] Starting dynamic subtest: pipe-C-eDP-1-size-256
[129.702381] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[130.028435] Starting dynamic subtest: pipe-D-eDP-1-size-64
[132.842795] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.824s)
[132.879358] Starting dynamic subtest: pipe-D-eDP-1-size-128
[134.999463] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.124s)
[135.038086] Starting dynamic subtest: pipe-D-eDP-1-size-256
[137.132728] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[137.452148] Subtest overlay: SUCCESS (31.594s)
[138.305164] [007/132] (883s left) perf (i915-ref-count)
[138.400416] Starting subtest: i915-ref-count
[138.459512] Subtest i915-ref-count: SUCCESS (0.057s)
[138.512782] [008/132] (883s left) gem_exec_schedule (smoketest-all)
[138.596097] Starting subtest: smoketest-all
[170.967255] Subtest smoketest-all: SUCCESS (32.323s)
[172.005919] [009/132] (850s left) gem_lmem_swapping (heavy-random)
[172.051654] Subtest heavy-random: SKIP (0.000s)
[172.089066] [010/132] (850s left) kms_psr (psr-primary-mmap-gtt)
[172.198964] Starting subtest: psr-primary-mmap-gtt
[172.201267] Starting dynamic subtest: eDP-1
[173.685540] Dynamic subtest eDP-1: SKIP (1.483s)
[173.690519] Subtest psr-primary-mmap-gtt: SKIP (1.485s)
[173.884517] [011/132] (848s left) perf (whitelisted-registers-userspace-config)
[173.995047] Starting subtest: whitelisted-registers-userspace-config
[173.997337] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[174.039383] [012/132] (848s left) gem_ppgtt (blt-vs-render-ctx0)
[174.088428] Starting subtest: blt-vs-render-ctx0
[206.998822] Subtest blt-vs-render-ctx0: SUCCESS (32.906s)
[207.167403] [013/132] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[207.317480] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[207.321685] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[207.450109] [014/132] (815s left) gem_mmap_gtt (basic)
[207.515032] Subtest basic: SKIP (0.000s)
[207.579693] [015/132] (815s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[207.648073] Starting subtest: invalid-single-wait-all-unsubmitted
[207.650385] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[207.796368] [016/132] (814s left) gem_ctx_engines (execute-one)
[207.868612] Starting subtest: execute-one
[210.398213] Subtest execute-one: SUCCESS (2.530s)
[210.605965] [017/132] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[210.706810] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[210.711296] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[210.829165] [018/132] (811s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[210.927170] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[210.929389] Starting dynamic subtest: pipe-A-eDP-1
[210.949544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[210.959886] Starting dynamic subtest: pipe-B-eDP-1
[210.977827] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[210.984960] Starting dynamic subtest: pipe-C-eDP-1
[211.003364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[211.010372] Starting dynamic subtest: pipe-D-eDP-1
[211.029048] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[211.030828] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[213.189794] [019/132] (809s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[213.245800] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[213.321797] [020/132] (809s left) api_intel_allocator (two-level-inception-interruptible)
[213.390942] Starting subtest: two-level-inception-interruptible
[218.800736] Subtest two-level-inception-interruptible: SUCCESS (5.410s)
[218.950394] [021/132] (803s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[224.062115] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[224.064359] Starting dynamic subtest: pipe-A-eDP-1
[230.679695] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.614s)
[230.688828] Starting dynamic subtest: pipe-B-eDP-1
[237.317749] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.638s)
[237.319834] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.256s)
[238.216935] [022/132] (784s left) i915_pciid
[238.394848] [023/132] (784s left) i915_pm_rpm (sysfs-read)
[239.960819] Starting subtest: sysfs-read
[241.117242] Subtest sysfs-read: SUCCESS (1.156s)
[241.514843] [024/132] (781s left) gem_exec_reloc (basic-cpu-noreloc)
[241.581646] Subtest basic-cpu-noreloc: SKIP (0.000s)
[241.687249] [025/132] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[241.784353] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[241.788898] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[241.914725] [026/132] (781s left) sw_sync (timeline_closed_signaled)
[241.956464] Starting subtest: timeline_closed_signaled
[241.958438] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[242.039743] [027/132] (781s left) gem_eio (context-create)
[242.305413] Starting subtest: context-create
[242.673073] Subtest context-create: SUCCESS (0.368s)
[242.805889] [028/132] (780s left) kms_fb_coherency (memset-crc)
[242.922681] Starting subtest: memset-crc
[242.924528] Starting dynamic subtest: mmap-offset-wc
[243.323950] Dynamic subtest mmap-offset-wc: SUCCESS (0.401s)
[243.613527] Starting dynamic subtest: mmap-offset-uc
[249.702073] Dynamic subtest mmap-offset-uc: SUCCESS (6.096s)
[249.997680] Subtest memset-crc: SUCCESS (7.076s)
[250.871849] [029/132] (772s left) gem_ctx_persistence (engines-hostile-preempt)
[250.933815] Starting subtest: engines-hostile-preempt
[250.936209] Starting dynamic subtest: rcs0
[250.988917] Dynamic subtest rcs0: SUCCESS (0.054s)
[250.999091] Starting dynamic subtest: bcs0
[251.081671] Dynamic subtest bcs0: SUCCESS (0.092s)
[251.090769] Starting dynamic subtest: vcs0
[252.901619] Dynamic subtest vcs0: SUCCESS (1.816s)
[252.912272] Starting dynamic subtest: vcs1
[254.917109] Dynamic subtest vcs1: SUCCESS (2.012s)
[254.925911] Starting dynamic subtest: vecs0
[256.931884] Dynamic subtest vecs0: SUCCESS (2.013s)
[256.945993] Starting dynamic subtest: ccs0
[256.970399] Dynamic subtest ccs0: SUCCESS (0.037s)
[256.972870] Subtest engines-hostile-preempt: SUCCESS (6.036s)
[257.110403] [030/132] (766s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[257.219384] Starting subtest: psr-rgb565-draw-pwrite
[264.234422] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.017s)
[264.369552] [031/132] (758s left) gem_render_copy (y-tiled-to-vebox-linear)
[264.443059] Starting subtest: y-tiled-to-vebox-linear
[264.447763] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[264.651168] [032/132] (758s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[264.715869] Starting subtest: multi-wait-for-submit-submitted-signaled
[264.718256] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[264.855967] [033/132] (758s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[264.959389] Starting subtest: x-tiled-64bpp-rotate-90
[264.981210] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[265.114675] [034/132] (758s left) kms_psr (fbc-psr2-cursor-render)
[265.209307] Starting subtest: fbc-psr2-cursor-render
[265.211635] Starting dynamic subtest: eDP-1
[265.215775] Dynamic subtest eDP-1: SKIP (0.000s)
[265.219937] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[265.304264] [035/132] (758s left) kms_getfb (getfb-handle-protection)
[265.405607] Starting subtest: getfb-handle-protection
[265.426230] Subtest getfb-handle-protection: SUCCESS (0.022s)
[265.581314] [036/132] (757s left) sw_sync (sync_merge_invalid)
[265.620529] Starting subtest: sync_merge_invalid
[265.644254] Subtest sync_merge_invalid: SUCCESS (0.025s)
[265.739603] [037/132] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[265.845915] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[270.524852] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.681s)
[271.692780] [038/132] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[271.789118] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[279.094422] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.308s)
[279.247888] [039/132] (744s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[279.364675] Starting subtest: cursorB-vs-flipA-toggle
[279.369380] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[279.530697] [040/132] (744s left) kms_rmfb (rmfb-ioctl)
[279.631281] Starting subtest: rmfb-ioctl
[279.633259] Starting dynamic subtest: pipe-A-eDP-1
[279.735128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[279.748869] Starting dynamic subtest: pipe-B-eDP-1
[280.958795] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s)
[280.970900] Starting dynamic subtest: pipe-C-eDP-1
[282.176348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s)
[282.186014] Starting dynamic subtest: pipe-D-eDP-1
[283.307336] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[283.309680] Subtest rmfb-ioctl: SUCCESS (3.679s)
[284.569546] [041/132] (739s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[284.969332] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[285.744425] [042/132] (737s left) sysfs_timeslice_duration (invalid)
[285.803036] Starting subtest: invalid
[285.805506] Starting dynamic subtest: vecs0
[285.807979] Dynamic subtest vecs0: SUCCESS (0.000s)
[285.821731] Starting dynamic subtest: ccs0
[285.823775] Dynamic subtest ccs0: SUCCESS (0.000s)
[285.835851] Starting dynamic subtest: vcs0
[285.837991] Dynamic subtest vcs0: SUCCESS (0.000s)
[285.847798] Starting dynamic subtest: bcs0
[285.849766] Dynamic subtest bcs0: SUCCESS (0.000s)
[285.857237] Starting dynamic subtest: rcs0
[285.859667] Dynamic subtest rcs0: SUCCESS (0.000s)
[285.867426] Starting dynamic subtest: vcs1
[285.870174] Dynamic subtest vcs1: SUCCESS (0.000s)
[285.872406] Subtest invalid: SUCCESS (0.006s)
[285.936061] [043/132] (737s left) syncobj_eventfd (timeline-wait)
[285.994764] Starting subtest: timeline-wait
[286.003299] Subtest timeline-wait: SUCCESS (0.010s)
[286.128125] [044/132] (737s left) kms_pm_backlight (brightness-with-dpms)
[286.226994] Starting subtest: brightness-with-dpms
[286.273921] Starting dynamic subtest: eDP-1
[288.701468] Dynamic subtest eDP-1: SUCCESS (2.427s)
[288.703796] Subtest brightness-with-dpms: SUCCESS (2.476s)
[289.596488] [045/132] (734s left) kms_busy (extended-modeset-hang-oldfb)
[289.696905] Starting subtest: extended-modeset-hang-oldfb
[289.699232] Starting dynamic subtest: pipe-A
[301.555254] Dynamic subtest pipe-A: SUCCESS (11.858s)
[301.565295] Starting dynamic subtest: pipe-D
[313.836484] Dynamic subtest pipe-D: SUCCESS (12.279s)
[313.838887] Subtest extended-modeset-hang-oldfb: SUCCESS (24.141s)
[314.670006] [046/132] (709s left) syncobj_wait (multi-wait-all-signaled)
[314.747511] Starting subtest: multi-wait-all-signaled
[314.749830] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[314.883285] [047/132] (709s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[314.974101] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[314.976271] Starting dynamic subtest: pipe-A-eDP-1
[314.998033] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.007126] Starting dynamic subtest: pipe-B-eDP-1
[315.029061] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.039757] Starting dynamic subtest: pipe-C-eDP-1
[315.060978] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.069200] Starting dynamic subtest: pipe-D-eDP-1
[315.090269] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.094615] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[317.152390] [048/132] (706s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[317.272275] Starting subtest: yf-tiled-8bpp-rotate-180
[317.277137] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[317.400458] [049/132] (706s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[317.508979] Starting subtest: psr-rgb565-draw-mmap-cpu
[324.404355] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.897s)
[324.547407] [050/132] (699s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[324.659645] Starting subtest: yf-tiled-16bpp-rotate-90
[324.663923] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[324.788873] [051/132] (699s left) kms_addfb_basic (clobberred-modifier)
[324.855754] Starting subtest: clobberred-modifier
[324.860893] Subtest clobberred-modifier: SKIP (0.000s)
[325.034030] [052/132] (699s left) gem_exec_reloc (basic-write-read-active)
[325.104330] Subtest basic-write-read-active: SKIP (0.000s)
[325.188852] [053/132] (698s left) dmabuf (all-tests)
[325.222856] Starting subtest: all-tests
[325.225232] Starting dynamic subtest: sanitycheck
[325.399384] Dynamic subtest sanitycheck: SUCCESS (0.175s)
[325.409527] Starting dynamic subtest: dma_fence
[325.670859] Dynamic subtest dma_fence: SUCCESS (0.270s)
[325.681953] Starting dynamic subtest: dma_fence_chain
[334.009382] Dynamic subtest dma_fence_chain: SUCCESS (8.336s)
[334.021042] Starting dynamic subtest: dma_fence_unwrap
[334.136840] Dynamic subtest dma_fence_unwrap: SUCCESS (0.124s)
[334.147967] Starting dynamic subtest: dma_resv
[334.272809] Dynamic subtest dma_resv: SUCCESS (0.134s)
[334.275660] Subtest all-tests: SUCCESS (9.049s)
[334.361117] [054/132] (689s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[334.663020] Starting subtest: cursor-rapid-movement-512x170
[334.667558] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[334.849543] [055/132] (689s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[334.913641] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[334.916065] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[335.059912] [056/132] (689s left) kms_big_fb (linear-16bpp-rotate-90)
[335.170077] Starting subtest: linear-16bpp-rotate-90
[335.189778] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[335.348762] [057/132] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[335.448159] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[335.451705] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[335.575753] [058/132] (688s left) gem_exec_schedule (noreorder-priority)
[335.761528] Starting subtest: noreorder-priority
[335.763831] Starting dynamic subtest: rcs0
[336.917119] Dynamic subtest rcs0: SUCCESS (1.155s)
[336.928654] Starting dynamic subtest: vcs0
[338.932220] Dynamic subtest vcs0: SUCCESS (2.012s)
[338.943748] Starting dynamic subtest: vcs1
[340.868642] Dynamic subtest vcs1: SUCCESS (1.933s)
[340.879700] Starting dynamic subtest: vecs0
[342.917057] Dynamic subtest vecs0: SUCCESS (2.045s)
[342.928311] Starting dynamic subtest: ccs0
[344.065889] Dynamic subtest ccs0: SUCCESS (1.148s)
[344.068504] Subtest noreorder-priority: SUCCESS (8.305s)
[344.275279] [059/132] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[344.383381] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[351.056371] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.674s)
[351.241197] [060/132] (673s left) perf (polling-small-buf)
[351.371424] Starting subtest: polling-small-buf
[351.462739] Subtest polling-small-buf: SUCCESS (0.088s)
[351.509222] [061/132] (672s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[351.603180] Starting subtest: bad-pixel-format-y-tiled-ccs
[351.605594] Starting dynamic subtest: pipe-A-eDP-1
[351.628493] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[351.638969] Starting dynamic subtest: pipe-B-eDP-1
[351.659701] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[351.667460] Starting dynamic subtest: pipe-C-eDP-1
[351.687917] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[351.695461] Starting dynamic subtest: pipe-D-eDP-1
[351.716443] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[351.720616] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.008s)
[353.878998] [062/132] (670s left) i915_drm_fdinfo (busy-hang)
[353.916456] Starting subtest: busy-hang
[353.918660] Starting dynamic subtest: rcs0
[353.953628] Dynamic subtest rcs0: SKIP (0.035s)
[353.964050] Starting dynamic subtest: bcs0
[353.968598] Dynamic subtest bcs0: SKIP (0.001s)
[353.979184] Starting dynamic subtest: vcs0
[353.983420] Dynamic subtest vcs0: SKIP (0.001s)
[353.991226] Starting dynamic subtest: vcs1
[353.995080] Dynamic subtest vcs1: SKIP (0.000s)
[354.002813] Starting dynamic subtest: vecs0
[354.006673] Dynamic subtest vecs0: SKIP (0.000s)
[354.014232] Starting dynamic subtest: ccs0
[354.018413] Dynamic subtest ccs0: SKIP (0.000s)
[354.022543] Subtest busy-hang: SKIP (0.042s)
[354.058948] [063/132] (670s left) kms_cursor_crc (cursor-sliding-max-size)
[354.375731] Starting subtest: cursor-sliding-max-size
[354.382601] Subtest cursor-sliding-max-size: SKIP (0.000s)
[354.537199] [064/132] (670s left) gem_exec_schedule (preempt-queue-contexts-chain)
[354.621439] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[354.936978] [065/132] (669s left) gem_mmap_gtt (big-copy)
[354.996697] Subtest big-copy: SKIP (0.000s)
[355.060319] [066/132] (669s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[355.158318] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[355.160482] Starting dynamic subtest: pipe-A
[355.220856] Dynamic subtest pipe-A: SUCCESS (0.065s)
[355.229338] Starting dynamic subtest: pipe-B
[356.387185] Dynamic subtest pipe-B: SUCCESS (1.165s)
[356.398400] Starting dynamic subtest: pipe-C
[357.513234] Dynamic subtest pipe-C: SUCCESS (1.124s)
[357.521580] Starting dynamic subtest: pipe-D
[358.635542] Dynamic subtest pipe-D: SUCCESS (1.121s)
[358.637867] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.480s)
[359.812331] [067/132] (664s left) kms_chamelium_color (ctm-0-50)
[359.925489] Subtest ctm-0-50: SKIP (0.000s)
[359.970638] [068/132] (664s left) kms_psr (pr-primary-page-flip)
[360.062272] Starting subtest: pr-primary-page-flip
[360.066500] Subtest pr-primary-page-flip: SKIP (0.000s)
[360.156534] [069/132] (664s left) kms_atomic (test-only)
[360.252247] Starting subtest: test-only
[360.299975] Starting dynamic subtest: pipe-A-eDP-1
[362.818178] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.520s)
[362.820426] Subtest test-only: SUCCESS (2.569s)
[363.697889] [070/132] (661s left) gem_spin_batch (spin-each)
[363.758225] Starting subtest: spin-each
[367.115592] Subtest spin-each: SUCCESS (3.357s)
[368.985428] [071/132] (655s left) gem_exec_params (batch-first)
[369.044279] Starting subtest: batch-first
[369.052756] Subtest batch-first: SUCCESS (0.011s)
[369.223177] [072/132] (655s left) gem_busy (semaphore)
[369.401911] Subtest semaphore: SKIP (0.000s)
[369.644906] [073/132] (655s left) kms_psr (pr-primary-blt)
[369.751066] Starting subtest: pr-primary-blt
[369.755164] Subtest pr-primary-blt: SKIP (0.000s)
[369.854957] [074/132] (655s left) kms_dp_link_training (uhbr-mst)
[369.950069] Starting subtest: uhbr-mst
[369.958244] Subtest uhbr-mst: SKIP (0.000s)
[370.047060] [075/132] (654s left) i915_suspend (debugfs-reader)
[370.110276] Starting subtest: debugfs-reader
[388.617592] Subtest debugfs-reader: SUCCESS (7.329s)
[397.678212] [076/132] (636s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[397.805985] Starting subtest: compare-crc-sanitycheck-nv12
[397.808345] Starting dynamic subtest: pipe-A-eDP-1
[398.557369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[398.568433] Starting dynamic subtest: pipe-B-eDP-1
[399.868486] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.262s)
[399.878280] Starting dynamic subtest: pipe-C-eDP-1
[401.188626] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[401.199125] Starting dynamic subtest: pipe-D-eDP-1
[402.456873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[402.459177] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.501s)
[403.314106] [077/132] (630s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[403.425928] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[403.429881] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[403.560510] [078/132] (630s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[403.663724] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[403.668204] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[404.879713] [079/132] (629s left) perf_pmu (busy-idle-check-all)
[404.928599] Starting subtest: busy-idle-check-all
[404.931552] Starting dynamic subtest: rcs0
[405.608496] Dynamic subtest rcs0: SUCCESS (0.671s)
[405.621088] Starting dynamic subtest: bcs0
[406.272246] Dynamic subtest bcs0: SUCCESS (0.651s)
[406.284666] Starting dynamic subtest: vcs0
[406.995974] Dynamic subtest vcs0: FAIL (0.642s)
[407.007240] Starting dynamic subtest: vcs1
[407.640909] Dynamic subtest vcs1: FAIL (0.620s)
[407.652243] Starting dynamic subtest: vecs0
[408.267938] Dynamic subtest vecs0: FAIL (0.620s)
[408.279502] Starting dynamic subtest: ccs0
[408.897285] Dynamic subtest ccs0: FAIL (0.623s)
[408.899391] Subtest busy-idle-check-all: FAIL (3.837s)
[410.215111] [080/132] (623s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[410.316168] Starting subtest: psr-2p-pri-indfb-multidraw
[410.320382] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[410.458559] [081/132] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[410.555439] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[410.559743] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[410.690691] [082/132] (623s left) gem_exec_balancer (fairslice)
[410.751500] Starting subtest: fairslice
[413.649638] Subtest fairslice: SUCCESS (2.876s)
[414.166310] [083/132] (620s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[414.223613] Starting subtest: etime-single-wait-all-available-unsubmitted
[414.324591] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[414.431674] [084/132] (619s left) gem_exec_fence (syncobj-timeline-chain-engines)
[414.997419] Starting subtest: syncobj-timeline-chain-engines
[415.162550] Subtest syncobj-timeline-chain-engines: SUCCESS (0.165s)
[416.154788] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[416.158418] [085/132] (618s left) gem_pread (display)
[416.228101] Subtest display: SKIP (0.000s)
[416.296837] [086/132] (618s left) gem_sync (basic-all)
[416.371296] Starting subtest: basic-all
[420.034810] Subtest basic-all: SUCCESS (3.659s)
[420.246845] [087/132] (614s left) gem_mmap_offset (isolation)
[420.303379] Starting subtest: isolation
[420.322067] Subtest isolation: SUCCESS (0.006s)
[420.442314] [088/132] (614s left) kms_atomic_interruptible (legacy-dpms)
[420.546675] Starting subtest: legacy-dpms
[420.549010] Starting dynamic subtest: pipe-A-eDP-1
[428.006162] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.444s)
[428.008175] Subtest legacy-dpms: SUCCESS (7.445s)
[428.871007] [089/132] (605s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[428.984693] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[428.989110] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[429.109422] [090/132] (605s left) gem_flink_basic (bad-open)
[429.168858] Starting subtest: bad-open
[429.171198] Subtest bad-open: SUCCESS (0.000s)
[429.297938] [091/132] (605s left) kms_invalid_mode (int-max-clock)
[429.401003] Starting subtest: int-max-clock
[429.403194] Starting dynamic subtest: pipe-A-eDP-1
[429.688348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[429.699021] Starting dynamic subtest: pipe-B-eDP-1
[429.701354] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[429.710570] Starting dynamic subtest: pipe-C-eDP-1
[429.712994] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[429.722158] Starting dynamic subtest: pipe-D-eDP-1
[429.724121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[429.726118] Subtest int-max-clock: SUCCESS (0.297s)
[430.505197] [092/132] (604s left) gem_exec_params (mmapped)
[430.562209] Starting subtest: mmapped
[430.567519] Subtest mmapped: SUCCESS (0.002s)
[430.713272] [093/132] (604s left) kms_plane_multiple (tiling-x)
[430.804747] Starting subtest: tiling-x
[430.807147] Starting dynamic subtest: pipe-A-eDP-1
[434.514662] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.708s)
[434.525015] Starting dynamic subtest: pipe-B-eDP-1
[438.868144] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.351s)
[438.878615] Starting dynamic subtest: pipe-C-eDP-1
[443.190353] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.319s)
[443.205717] Starting dynamic subtest: pipe-D-eDP-1
[447.535293] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.339s)
[447.537680] Subtest tiling-x: SUCCESS (16.722s)
[448.378622] [094/132] (586s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[448.485124] Starting subtest: fbc-rgb101010-draw-pwrite
[453.832288] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.348s)
[454.983499] [095/132] (579s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[455.090322] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[462.004440] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.912s)
[462.213135] [096/132] (572s left) kms_flip (2x-flip-vs-dpms)
[462.307100] Starting subtest: 2x-flip-vs-dpms
[462.318801] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[462.449038] [097/132] (572s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[462.549159] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[462.560908] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[462.699018] [098/132] (572s left) kms_content_protection (atomic-hdcp14)
[462.839062] Starting subtest: atomic-hdcp14
[462.843442] Subtest atomic-hdcp14: SKIP (0.000s)
[462.996738] [099/132] (572s left) sw_sync (sync_merge)
[463.036747] Starting subtest: sync_merge
[463.038603] Subtest sync_merge: SUCCESS (0.000s)
[463.116017] [100/132] (571s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[463.210905] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[463.212869] Starting dynamic subtest: pipe-A-default-mode
[463.501893] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[463.506286] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.288s)
[464.340094] [101/132] (570s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[464.466676] Starting subtest: cursor-vs-flip-atomic-transitions
[494.407095] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.928s)
[495.280927] [102/132] (539s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[495.382679] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[495.384833] Starting dynamic subtest: pipe-A-eDP-1
[495.443204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[495.738322] Starting dynamic subtest: pipe-B-eDP-1
[496.553070] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.824s)
[496.859005] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.477s)
[497.734134] [103/132] (537s left) kms_prime (basic-crc-vgem)
[497.818417] Starting subtest: basic-crc-vgem
[497.820825] Starting dynamic subtest: second-to-first
[498.778974] Dynamic subtest second-to-first: SUCCESS (0.965s)
[498.781086] Subtest basic-crc-vgem: SUCCESS (0.966s)
[498.896423] [104/132] (536s left) kms_properties (invalid-properties-legacy)
[499.031790] Starting subtest: invalid-properties-legacy
[499.136391] Subtest invalid-properties-legacy: SUCCESS (0.104s)
[499.231940] [105/132] (536s left) syncobj_timeline (wait-zero-handles)
[499.288762] Starting subtest: wait-zero-handles
[499.290791] Subtest wait-zero-handles: SUCCESS (0.000s)
[499.409690] [106/132] (535s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[504.418698] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[504.423586] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[505.290616] [107/132] (530s left) gem_pxp (reject-modify-context-protection-off-1)
[505.414877] Starting subtest: reject-modify-context-protection-off-1
[505.417196] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[505.566833] [108/132] (529s left) kms_selftest (drm_format_helper)
[505.604338] Starting subtest: drm_format_helper
[505.615988] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[505.742685] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.127s)
[505.754068] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[505.857088] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.114s)
[505.867049] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[505.983176] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.123s)
[505.992260] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[506.118995] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.136s)
[506.128598] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[506.233200] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.111s)
[506.242334] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[506.392644] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.159s)
[506.403259] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[506.521041] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.128s)
[506.530408] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[506.665952] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.145s)
[506.675208] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[506.820617] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.153s)
[506.830635] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[506.954871] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.133s)
[506.966000] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[507.081622] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.126s)
[507.092260] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[507.216831] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.135s)
[507.227430] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[507.347374] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.130s)
[507.356630] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[507.477776] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.128s)
[507.488135] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[507.585717] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.108s)
[507.596398] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[507.706965] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.120s)
[507.717384] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[507.850874] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.144s)
[507.852983] Subtest drm_format_helper: SUCCESS (2.248s)
[508.074189] [109/132] (527s left) gen3_mixed_blits
[508.217149] [110/132] (527s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[508.331541] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[508.335414] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[508.463111] [111/132] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[508.574817] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[515.352955] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.781s)
[515.501435] [112/132] (520s left) gen7_exec_parse (cmd-crossing-page)
[515.564077] Subtest cmd-crossing-page: SKIP (0.000s)
[515.651458] [113/132] (519s left) gem_softpin (overlap)
[515.713593] Starting subtest: overlap
[516.610324] Subtest overlap: SUCCESS (0.895s)
[516.779129] [114/132] (518s left) gem_eio (in-flight-internal-immediate)
[517.016549] Starting subtest: in-flight-internal-immediate
[518.168406] Subtest in-flight-internal-immediate: SUCCESS (1.151s)
[518.344344] [115/132] (517s left) gem_wait (write-wait)
[518.411821] Starting subtest: write-wait
[518.414205] Starting dynamic subtest: all-engines
[519.560550] Dynamic subtest all-engines: SUCCESS (1.148s)
[519.577923] Starting dynamic subtest: rcs0
[520.619324] Dynamic subtest rcs0: SUCCESS (1.057s)
[520.636780] Starting dynamic subtest: bcs0
[521.677870] Dynamic subtest bcs0: SUCCESS (1.056s)
[521.695060] Starting dynamic subtest: vcs0
[522.732388] Dynamic subtest vcs0: SUCCESS (1.052s)
[522.750407] Starting dynamic subtest: vcs1
[523.783974] Dynamic subtest vcs1: SUCCESS (1.050s)
[523.800751] Starting dynamic subtest: vecs0
[524.838274] Dynamic subtest vecs0: SUCCESS (1.052s)
[524.854838] Starting dynamic subtest: ccs0
[525.895606] Dynamic subtest ccs0: SUCCESS (1.055s)
[525.898502] Subtest write-wait: SUCCESS (7.484s)
[526.121288] [116/132] (509s left) kms_chamelium_edid (dp-edid-read)
[526.517893] Subtest dp-edid-read: SKIP (0.000s)
[527.371946] [117/132] (508s left) gem_exec_balancer (parallel-bb-first)
[527.633950] Starting subtest: parallel-bb-first
[528.558189] Subtest parallel-bb-first: SUCCESS (0.923s)
[529.151871] [118/132] (506s left) kms_pm_rpm (fences)
[531.281969] Starting subtest: fences
[531.286959] Subtest fences: SKIP (0.000s)
[531.652965] [119/132] (504s left) gem_ctx_persistence (legacy-engines-queued)
[531.727069] Starting subtest: legacy-engines-queued
[531.729545] Starting dynamic subtest: render
[531.852153] Dynamic subtest render: SUCCESS (0.124s)
[531.867044] Starting dynamic subtest: bsd1
[533.023174] Dynamic subtest bsd1: SUCCESS (1.166s)
[533.035978] Starting dynamic subtest: bsd2
[535.071164] Dynamic subtest bsd2: SUCCESS (2.044s)
[535.083628] Starting dynamic subtest: blt
[535.167522] Dynamic subtest blt: SUCCESS (0.094s)
[535.179415] Starting dynamic subtest: vebox
[537.055591] Dynamic subtest vebox: SUCCESS (1.883s)
[537.058583] Subtest legacy-engines-queued: SUCCESS (5.327s)
[537.161257] [120/132] (498s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[537.270439] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[537.960944] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[538.179445] [121/132] (497s left) gem_mmap_gtt (basic-wc)
[538.249225] Subtest basic-wc: SKIP (0.000s)
[538.321775] [122/132] (497s left) core_auth (getclient-simple)
[538.356450] Starting subtest: getclient-simple
[538.382227] Subtest getclient-simple: SUCCESS (0.029s)
[538.529345] [123/132] (497s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[538.637808] Starting subtest: addfb25-y-tiled-small-legacy
[538.641654] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[538.756982] [124/132] (497s left) perf (invalid-oa-exponent)
[538.863837] Starting subtest: invalid-oa-exponent
[538.873613] Subtest invalid-oa-exponent: SUCCESS (0.010s)
[538.917457] [125/132] (497s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[539.027211] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[539.028995] Starting dynamic subtest: pipe-A-default-mode
[540.192290] Dynamic subtest pipe-A-default-mode: SKIP (1.161s)
[540.196309] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.163s)
[540.391770] [126/132] (495s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[540.487905] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[540.490243] Starting dynamic subtest: A-eDP1
[544.081884] Dynamic subtest A-eDP1: SUCCESS (3.591s)
[544.092954] Starting dynamic subtest: B-eDP1
[547.288989] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[547.299879] Starting dynamic subtest: C-eDP1
[550.385053] Dynamic subtest C-eDP1: SUCCESS (3.096s)
[550.396939] Starting dynamic subtest: D-eDP1
[553.499050] Dynamic subtest D-eDP1: SUCCESS (3.110s)
[553.501030] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.008s)
[554.322853] [127/132] (481s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[554.386610] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[554.388607] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[554.526163] [128/132] (481s left) kms_vrr (max-min)
[554.626715] Starting subtest: max-min
[554.633349] Subtest max-min: SKIP (0.000s)
[554.724354] [129/132] (481s left) kms_rotation_crc (sprite-rotation-90)
[554.818738] Starting subtest: sprite-rotation-90
[554.823242] Subtest sprite-rotation-90: SKIP (0.001s)
[554.916971] [130/132] (481s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[555.017646] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[555.021999] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.145953] [131/132] (481s left) kms_cursor_crc (cursor-offscreen-64x64)
[555.311691] Starting subtest: cursor-offscreen-64x64
[555.316178] Starting dynamic subtest: pipe-A-eDP-1
[557.252874] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[557.283326] Starting dynamic subtest: pipe-D-eDP-1
[559.916686] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.641s)
[559.918954] Subtest cursor-offscreen-64x64: SUCCESS (4.603s)
[560.797885] [132/132] (475s left) kms_color_pipeline (plane-lut1d-lut1d)
[560.896410] Starting subtest: plane-lut1d-lut1d
[560.909501] Starting dynamic subtest: pipe-A-eDP-1
[561.635439] Dynamic subtest pipe-A-eDP-1: FAIL (0.316s)
[562.262502] Starting dynamic subtest: pipe-B-eDP-1
[563.085104] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[563.588987] Starting dynamic subtest: pipe-C-eDP-1
[564.461824] Dynamic subtest pipe-C-eDP-1: FAIL (0.278s)
[564.921259] Starting dynamic subtest: pipe-D-eDP-1
[565.757688] Dynamic subtest pipe-D-eDP-1: FAIL (0.247s)
[565.759733] Subtest plane-lut1d-lut1d: FAIL (4.549s)
[566.321199] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_store
results: parsing output: 1/ for test: gem_pread
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_plane_cursor
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: gem_ppgtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_ctx_engines
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: i915_pciid
results: parsing output: 22/ for test: i915_pm_rpm
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: sw_sync
results: parsing output: 26/ for test: gem_eio
results: parsing output: 27/ for test: kms_fb_coherency
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_getfb
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_rmfb
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: sysfs_timeslice_duration
results: parsing output: 42/ for test: syncobj_eventfd
results: parsing output: 43/ for test: kms_pm_backlight
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: dmabuf
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_chamelium_color
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_atomic
results: parsing output: 69/ for test: gem_spin_batch
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: gem_busy
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_dp_link_training
results: parsing output: 74/ for test: i915_suspend
results: parsing output: 75/ for test: kms_pipe_crc_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_pread
results: parsing output: 85/ for test: gem_sync
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: kms_atomic_interruptible
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_flink_basic
results: parsing output: 90/ for test: kms_invalid_mode
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_plane_multiple
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_prime
results: parsing output: 103/ for test: kms_properties
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_selftest
results: parsing output: 108/ for test: gen3_mixed_blits
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gen7_exec_parse
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: gem_wait
results: parsing output: 115/ for test: kms_chamelium_edid
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: core_auth
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_vrr
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_color_pipeline
Done.