[62.104087] Initializing watchdogs
[62.104133]   /dev/watchdog0
[62.118328] [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]
[62.122908] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.125057] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.127273] [001/133] (960s left) kms_rotation_crc (bad-pixel-format)
[62.231781] Starting subtest: bad-pixel-format
[62.233561] Subtest bad-pixel-format: SKIP (0.001s)
[62.320987] [002/133] (960s left) vgem_basic (debugfs)
[62.379756] Starting subtest: debugfs
[62.380672] Subtest debugfs: SUCCESS (0.000s)
[62.458447] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[62.460200] [003/133] (960s left) gem_pxp (create-valid-protected-context)
[62.588431] Starting subtest: create-valid-protected-context
[62.590556] Subtest create-valid-protected-context: SUCCESS (0.002s)
[62.731421] [004/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[62.822053] Starting subtest: psr-1p-rte
[68.413143] Subtest psr-1p-rte: SUCCESS (5.593s)
[68.579321] [005/133] (954s left) syncobj_basic (bad-flags-handle-to-fd)
[68.633381] Starting subtest: bad-flags-handle-to-fd
[68.634404] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[68.749427] [006/133] (954s left) gen9_exec_parse (bb-secure)
[68.811558] Subtest bb-secure: SKIP (0.000s)
[68.879313] [007/133] (953s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[68.982479] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[68.984778] Starting dynamic subtest: A-eDP1
[77.908095] Dynamic subtest A-eDP1: SUCCESS (8.923s)
[77.915422] Starting dynamic subtest: B-eDP1
[86.846660] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[86.855510] Starting dynamic subtest: C-eDP1
[95.761837] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[95.769623] Starting dynamic subtest: D-eDP1
[104.689735] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[104.692413] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.709s)
[105.928235] [008/133] (916s left) kms_psr (psr-primary-render)
[106.022273] Starting subtest: psr-primary-render
[106.023231] Starting dynamic subtest: eDP-1
[107.716220] Dynamic subtest eDP-1: SUCCESS (1.693s)
[107.717185] Subtest psr-primary-render: SUCCESS (1.694s)
[108.599570] [009/133] (914s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[108.699192] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[108.701047] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[109.836639] [010/133] (913s left) kms_content_protection (lic-type-0)
[109.968232] Starting subtest: lic-type-0
[109.970316] Subtest lic-type-0: SKIP (0.000s)
[110.132326] [011/133] (912s left) kms_psr (psr2-cursor-plane-onoff)
[110.216082] Starting subtest: psr2-cursor-plane-onoff
[110.216989] Starting dynamic subtest: eDP-1
[111.874262] Dynamic subtest eDP-1: SUCCESS (1.658s)
[111.875125] Subtest psr2-cursor-plane-onoff: SUCCESS (1.659s)
[112.695641] [012/133] (910s left) syncobj_wait (reset-multiple-signaled)
[112.740212] Starting subtest: reset-multiple-signaled
[112.741762] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[112.891645] [013/133] (910s left) gem_mmap_gtt (hang-busy)
[112.943386] Subtest hang-busy: SKIP (0.000s)
[113.038268] [014/133] (910s left) syncobj_timeline (invalid-transfer-non-existent-point)
[113.096136] Starting subtest: invalid-transfer-non-existent-point
[113.097744] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[113.246507] [015/133] (909s left) kms_pm_rpm (modeset-pc8-residency-stress)
[115.074309] Starting subtest: modeset-pc8-residency-stress
[115.076541] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[115.514405] [016/133] (907s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[115.625905] Starting subtest: short-busy-flip-before-cursor-toggle
[115.627776] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[115.789561] [017/133] (907s left) gem_spin_batch (resubmit)
[115.846050] Starting subtest: resubmit
[115.847091] Starting dynamic subtest: rcs0
[115.852488] Dynamic subtest rcs0: SUCCESS (0.006s)
[115.860654] Starting dynamic subtest: bcs0
[115.861549] Dynamic subtest bcs0: SUCCESS (0.002s)
[115.867621] Starting dynamic subtest: vcs0
[115.868508] Dynamic subtest vcs0: SUCCESS (0.003s)
[115.874781] Starting dynamic subtest: vcs1
[115.875706] Dynamic subtest vcs1: SUCCESS (0.003s)
[115.881601] Starting dynamic subtest: vecs0
[115.882486] Dynamic subtest vecs0: SUCCESS (0.002s)
[115.888135] Starting dynamic subtest: ccs0
[115.888973] Dynamic subtest ccs0: SUCCESS (0.002s)
[115.889812] Subtest resubmit: SUCCESS (0.021s)
[116.128206] [018/133] (907s left) vgem_slow (nohang)
[116.163076] Starting subtest: nohang
[126.580510] Subtest nohang: SUCCESS (10.415s)
[126.659737] [019/133] (896s left) kms_getfb (getfb-reject-nv12)
[126.750133] Starting subtest: getfb-reject-nv12
[126.751067] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[126.893082] [020/133] (896s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[126.989277] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[126.990969] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[127.117258] [021/133] (896s left) gem_exec_fence (basic-wait-all)
[127.179755] Starting subtest: basic-wait-all
[127.308569] Subtest basic-wait-all: SUCCESS (0.128s)
[129.046208] [022/133] (894s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[129.131712] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[129.132665] Starting dynamic subtest: pipe-A-eDP-1
[162.390450] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.777s)
[162.397788] Starting dynamic subtest: pipe-B-eDP-1
[197.326348] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.473s)
[197.335343] Starting dynamic subtest: pipe-C-eDP-1
[232.330368] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.383s)
[232.338183] Starting dynamic subtest: pipe-D-eDP-1
[267.318620] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.370s)
[267.319768] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.007s)
[273.588229] [023/133] (754s left) gem_exec_params (invalid-ring)
[273.641270] Starting subtest: invalid-ring
[273.642303] Subtest invalid-ring: SUCCESS (0.000s)
[273.769451] [024/133] (754s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[273.865662] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[277.999413] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.128s)
[279.182649] [025/133] (749s left) kms_feature_discovery (display-1x)
[279.282480] Starting subtest: display-1x
[279.283739] Subtest display-1x: SUCCESS (0.000s)
[279.374770] [026/133] (749s left) gem_request_retire (retire-vma-not-inactive)
[279.424435] Starting subtest: retire-vma-not-inactive
[279.486809] Subtest retire-vma-not-inactive: SUCCESS (0.060s)
[279.636367] [027/133] (748s left) sysfs_preempt_timeout (timeout)
[279.687710] Starting subtest: timeout
[279.689062] Starting dynamic subtest: vecs0
[289.069006] Dynamic subtest vecs0: SUCCESS (9.372s)
[289.078156] Starting dynamic subtest: ccs0
[290.481506] Dynamic subtest ccs0: SUCCESS (1.413s)
[290.491658] Starting dynamic subtest: vcs0
[300.111020] Dynamic subtest vcs0: SUCCESS (9.626s)
[300.121971] Starting dynamic subtest: bcs0
[301.484917] Dynamic subtest bcs0: SUCCESS (1.373s)
[301.496457] Starting dynamic subtest: rcs0
[302.837206] Dynamic subtest rcs0: SUCCESS (1.351s)
[302.847381] Starting dynamic subtest: vcs1
[312.131841] Dynamic subtest vcs1: SUCCESS (9.293s)
[312.133429] Subtest timeout: SUCCESS (32.437s)
[312.222626] [028/133] (716s left) i915_drm_fdinfo (idle)
[312.254816] Starting subtest: idle
[312.256316] Starting dynamic subtest: rcs0
[312.839274] Dynamic subtest rcs0: SUCCESS (0.584s)
[312.849885] Starting dynamic subtest: bcs0
[313.346020] Dynamic subtest bcs0: SUCCESS (0.503s)
[313.355900] Starting dynamic subtest: vcs0
[313.851183] Dynamic subtest vcs0: SUCCESS (0.503s)
[313.860984] Starting dynamic subtest: vcs1
[314.356190] Dynamic subtest vcs1: SUCCESS (0.503s)
[314.365915] Starting dynamic subtest: vecs0
[314.860523] Dynamic subtest vecs0: SUCCESS (0.503s)
[314.870823] Starting dynamic subtest: ccs0
[315.365811] Dynamic subtest ccs0: SUCCESS (0.503s)
[315.367509] Subtest idle: SUCCESS (3.111s)
[315.457621] [029/133] (713s left) kms_big_fb (4-tiled-addfb-size-overflow)
[315.568529] Starting subtest: 4-tiled-addfb-size-overflow
[315.569771] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[315.693174] [030/133] (713s left) kms_plane_alpha_blend (constant-alpha-min)
[315.793218] Starting subtest: constant-alpha-min
[316.091988] Starting dynamic subtest: pipe-A-eDP-1
[316.791286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[316.801913] Starting dynamic subtest: pipe-D-eDP-1
[318.256679] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.466s)
[318.257792] Subtest constant-alpha-min: SUCCESS (2.466s)
[319.157400] [031/133] (709s left) gem_exec_alignment (many)
[319.222687] Starting subtest: many
[341.072926] Subtest many: SUCCESS (21.849s)
[343.023187] [032/133] (685s left) sw_sync (sync_busy)
[343.082874] Starting subtest: sync_busy
[343.084788] Subtest sync_busy: SUCCESS (0.002s)
[343.163771] [033/133] (685s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[343.274005] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[343.275295] Starting dynamic subtest: pipe-A-default-mode
[345.948294] Dynamic subtest pipe-A-default-mode: SUCCESS (2.674s)
[345.949456] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.676s)
[346.828926] [034/133] (682s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[346.931944] Starting subtest: plane-lut1d-pre-ctm3x4
[346.946405] Starting dynamic subtest: pipe-A-eDP-1
[347.411887] Dynamic subtest pipe-A-eDP-1: FAIL (0.313s)
[348.301782] Starting dynamic subtest: pipe-B-eDP-1
[348.805308] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[349.630799] Starting dynamic subtest: pipe-C-eDP-1
[350.144577] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[350.964124] Starting dynamic subtest: pipe-D-eDP-1
[351.537127] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[351.538511] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.559s)
[352.361434] [035/133] (676s left) i915_query (test-query-geometry-subslices)
[352.424034] Starting subtest: test-query-geometry-subslices
[352.425432] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[352.542715] [036/133] (676s left) kms_addfb_basic (bad-pitch-128)
[352.592239] Starting subtest: bad-pitch-128
[352.593373] Subtest bad-pitch-128: SUCCESS (0.000s)
[352.747778] [037/133] (676s left) kms_psr (pr-cursor-blt)
[352.833871] Starting subtest: pr-cursor-blt
[352.836409] Subtest pr-cursor-blt: SKIP (0.000s)
[352.926586] [038/133] (676s left) syncobj_basic (bad-pad-fd-to-handle)
[352.976998] Starting subtest: bad-pad-fd-to-handle
[352.978438] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[353.098155] [039/133] (675s left) gem_ctx_persistence (legacy-engines-hang)
[353.161392] Starting subtest: legacy-engines-hang
[353.162911] Starting dynamic subtest: render
[353.309233] Dynamic subtest render: SUCCESS (0.147s)
[353.320303] Starting dynamic subtest: bsd1
[353.429905] Dynamic subtest bsd1: SUCCESS (0.118s)
[353.442861] Starting dynamic subtest: bsd2
[353.555865] Dynamic subtest bsd2: SUCCESS (0.123s)
[353.568992] Starting dynamic subtest: blt
[353.673272] Dynamic subtest blt: SUCCESS (0.115s)
[353.686227] Starting dynamic subtest: vebox
[353.793954] Dynamic subtest vebox: SUCCESS (0.117s)
[353.795780] Subtest legacy-engines-hang: SUCCESS (0.633s)
[353.891267] [040/133] (675s left) kms_pipe_crc_basic (read-crc)
[353.981987] Starting subtest: read-crc
[353.983177] Starting dynamic subtest: pipe-A-eDP-1
[354.675527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[354.684578] Starting dynamic subtest: pipe-B-eDP-1
[356.016304] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s)
[356.024465] Starting dynamic subtest: pipe-C-eDP-1
[357.411003] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[357.419217] Starting dynamic subtest: pipe-D-eDP-1
[358.712312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[358.713612] Subtest read-crc: SUCCESS (4.730s)
[359.592533] [041/133] (669s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[359.703705] Starting subtest: short-flip-before-cursor-toggle
[360.639608] Subtest short-flip-before-cursor-toggle: SUCCESS (0.935s)
[361.529388] [042/133] (667s left) gem_partial_pwrite_pread (writes-after-reads)
[361.589895] Subtest writes-after-reads: SKIP (0.000s)
[361.645266] [043/133] (667s left) gem_mmap_gtt (big-bo-tiledy)
[361.694645] Subtest big-bo-tiledY: SKIP (0.000s)
[361.753686] [044/133] (667s left) gem_exec_reloc (basic-gtt-wc)
[361.820555] Subtest basic-gtt-wc: SKIP (0.000s)
[361.878289] [045/133] (667s left) gem_pread (display)
[361.934016] Subtest display: SKIP (0.000s)
[361.991602] [046/133] (667s left) kms_chamelium_hpd (hdmi-hpd-storm)
[362.374989] Subtest hdmi-hpd-storm: SKIP (0.000s)
[363.215319] [047/133] (666s left) gem_exec_schedule (fairslice)
[363.284706] Starting subtest: fairslice
[363.285922] Starting dynamic subtest: rcs0
[365.302000] Dynamic subtest rcs0: SUCCESS (2.019s)
[365.312568] Starting dynamic subtest: bcs0
[367.324346] Dynamic subtest bcs0: SUCCESS (2.020s)
[367.333809] Starting dynamic subtest: vcs0
[369.344606] Dynamic subtest vcs0: SUCCESS (2.019s)
[369.354379] Starting dynamic subtest: vcs1
[371.364814] Dynamic subtest vcs1: SUCCESS (2.020s)
[371.378345] Starting dynamic subtest: vecs0
[373.383764] Dynamic subtest vecs0: SUCCESS (2.019s)
[373.393587] Starting dynamic subtest: ccs0
[375.404359] Dynamic subtest ccs0: SUCCESS (2.020s)
[375.405652] Subtest fairslice: SUCCESS (12.121s)
[375.723237] [048/133] (653s left) kms_vrr (flip-basic)
[375.816658] Starting subtest: flip-basic
[375.820978] Subtest flip-basic: SKIP (0.000s)
[375.920005] [049/133] (653s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[376.004428] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[376.005664] Starting dynamic subtest: pipe-A-eDP-1
[376.015812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[376.024021] Starting dynamic subtest: pipe-B-eDP-1
[376.033667] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[376.042190] Starting dynamic subtest: pipe-C-eDP-1
[376.051622] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[376.059586] Starting dynamic subtest: pipe-D-eDP-1
[376.070067] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[376.071760] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[378.317322] [050/133] (651s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[378.424306] Starting subtest: protected-encrypted-src-copy-not-readible
[378.560898] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.136s)
[378.712280] [051/133] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[378.813433] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[378.815879] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[378.942412] [052/133] (650s left) gem_exec_whisper (basic-contexts-forked)
[378.997355] Starting subtest: basic-contexts-forked
[402.604593] Subtest basic-contexts-forked: SUCCESS (23.603s)
[402.804186] [053/133] (626s left) gem_exec_fence (syncobj-timeline-chain-engines)
[403.408995] Starting subtest: syncobj-timeline-chain-engines
[403.623495] Subtest syncobj-timeline-chain-engines: SUCCESS (0.214s)
[405.232822] [054/133] (624s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[405.325133] Starting subtest: primary-yf-tiled-reflect-x-0
[405.385587] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[405.502066] [055/133] (624s left) syncobj_timeline (wait-all-for-submit-complex)
[405.556402] Starting subtest: wait-all-for-submit-complex
[405.772865] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[405.868278] [056/133] (623s left) gem_exec_flush (basic-uc-prw-default)
[405.925472] Starting subtest: basic-uc-prw-default
[411.390342] Subtest basic-uc-prw-default: SUCCESS (5.464s)
[411.599082] [057/133] (618s left) kms_psr (fbc-psr2-primary-page-flip)
[411.710483] Starting subtest: fbc-psr2-primary-page-flip
[411.711499] Starting dynamic subtest: eDP-1
[411.713524] Dynamic subtest eDP-1: SKIP (0.000s)
[411.715392] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[411.809513] [058/133] (617s left) kms_vblank (ts-continuation-idle-hang)
[411.899377] Starting subtest: ts-continuation-idle-hang
[411.900496] Starting dynamic subtest: pipe-A-eDP-1
[437.894272] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.991s)
[437.906648] Starting dynamic subtest: pipe-D-eDP-1
[452.843289] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.947s)
[452.844392] Subtest ts-continuation-idle-hang: SUCCESS (40.942s)
[453.678317] [059/133] (576s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[453.800637] Starting subtest: x-tiled-16bpp-rotate-180
[455.179569] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.380s)
[455.335794] [060/133] (574s left) kms_psr (fbc-pr-cursor-plane-onoff)
[455.428649] Starting subtest: fbc-pr-cursor-plane-onoff
[455.431215] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[455.522991] [061/133] (574s left) kms_async_flips (crc-atomic)
[455.612425] Starting subtest: crc-atomic
[455.991844] Starting dynamic subtest: pipe-A-eDP-1
[458.887556] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.896s)
[459.272780] Starting dynamic subtest: pipe-B-eDP-1
[462.196491] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.932s)
[462.560998] Starting dynamic subtest: pipe-C-eDP-1
[465.407469] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.855s)
[465.769670] Starting dynamic subtest: pipe-D-eDP-1
[468.640398] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.879s)
[468.641404] Subtest crc-atomic: SUCCESS (13.027s)
[469.835825] [062/133] (560s left) syncobj_wait (invalid-signal-illegal-handle)
[469.898221] Starting subtest: invalid-signal-illegal-handle
[469.899240] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[470.023423] [063/133] (559s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[470.121327] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[470.123219] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[470.258899] [064/133] (559s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[470.363604] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[471.211074] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.848s)
[471.403390] [065/133] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[471.500315] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[478.123341] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.620s)
[478.288558] [066/133] (551s left) dmabuf (all-tests)
[478.320651] Starting subtest: all-tests
[478.322123] Starting dynamic subtest: sanitycheck
[478.473375] Dynamic subtest sanitycheck: SUCCESS (0.150s)
[478.487220] Starting dynamic subtest: dma_fence
[478.762243] Dynamic subtest dma_fence: SUCCESS (0.287s)
[478.774981] Starting dynamic subtest: dma_fence_chain
[487.562586] Dynamic subtest dma_fence_chain: SUCCESS (8.797s)
[487.574699] Starting dynamic subtest: dma_fence_unwrap
[487.689294] Dynamic subtest dma_fence_unwrap: SUCCESS (0.125s)
[487.702364] Starting dynamic subtest: dma_resv
[487.849434] Dynamic subtest dma_resv: SUCCESS (0.158s)
[487.851001] Subtest all-tests: SUCCESS (9.527s)
[487.936776] [067/133] (542s left) perf_pmu (rc6-all-gts)
[487.974882] Starting subtest: rc6-all-gts
[494.355970] Subtest rc6-all-gts: SUCCESS (6.378s)
[494.804551] [068/133] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[494.895256] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[494.896837] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[495.027815] [069/133] (535s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[500.015449] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[500.017577] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[500.889668] [070/133] (529s left) kms_cursor_crc (cursor-sliding-64x64)
[501.063273] Starting subtest: cursor-sliding-64x64
[501.065192] Starting dynamic subtest: pipe-A-eDP-1
[504.298978] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.233s)
[504.324815] Starting dynamic subtest: pipe-D-eDP-1
[508.164402] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.848s)
[508.165290] Subtest cursor-sliding-64x64: SUCCESS (7.103s)
[509.058019] [071/133] (521s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[509.111645] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[509.222608] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.109s)
[509.316737] [072/133] (520s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[514.295365] Starting subtest: psr2-plane-move-sf-dmg-area
[514.296690] Starting dynamic subtest: pipe-A-eDP-1
[519.596114] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.300s)
[519.606908] Starting dynamic subtest: pipe-B-eDP-1
[524.907986] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.309s)
[524.909425] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.614s)
[525.795349] [073/133] (504s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[525.897233] Starting subtest: plane-all-transition-nonblocking-fencing
[525.898558] Starting dynamic subtest: pipe-A-eDP-1
[528.391776] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[528.704361] Starting dynamic subtest: pipe-B-eDP-1
[531.914249] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.220s)
[532.208629] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.313s)
[533.061693] [074/133] (497s left) kms_busy (basic-hang)
[533.161900] Starting subtest: basic-hang
[533.162905] Starting dynamic subtest: flip-pipe-A
[533.784605] Dynamic subtest flip-pipe-A: SUCCESS (0.623s)
[533.793910] Starting dynamic subtest: modeset-pipe-A
[537.424264] Dynamic subtest modeset-pipe-A: SUCCESS (3.638s)
[537.435148] Starting dynamic subtest: flip-pipe-D
[538.664723] Dynamic subtest flip-pipe-D: SUCCESS (1.238s)
[538.673770] Starting dynamic subtest: modeset-pipe-D
[541.984260] Dynamic subtest modeset-pipe-D: SUCCESS (3.317s)
[541.985522] Subtest basic-hang: SUCCESS (8.823s)
[542.807300] [075/133] (487s left) kms_plane_scaling (2x-scaler-multi-pipe)
[542.895643] Starting subtest: 2x-scaler-multi-pipe
[542.898647] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[543.025319] [076/133] (487s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[543.117488] Starting subtest: psr-rgb565-draw-mmap-gtt
[543.119562] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[543.243816] [077/133] (487s left) i915_pm_rpm (system-suspend-devices)
[545.281722] Starting subtest: system-suspend-devices
[552.981610] Subtest system-suspend-devices: SUCCESS (7.704s)
[560.391657] [078/133] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[560.502597] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[560.505006] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[560.643709] [079/133] (476s left) dumb_buffer (map-invalid-size)
[560.699512] Starting subtest: map-invalid-size
[560.700657] Subtest map-invalid-size: SUCCESS (0.000s)
[560.805429] [080/133] (476s left) kms_rotation_crc (primary-rotation-270)
[560.897730] Starting subtest: primary-rotation-270
[560.899783] Subtest primary-rotation-270: SKIP (0.001s)
[560.989292] [081/133] (476s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[561.073037] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[561.075101] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[561.201119] [082/133] (476s left) i915_pm_freq_api (freq-reset)
[561.259198] Starting subtest: freq-reset
[561.260312] Starting dynamic subtest: gt0
[561.457430] Dynamic subtest gt0: SUCCESS (0.198s)
[561.466328] Starting dynamic subtest: gt1
[561.632767] Dynamic subtest gt1: SUCCESS (0.173s)
[561.633874] Subtest freq-reset: SUCCESS (0.373s)
[561.729652] [083/133] (475s left) syncobj_wait (wait-all-complex)
[561.784760] Starting subtest: wait-all-complex
[562.002116] Subtest wait-all-complex: SUCCESS (0.215s)
[562.094830] [084/133] (475s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[562.182985] Starting subtest: basic-modeset-with-all-modifiers-formats
[562.554964] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[563.326873] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.772s)
[563.337562] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[563.349332] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[563.358422] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[563.371502] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[563.380977] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[563.538538] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[563.550249] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[563.560118] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[563.569250] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[563.582417] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[563.592204] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[563.605153] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[563.616228] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[563.627149] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.020s)
[563.635816] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[563.648693] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[563.657477] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[563.671323] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[563.681107] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[563.693551] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[563.702809] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[563.715621] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[563.724485] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[563.882273] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[563.891689] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[563.904675] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[563.913543] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[563.926898] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[563.936212] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[563.949229] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[563.959255] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[563.971638] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[563.980379] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[563.994007] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[564.002985] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[564.016014] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[564.024973] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[564.038298] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[564.047689] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[564.060358] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[564.069581] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[564.227372] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[564.236957] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[564.249558] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[564.258654] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[564.272000] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[564.280872] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[564.294214] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[564.303307] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[564.316563] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[564.325701] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[564.338558] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[564.347739] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[564.360975] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[564.370387] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[564.383023] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[564.392399] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[564.405302] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[564.795339] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.613s)
[565.625740] [085/133] (472s left) api_intel_bb (intel-bb-blit-y)
[565.679165] Starting subtest: intel-bb-blit-y
[569.152298] Subtest intel-bb-blit-y: SUCCESS (3.473s)
[569.293268] [086/133] (468s left) gem_basic (create-close)
[569.355135] Starting subtest: create-close
[569.357774] Subtest create-close: SUCCESS (0.000s)
[569.470593] [087/133] (468s left) api_intel_allocator (reopen)
[569.535824] Starting subtest: reopen
[569.541792] Subtest reopen: SUCCESS (0.008s)
[569.704363] [088/133] (468s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[569.818259] Starting subtest: basic-flip-before-cursor-legacy
[570.745354] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.926s)
[571.556457] [089/133] (466s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[571.608993] Starting subtest: y-tiled-to-vebox-yf-tiled
[571.612017] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[571.814086] [090/133] (466s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[571.903971] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[579.367299] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.465s)
[579.547253] [091/133] (458s left) gem_exec_flush (basic-wb-ro-before-default)
[579.618728] Starting subtest: basic-wb-ro-before-default
[585.076786] Subtest basic-wb-ro-before-default: SUCCESS (5.457s)
[585.275703] [092/133] (452s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[585.385571] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[585.387721] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[585.505609] [093/133] (452s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[585.603447] Starting subtest: yf-tiled-16bpp-rotate-270
[585.605045] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[585.721696] [094/133] (452s left) gem_exec_schedule (preempt-other)
[585.785362] Starting subtest: preempt-other
[585.786521] Starting dynamic subtest: rcs0
[585.867781] Dynamic subtest rcs0: SUCCESS (0.081s)
[585.879689] Starting dynamic subtest: bcs0
[585.943155] Dynamic subtest bcs0: SUCCESS (0.075s)
[585.954999] Starting dynamic subtest: vcs0
[586.013648] Dynamic subtest vcs0: SUCCESS (0.070s)
[586.024541] Starting dynamic subtest: vcs1
[586.085921] Dynamic subtest vcs1: SUCCESS (0.072s)
[586.097355] Starting dynamic subtest: vecs0
[586.155246] Dynamic subtest vecs0: SUCCESS (0.069s)
[586.165845] Starting dynamic subtest: ccs0
[586.222971] Dynamic subtest ccs0: SUCCESS (0.067s)
[586.224448] Subtest preempt-other: SUCCESS (0.438s)
[587.188265] [095/133] (450s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[587.239358] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[587.240642] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[587.351308] [096/133] (450s left) gem_exec_schedule (u-fairslice-all)
[587.414917] Starting subtest: u-fairslice-all
[589.472869] Subtest u-fairslice-all: SUCCESS (2.058s)
[591.205256] [097/133] (446s left) kms_invalid_mode (int-max-clock)
[591.302870] Starting subtest: int-max-clock
[591.304189] Starting dynamic subtest: pipe-A-eDP-1
[591.586289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[591.598630] Starting dynamic subtest: pipe-B-eDP-1
[591.599862] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[591.608611] Starting dynamic subtest: pipe-C-eDP-1
[591.610663] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[591.619794] Starting dynamic subtest: pipe-D-eDP-1
[591.621097] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[591.622231] Subtest int-max-clock: SUCCESS (0.292s)
[592.427011] [098/133] (445s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[592.486391] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[592.538323] [099/133] (445s left) gem_mmap_wc (write-read-distinct)
[592.585683] Subtest write-read-distinct: SKIP (0.000s)
[592.649793] [100/133] (445s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[592.856301] Starting subtest: cursor-rapid-movement-128x42
[592.898632] Subtest cursor-rapid-movement-128x42: SKIP (0.039s)
[593.134286] [101/133] (445s left) kms_scaling_modes (scaling-mode-center)
[593.227681] Starting subtest: scaling-mode-center
[593.228963] Starting dynamic subtest: pipe-A-eDP-1
[593.323824] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[593.357153] Starting dynamic subtest: pipe-B-eDP-1
[594.532633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[594.542968] Starting dynamic subtest: pipe-C-eDP-1
[595.631266] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.097s)
[595.642721] Starting dynamic subtest: pipe-D-eDP-1
[596.763855] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[596.765274] Subtest scaling-mode-center: SUCCESS (3.538s)
[597.960132] [102/133] (440s left) gem_eio (in-flight-contexts-immediate)
[598.176267] Starting subtest: in-flight-contexts-immediate
[612.109628] Subtest in-flight-contexts-immediate: SUCCESS (13.931s)
[612.306113] [103/133] (425s left) gem_partial_pwrite_pread (write-snoop)
[612.362818] Subtest write-snoop: SKIP (0.000s)
[612.439815] [104/133] (425s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[612.496302] Starting subtest: single-wait-for-submit-unsubmitted
[612.597244] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[612.709137] [105/133] (425s left) gem_mmap_wc (fault-concurrent)
[612.771683] Subtest fault-concurrent: SKIP (0.000s)
[612.825513] [106/133] (425s left) kms_pm_dc (dc9-dpms)
[613.925340] Starting subtest: dc9-dpms
[615.321850] Subtest dc9-dpms: SUCCESS (1.397s)
[615.410021] [107/133] (422s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[615.512125] Starting subtest: fbc-rgb565-draw-pwrite
[620.012432] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.501s)
[621.190263] [108/133] (417s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[621.321045] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[622.304339] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.981s)
[623.122149] [109/133] (415s left) gem_flink_basic (double-flink)
[623.171181] Starting subtest: double-flink
[623.171996] Subtest double-flink: SUCCESS (0.000s)
[623.281543] [110/133] (415s left) gem_ctx_exec (basic-close-race)
[623.332284] Starting subtest: basic-close-race
[629.210241] Subtest basic-close-race: SUCCESS (5.875s)
[629.383448] [111/133] (409s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[629.481876] Starting subtest: bad-pixel-format-yf-tiled-ccs
[629.482953] Starting dynamic subtest: pipe-A-eDP-1
[629.492632] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[629.507216] Starting dynamic subtest: pipe-B-eDP-1
[629.518976] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[629.530512] Starting dynamic subtest: pipe-C-eDP-1
[629.540266] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[629.549656] Starting dynamic subtest: pipe-D-eDP-1
[629.560240] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[629.562541] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[631.686546] [112/133] (406s left) kms_cursor_crc (cursor-onscreen-64x64)
[631.878882] Starting subtest: cursor-onscreen-64x64
[631.882762] Starting dynamic subtest: pipe-A-eDP-1
[634.015558] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.134s)
[634.044746] Starting dynamic subtest: pipe-D-eDP-1
[636.808180] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[636.809295] Subtest cursor-onscreen-64x64: SUCCESS (4.930s)
[637.671330] [113/133] (400s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[637.766331] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[637.767359] Starting dynamic subtest: pipe-A-default-mode
[638.908604] Dynamic subtest pipe-A-default-mode: SKIP (1.141s)
[638.910565] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.142s)
[639.082330] [114/133] (399s left) gem_wait (wait)
[639.137670] Starting subtest: wait
[639.139044] Starting dynamic subtest: all-engines
[641.074619] Dynamic subtest all-engines: SUCCESS (1.936s)
[641.087291] Starting dynamic subtest: rcs0
[642.124576] Dynamic subtest rcs0: SUCCESS (1.050s)
[642.137834] Starting dynamic subtest: bcs0
[643.174613] Dynamic subtest bcs0: SUCCESS (1.048s)
[643.187865] Starting dynamic subtest: vcs0
[644.224760] Dynamic subtest vcs0: SUCCESS (1.048s)
[644.238350] Starting dynamic subtest: vcs1
[645.277862] Dynamic subtest vcs1: SUCCESS (1.050s)
[645.291905] Starting dynamic subtest: vecs0
[646.327672] Dynamic subtest vecs0: SUCCESS (1.048s)
[646.341215] Starting dynamic subtest: ccs0
[647.380791] Dynamic subtest ccs0: SUCCESS (1.051s)
[647.382338] Subtest wait: SUCCESS (8.246s)
[647.607103] [115/133] (391s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[647.713332] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[647.716276] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[647.832284] [116/133] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[647.930914] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[647.937273] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[648.054033] [117/133] (390s left) sriov_basic (enable-vfs-autoprobe-off)
[648.101281] Starting subtest: enable-vfs-autoprobe-off
[648.102295] Starting dynamic subtest: numvfs-1
[648.132591] Dynamic subtest numvfs-1: FAIL (0.005s)
[648.141880] Starting dynamic subtest: numvfs-2
[648.171343] Dynamic subtest numvfs-2: FAIL (0.004s)
[648.180767] Starting dynamic subtest: numvfs-3
[648.210588] Dynamic subtest numvfs-3: FAIL (0.004s)
[648.220254] Starting dynamic subtest: numvfs-4
[648.251901] Dynamic subtest numvfs-4: FAIL (0.004s)
[648.261182] Starting dynamic subtest: numvfs-5
[648.292016] Dynamic subtest numvfs-5: FAIL (0.004s)
[648.300774] Starting dynamic subtest: numvfs-6
[648.331885] Dynamic subtest numvfs-6: FAIL (0.004s)
[648.340835] Starting dynamic subtest: numvfs-7
[648.373826] Dynamic subtest numvfs-7: FAIL (0.004s)
[648.382668] Starting dynamic subtest: numvfs-random
[648.414159] Dynamic subtest numvfs-random: FAIL (0.003s)
[648.422925] Starting dynamic subtest: numvfs-all
[648.455680] Dynamic subtest numvfs-all: FAIL (0.003s)
[648.456672] Subtest enable-vfs-autoprobe-off: FAIL (0.041s)
[648.486812] [118/133] (390s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[653.469476] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[653.470695] Starting dynamic subtest: pipe-A-eDP-1
[654.270673] Dynamic subtest pipe-A-eDP-1: SKIP (0.799s)
[654.281190] Starting dynamic subtest: pipe-B-eDP-1
[655.397855] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[655.400358] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.928s)
[656.607912] [119/133] (382s left) kms_plane (pixel-format-source-clamping)
[656.704689] Starting subtest: pixel-format-source-clamping
[656.735049] Starting dynamic subtest: pipe-A-plane-0
[662.290875] Dynamic subtest pipe-A-plane-0: SUCCESS (5.555s)
[662.309208] Starting dynamic subtest: pipe-A-plane-3
[665.058515] Dynamic subtest pipe-A-plane-3: SUCCESS (2.764s)
[665.068292] Starting dynamic subtest: pipe-A-plane-5
[665.069682] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[666.184732] Starting dynamic subtest: pipe-B-plane-0
[671.388399] Dynamic subtest pipe-B-plane-0: SUCCESS (5.211s)
[671.399814] Starting dynamic subtest: pipe-B-plane-3
[673.999720] Dynamic subtest pipe-B-plane-3: SUCCESS (2.610s)
[674.009301] Starting dynamic subtest: pipe-B-plane-5
[674.010456] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[674.307541] Subtest pixel-format-source-clamping: SUCCESS (17.601s)
[675.181083] [120/133] (363s left) gem_ctx_exec (basic-nohangcheck)
[675.246363] Starting subtest: basic-nohangcheck
[675.500874] Subtest basic-nohangcheck: SUCCESS (0.256s)
[675.647207] [121/133] (363s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[675.738308] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[675.740119] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[675.851292] [122/133] (363s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[675.939664] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[683.312956] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.374s)
[683.461962] [123/133] (355s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[683.572215] Starting subtest: y-tiled-16bpp-rotate-270
[683.574083] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[683.699479] [124/133] (355s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[683.795878] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[690.660743] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.862s)
[690.838405] [125/133] (348s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[690.933248] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[690.935154] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[691.076281] [126/133] (348s left) gem_mmap_gtt (basic-write-read)
[691.123232] Subtest basic-write-read: SKIP (0.000s)
[691.181238] [127/133] (347s left) kms_chamelium_frames (dp-crc-single)
[691.563513] Subtest dp-crc-single: SKIP (0.000s)
[692.392130] [128/133] (346s left) gem_exec_balancer (full-late)
[692.452380] Starting subtest: full-late
[696.895984] Subtest full-late: SUCCESS (4.443s)
[697.297245] [129/133] (341s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[697.393909] Starting subtest: plane-upscale-20x20-with-modifiers
[697.395271] Starting dynamic subtest: pipe-A
[697.731187] Dynamic subtest pipe-A: SUCCESS (0.338s)
[697.740247] Starting dynamic subtest: pipe-B
[699.113306] Dynamic subtest pipe-B: SUCCESS (1.381s)
[699.123785] Starting dynamic subtest: pipe-C
[700.552706] Dynamic subtest pipe-C: SUCCESS (1.437s)
[700.570824] Starting dynamic subtest: pipe-D
[701.982595] Dynamic subtest pipe-D: SUCCESS (1.428s)
[701.983684] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.590s)
[703.174100] [130/133] (336s left) gem_lmem_swapping (heavy-multi)
[703.218383] Subtest heavy-multi: SKIP (0.000s)
[703.266494] [131/133] (336s left) perf_pmu (enable-race)
[703.300664] Starting subtest: enable-race
[703.301507] Starting dynamic subtest: rcs0
[716.082000] Dynamic subtest rcs0: SUCCESS (12.779s)
[716.094648] Starting dynamic subtest: bcs0
[728.826610] Dynamic subtest bcs0: SUCCESS (12.741s)
[728.838332] Starting dynamic subtest: vcs0
[744.114487] Dynamic subtest vcs0: SUCCESS (15.282s)
[744.126440] Starting dynamic subtest: vcs1
[760.114672] Dynamic subtest vcs1: SUCCESS (15.996s)
[760.127455] Starting dynamic subtest: vecs0
[776.115217] Dynamic subtest vecs0: SUCCESS (15.996s)
[776.127281] Starting dynamic subtest: ccs0
[788.854656] Dynamic subtest ccs0: SUCCESS (12.738s)
[788.857987] Subtest enable-race: SUCCESS (85.548s)
[788.978364] [132/133] (250s left) kms_chamelium_audio (hdmi-audio-edid)
[789.370428] Subtest hdmi-audio-edid: SKIP (0.000s)
[790.148734] [133/133] (249s left) gem_exec_basic (basic)
[790.202127] Starting subtest: basic
[790.203721] Starting dynamic subtest: rcs0-smem
[790.206864] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[790.216813] Starting dynamic subtest: bcs0-smem
[790.218390] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[790.227872] Starting dynamic subtest: vcs0-smem
[790.229309] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[790.238288] Starting dynamic subtest: vcs1-smem
[790.239448] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[790.248469] Starting dynamic subtest: vecs0-smem
[790.249870] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[790.259306] Starting dynamic subtest: ccs0-smem
[790.260706] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[790.261971] Subtest basic: SUCCESS (0.020s)
[792.168437] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: gem_pxp
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_basic
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_content_protection
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: vgem_slow
results: parsing output: 18/ for test: kms_getfb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_feature_discovery
results: parsing output: 25/ for test: gem_request_retire
results: parsing output: 26/ for test: sysfs_preempt_timeout
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_plane_alpha_blend
results: parsing output: 30/ for test: gem_exec_alignment
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_color_pipeline
results: parsing output: 34/ for test: i915_query
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: syncobj_basic
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_pread
results: parsing output: 45/ for test: kms_chamelium_hpd
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_rotation_crc
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: dmabuf
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_busy
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_pm_rpm
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: dumb_buffer
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_pm_freq_api
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: gem_basic
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_flush
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_invalid_mode
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_scaling_modes
results: parsing output: 101/ for test: gem_eio
results: parsing output: 102/ for test: gem_partial_pwrite_pread
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: kms_pm_dc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_flink_basic
results: parsing output: 109/ for test: gem_ctx_exec
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: gem_wait
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: sriov_basic
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: gem_ctx_exec
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_chamelium_frames
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: kms_chamelium_audio
results: parsing output: 132/ for test: gem_exec_basic
Done.