[54.985320] Initializing watchdogs
[54.985368]   /dev/watchdog0
[54.993900] [001/131] (960s left) kms_addfb_basic (basic-y-tiled-legacy)
[55.063280] Starting subtest: basic-y-tiled-legacy
[55.067752] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[55.199798] [002/131] (960s left) gem_exec_fence (syncobj-repeat)
[55.631241] Starting subtest: syncobj-repeat
[55.816067] Subtest syncobj-repeat: SUCCESS (0.184s)
[57.018404] [003/131] (958s left) syncobj_wait (reset-signaled)
[57.088111] Starting subtest: reset-signaled
[57.090473] Subtest reset-signaled: SUCCESS (0.000s)
[57.179291] [004/131] (958s left) kms_atomic_interruptible (atomic-setmode)
[57.288728] Starting subtest: atomic-setmode
[57.291083] Starting dynamic subtest: pipe-A-eDP-1
[64.167616] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.896s)
[64.169581] Subtest atomic-setmode: SUCCESS (6.897s)
[64.934413] [005/131] (950s left) gem_exec_schedule (preempt-queue-chain)
[65.015457] Subtest preempt-queue-chain: SKIP (0.000s)
[65.276657] [006/131] (950s left) kms_flip (dpms-off-confusion-interruptible)
[65.377728] Starting subtest: dpms-off-confusion-interruptible
[65.380086] Starting dynamic subtest: A-eDP1
[74.090602] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[74.099305] Starting dynamic subtest: B-eDP1
[82.675903] Dynamic subtest B-eDP1: SUCCESS (8.619s)
[82.684508] Starting dynamic subtest: C-eDP1
[91.323801] Dynamic subtest C-eDP1: SUCCESS (8.604s)
[91.332176] Starting dynamic subtest: D-eDP1
[99.956642] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[99.958908] Subtest dpms-off-confusion-interruptible: SUCCESS (34.543s)
[101.053732] [007/131] (914s left) kms_psr2_su (frontbuffer-xrgb8888)
[101.120105] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[101.166464] [008/131] (914s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[101.266918] Starting subtest: primary-yf-tiled-reflect-x-180
[101.328894] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[101.406755] [009/131] (914s left) gem_linear_blits (basic)
[101.715836] Starting subtest: basic
[101.726030] Subtest basic: SUCCESS (0.011s)
[101.853333] [010/131] (913s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[102.012322] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[118.832586] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (16.822s)
[119.599038] [011/131] (896s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[124.550320] Starting subtest: pr-cursor-plane-update-sf
[124.554808] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[125.384758] [012/131] (890s left) kms_hdr (static-swap)
[125.484986] Starting subtest: static-swap
[125.491868] Subtest static-swap: SKIP (0.000s)
[125.537360] [013/131] (890s left) kms_pm_backlight (fade-with-suspend)
[125.626360] Starting subtest: fade-with-suspend
[141.796759] Starting dynamic subtest: eDP-1
[144.448955] Dynamic subtest eDP-1: SUCCESS (2.669s)
[144.450960] Subtest fade-with-suspend: SUCCESS (3.949s)
[145.247046] [014/131] (885s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[145.368174] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[145.954592] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.592s)
[146.096483] [015/131] (884s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[146.285845] Starting subtest: cursor-rapid-movement-128x128
[146.290554] Starting dynamic subtest: pipe-A-eDP-1
[146.829861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[146.853372] Starting dynamic subtest: pipe-D-eDP-1
[148.051860] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s)
[148.054290] Subtest cursor-rapid-movement-128x128: SUCCESS (1.774s)
[148.879492] [016/131] (881s left) gem_mmap_wc (read-write)
[148.948858] Subtest read-write: SKIP (0.000s)
[148.983648] [017/131] (881s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[149.053649] Starting subtest: etime-single-wait-available-unsubmitted
[149.163346] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[149.214852] [018/131] (881s left) kms_big_fb (linear-32bpp-rotate-180)
[149.325228] Starting subtest: linear-32bpp-rotate-180
[150.820945] Subtest linear-32bpp-rotate-180: SUCCESS (1.501s)
[150.941997] [019/131] (879s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[151.056088] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[151.059725] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[151.144437] [020/131] (879s left) gem_fence_thrash (bo-copy)
[151.178322] Starting subtest: bo-copy
[151.206068] Subtest bo-copy: SKIP (0.024s)
[151.250965] [021/131] (879s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[151.356569] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[151.360018] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[151.445125] [022/131] (879s left) gem_exec_reloc (basic-cpu)
[151.509496] Subtest basic-cpu: SKIP (0.000s)
[151.564607] [023/131] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[151.666264] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[154.159088] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.498s)
[154.271610] [024/131] (876s left) kms_chamelium_hpd (dp-hpd)
[154.663078] Subtest dp-hpd: SKIP (0.000s)
[155.488449] [025/131] (875s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[155.590890] Starting subtest: fbcpsr-indfb-scaledprimary
[161.200287] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.621s)
[161.336113] [026/131] (869s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[161.439621] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[161.444048] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[161.515390] [027/131] (869s left) kms_atomic (plane-primary-legacy)
[161.628303] Starting subtest: plane-primary-legacy
[161.630540] Starting dynamic subtest: pipe-A-eDP-1
[162.075669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[162.078031] Subtest plane-primary-legacy: SUCCESS (0.447s)
[162.868399] [028/131] (867s left) kms_cdclk (mode-transition-all-outputs)
[162.980906] Starting subtest: mode-transition-all-outputs
[163.266757] Subtest mode-transition-all-outputs: SKIP (0.283s)
[164.094609] [029/131] (866s left) kms_vblank (ts-continuation-idle-hang)
[164.196473] Starting subtest: ts-continuation-idle-hang
[164.198867] Starting dynamic subtest: pipe-A-eDP-1
[190.533410] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.339s)
[190.548042] Starting dynamic subtest: pipe-D-eDP-1
[215.556412] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[215.558862] Subtest ts-continuation-idle-hang: SUCCESS (51.370s)
[216.319356] [030/131] (814s left) vgem_basic (bad-handle)
[216.360367] Starting subtest: bad-handle
[216.362247] Subtest bad-handle: SUCCESS (0.000s)
[216.395214] [031/131] (814s left) sw_sync (sync_merge)
[216.431567] Starting subtest: sync_merge
[216.433405] Subtest sync_merge: SUCCESS (0.000s)
[216.461612] [032/131] (814s left) kms_big_fb (yf-tiled-addfb)
[216.552784] Starting subtest: yf-tiled-addfb
[216.556896] Subtest yf-tiled-addfb: SKIP (0.000s)
[216.643659] [033/131] (814s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[216.739581] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[216.741880] Starting dynamic subtest: pipe-A-default-mode
[217.878771] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[217.883383] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.136s)
[218.001633] [034/131] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[218.115516] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[218.119554] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[218.200123] [035/131] (812s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[218.259652] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[218.261653] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[218.340616] [036/131] (812s left) perf_pmu (idle)
[218.390366] Starting subtest: idle
[218.392353] Starting dynamic subtest: rcs0
[218.954886] Dynamic subtest rcs0: SUCCESS (0.565s)
[218.966500] Starting dynamic subtest: bcs0
[219.470863] Dynamic subtest bcs0: SUCCESS (0.515s)
[219.482243] Starting dynamic subtest: vcs0
[219.998716] Dynamic subtest vcs0: SUCCESS (0.527s)
[220.009378] Starting dynamic subtest: vcs1
[220.518933] Dynamic subtest vcs1: SUCCESS (0.516s)
[220.527085] Starting dynamic subtest: vecs0
[221.045302] Dynamic subtest vecs0: SUCCESS (0.525s)
[221.055939] Starting dynamic subtest: ccs0
[221.566300] Dynamic subtest ccs0: SUCCESS (0.523s)
[221.569304] Subtest idle: SUCCESS (3.178s)
[221.662992] [037/131] (809s left) gem_lmem_swapping (verify-random)
[221.711806] Subtest verify-random: SKIP (0.000s)
[221.734232] [038/131] (809s left) gem_userptr_blits (stress-purge)
[221.807544] Starting subtest: stress-purge
[227.225318] Subtest stress-purge: SUCCESS (5.421s)
[227.365934] [039/131] (803s left) gem_softpin (evict-active)
[227.460323] Starting subtest: evict-active
[227.470357] Subtest evict-active: SUCCESS (0.010s)
[227.605889] [040/131] (803s left) debugfs_test (read_all_entries_display_on)
[227.721860] Starting subtest: read_all_entries_display_on
[228.076153] Subtest read_all_entries_display_on: SUCCESS (0.352s)
[228.198327] [041/131] (802s left) sysfs_heartbeat_interval (idempotent)
[228.262907] Starting subtest: idempotent
[228.265098] Starting dynamic subtest: vecs0
[228.267229] Dynamic subtest vecs0: SUCCESS (0.001s)
[228.276761] Starting dynamic subtest: ccs0
[228.278434] Dynamic subtest ccs0: SUCCESS (0.001s)
[228.286194] Starting dynamic subtest: vcs0
[228.287887] Dynamic subtest vcs0: SUCCESS (0.000s)
[228.295467] Starting dynamic subtest: bcs0
[228.297118] Dynamic subtest bcs0: SUCCESS (0.001s)
[228.304548] Starting dynamic subtest: rcs0
[228.306204] Dynamic subtest rcs0: SUCCESS (0.000s)
[228.313886] Starting dynamic subtest: vcs1
[228.315592] Dynamic subtest vcs1: SUCCESS (0.000s)
[228.317317] Subtest idempotent: SUCCESS (0.006s)
[228.372179] [042/131] (802s left) gem_readwrite (write-bad-handle)
[228.436122] Subtest write-bad-handle: SKIP (0.000s)
[228.480159] [043/131] (802s left) syncobj_wait (invalid-wait-bad-flags)
[228.543838] Starting subtest: invalid-wait-bad-flags
[228.545853] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[228.613234] [044/131] (802s left) gem_userptr_blits (dmabuf-unsync)
[228.671861] Subtest dmabuf-unsync: SKIP (0.000s)
[228.800615] [045/131] (802s left) sw_sync (sync_busy_fork)
[228.834417] Starting subtest: sync_busy_fork
[229.849062] Subtest sync_busy_fork: SUCCESS (1.014s)
[229.892260] [046/131] (801s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[229.984394] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[229.986765] Starting dynamic subtest: pipe-A-eDP-1
[230.010382] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.020832] Starting dynamic subtest: pipe-B-eDP-1
[230.042707] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.051225] Starting dynamic subtest: pipe-C-eDP-1
[230.074079] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.083926] Starting dynamic subtest: pipe-D-eDP-1
[230.106395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.110831] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[232.093760] [047/131] (799s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[232.205977] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[232.210556] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[232.293849] [048/131] (798s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[232.392448] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[232.396760] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[232.458251] [049/131] (798s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[232.559815] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[232.563906] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[232.637628] [050/131] (798s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[232.736547] Starting subtest: psr-dirtyfb-ioctl
[232.738902] Starting dynamic subtest: A-eDP-1
[234.523244] Dynamic subtest A-eDP-1: SUCCESS (1.786s)
[234.525756] Subtest psr-dirtyfb-ioctl: SUCCESS (1.787s)
[235.324021] [051/131] (795s left) gem_flink_basic (bad-open)
[235.393507] Starting subtest: bad-open
[235.395421] Subtest bad-open: SUCCESS (0.000s)
[235.472290] [052/131] (795s left) kms_psr (fbc-pr-sprite-plane-onoff)
[235.568347] Starting subtest: fbc-pr-sprite-plane-onoff
[235.572800] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[235.620819] [053/131] (795s left) syncobj_wait (invalid-single-wait-unsubmitted)
[235.678807] Starting subtest: invalid-single-wait-unsubmitted
[235.681127] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[235.768783] [054/131] (795s left) gen9_exec_parse (allowed-single)
[235.842686] Subtest allowed-single: SKIP (0.000s)
[235.914880] [055/131] (795s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[235.977782] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[235.980250] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[236.064885] [056/131] (795s left) i915_query (query-topology-unsupported)
[236.137322] Starting subtest: query-topology-unsupported
[236.141580] Subtest query-topology-unsupported: SKIP (0.000s)
[236.222048] [057/131] (795s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[236.321921] Starting subtest: bad-pixel-format-yf-tiled-ccs
[236.323963] Starting dynamic subtest: pipe-A-eDP-1
[236.342932] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.353047] Starting dynamic subtest: pipe-B-eDP-1
[236.370218] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.377925] Starting dynamic subtest: pipe-C-eDP-1
[236.395072] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.402972] Starting dynamic subtest: pipe-D-eDP-1
[236.420722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.424210] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[238.478309] [058/131] (792s left) kms_legacy_colorkey (invalid-plane)
[238.571407] Starting subtest: invalid-plane
[238.573747] Starting dynamic subtest: zero-id
[238.575990] Dynamic subtest zero-id: SUCCESS (0.000s)
[238.585117] Starting dynamic subtest: outrange-id
[238.587414] Dynamic subtest outrange-id: SUCCESS (0.000s)
[238.589313] Subtest invalid-plane: SUCCESS (0.001s)
[238.625927] [059/131] (792s left) gem_lmem_swapping (massive-random)
[238.669333] Subtest massive-random: SKIP (0.000s)
[238.690139] [060/131] (792s left) i915_hangman (error-state-basic)
[238.764178] Starting subtest: error-state-basic
[238.870374] Subtest error-state-basic: SUCCESS (0.107s)
[238.924868] [061/131] (792s left) gem_userptr_blits (nohangcheck)
[238.991647] Starting subtest: nohangcheck
[239.243192] Subtest nohangcheck: SUCCESS (0.247s)
[239.363161] [062/131] (792s left) gem_userptr_blits (coherency-sync)
[239.434171] Starting subtest: coherency-sync
[239.560714] Subtest coherency-sync: SKIP (0.090s)
[239.644193] [063/131] (791s left) kms_flip (blocking-wf_vblank)
[239.798494] Starting subtest: blocking-wf_vblank
[239.800923] Starting dynamic subtest: A-eDP1
[248.777914] Dynamic subtest A-eDP1: SUCCESS (8.940s)
[248.786345] Starting dynamic subtest: B-eDP1
[257.708916] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[257.719167] Starting dynamic subtest: C-eDP1
[266.584752] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[266.595958] Starting dynamic subtest: D-eDP1
[275.507986] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[275.512939] Subtest blocking-wf_vblank: SUCCESS (35.711s)
[276.704118] [064/131] (754s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[276.771925] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[276.817989] [065/131] (754s left) drm_fdinfo (memory-info-purgeable)
[276.856830] Starting subtest: memory-info-purgeable
[276.859439] Starting dynamic subtest: smem0
[279.304503] Dynamic subtest smem0: SUCCESS (2.448s)
[279.306662] Subtest memory-info-purgeable: SUCCESS (2.448s)
[279.359422] [066/131] (752s left) gem_ctx_persistence (userptr)
[279.427518] Starting subtest: userptr
[279.635661] Subtest userptr: SUCCESS (0.208s)
[279.699845] [067/131] (751s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[279.804830] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[279.806859] Starting dynamic subtest: pipe-A-default-mode
[280.963098] Dynamic subtest pipe-A-default-mode: SKIP (1.153s)
[280.967950] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.154s)
[281.084440] [068/131] (750s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[281.192645] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[281.196652] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[281.270200] [069/131] (750s left) prime_vgem (fence-wait)
[281.354342] Starting subtest: fence-wait
[281.356335] Starting dynamic subtest: rcs0
[282.400336] Dynamic subtest rcs0: SUCCESS (1.047s)
[282.415886] Starting dynamic subtest: bcs0
[283.446715] Dynamic subtest bcs0: SUCCESS (1.046s)
[283.464297] Starting dynamic subtest: vcs0
[284.492840] Dynamic subtest vcs0: SUCCESS (1.044s)
[284.504019] Starting dynamic subtest: vcs1
[285.538166] Dynamic subtest vcs1: SUCCESS (1.044s)
[285.549650] Starting dynamic subtest: vecs0
[286.582308] Dynamic subtest vecs0: SUCCESS (1.043s)
[286.594346] Starting dynamic subtest: ccs0
[287.625746] Dynamic subtest ccs0: SUCCESS (1.042s)
[287.628491] Subtest fence-wait: SUCCESS (6.274s)
[287.751611] [070/131] (743s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[287.860479] Starting subtest: y-tiled-32bpp-rotate-90
[287.864461] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[287.957338] [071/131] (743s left) kms_content_protection (dp-mst-lic-type-0)
[288.100967] Starting subtest: dp-mst-lic-type-0
[288.105417] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[288.223101] [072/131] (743s left) kms_psr (fbc-psr2-suspend)
[288.316381] Starting subtest: fbc-psr2-suspend
[288.318694] Starting dynamic subtest: eDP-1
[288.323090] Dynamic subtest eDP-1: SKIP (0.000s)
[288.327488] Subtest fbc-psr2-suspend: SKIP (0.001s)
[288.369201] [073/131] (743s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[288.480331] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[293.594136] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.118s)
[293.697155] [074/131] (737s left) kms_chamelium_audio (hdmi-audio-edid)
[294.076262] Subtest hdmi-audio-edid: SKIP (0.000s)
[294.884768] [075/131] (736s left) kms_plane_alpha_blend (alpha-opaque-fb)
[294.979466] Starting subtest: alpha-opaque-fb
[295.267818] Starting dynamic subtest: pipe-A-eDP-1
[295.846049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[295.855731] Starting dynamic subtest: pipe-D-eDP-1
[297.148898] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[297.151209] Subtest alpha-opaque-fb: SUCCESS (2.169s)
[297.951102] [076/131] (733s left) syncobj_wait (single-wait-all-signaled)
[298.027733] Starting subtest: single-wait-all-signaled
[298.030303] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[298.082185] [077/131] (733s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[298.190433] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[298.192757] Starting dynamic subtest: pipe-A-eDP-1
[298.216046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[298.226550] Starting dynamic subtest: pipe-B-eDP-1
[298.248469] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[298.257169] Starting dynamic subtest: pipe-C-eDP-1
[298.279934] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[298.288393] Starting dynamic subtest: pipe-D-eDP-1
[298.310570] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[298.314667] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[300.289240] [078/131] (731s left) gem_mmap_offset (mmap-unmap)
[300.346726] Starting subtest: mmap-unmap
[300.349029] Starting dynamic subtest: smem0
[322.411577] Dynamic subtest smem0: SUCCESS (22.070s)
[322.413882] Subtest mmap-unmap: SUCCESS (22.070s)
[322.536924] [079/131] (709s left) i915_query (query-topology-garbage-items)
[322.598461] Starting subtest: query-topology-garbage-items
[322.600775] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[322.688104] [080/131] (709s left) kms_addfb_basic (addfb25-bad-modifier)
[322.742392] Starting subtest: addfb25-bad-modifier
[322.744459] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[322.902789] [081/131] (708s left) gem_exec_balancer (nop)
[322.985720] Starting subtest: nop
[369.551325] Subtest nop: SUCCESS (46.575s)
[369.809879] [082/131] (661s left) gem_workarounds (reset-fd)
[369.878015] Starting subtest: reset-fd
[370.063356] Subtest reset-fd: SUCCESS (0.185s)
[370.168423] [083/131] (661s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[370.284876] Starting subtest: short-busy-flip-before-cursor-toggle
[370.289644] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[370.410843] [084/131] (661s left) gem_exec_whisper (basic-queues-priority)
[370.472335] Starting subtest: basic-queues-priority
[394.670869] Subtest basic-queues-priority: SUCCESS (24.186s)
[394.833121] [085/131] (637s left) kms_invalid_mode (bad-vtotal)
[394.933396] Starting subtest: bad-vtotal
[394.935545] Starting dynamic subtest: pipe-A-eDP-1
[395.212873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[395.222409] Starting dynamic subtest: pipe-B-eDP-1
[395.224339] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[395.233152] Starting dynamic subtest: pipe-C-eDP-1
[395.235532] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[395.244165] Starting dynamic subtest: pipe-D-eDP-1
[395.246384] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[395.248560] Subtest bad-vtotal: SUCCESS (0.285s)
[395.993190] [086/131] (635s left) gem_sync (basic-each)
[396.076848] Starting subtest: basic-each
[398.438160] Subtest basic-each: SUCCESS (2.373s)
[398.600608] [087/131] (633s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[398.689623] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[398.691872] Starting dynamic subtest: pipe-A-eDP-1
[398.915953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.195s)
[398.924817] Starting dynamic subtest: pipe-B-eDP-1
[400.170137] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[400.179033] Starting dynamic subtest: pipe-C-eDP-1
[401.372201] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[401.381362] Starting dynamic subtest: pipe-D-eDP-1
[402.596352] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[402.598578] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.873s)
[403.692005] [088/131] (628s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[403.755943] Starting subtest: multi-wait-all-for-submit-signaled
[403.758257] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[403.845098] [089/131] (628s left) gem_ctx_exec (basic-norecovery)
[403.903546] Starting subtest: basic-norecovery
[404.271122] Subtest basic-norecovery: SUCCESS (0.368s)
[404.388341] [090/131] (627s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[404.497601] Starting subtest: fbcpsr-stridechange
[408.594143] Subtest fbcpsr-stridechange: SUCCESS (4.098s)
[408.718750] [091/131] (623s left) gem_ringfill (legacy-basic)
[414.803889] Starting subtest: legacy-basic
[414.806686] Starting dynamic subtest: default
[414.869065] Dynamic subtest default: SUCCESS (0.066s)
[414.880931] Starting dynamic subtest: render
[414.913361] Dynamic subtest render: SUCCESS (0.042s)
[414.924139] Starting dynamic subtest: bsd
[414.955091] Dynamic subtest bsd: SUCCESS (0.040s)
[414.964945] Starting dynamic subtest: bsd1
[414.997244] Dynamic subtest bsd1: SUCCESS (0.041s)
[415.008346] Starting dynamic subtest: bsd2
[415.036256] Dynamic subtest bsd2: SUCCESS (0.037s)
[415.045966] Starting dynamic subtest: blt
[415.082414] Dynamic subtest blt: SUCCESS (0.044s)
[415.093560] Starting dynamic subtest: vebox
[415.126534] Dynamic subtest vebox: SUCCESS (0.042s)
[415.129056] Subtest legacy-basic: SUCCESS (0.325s)
[415.185783] [092/131] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[415.296485] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[420.655176] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.360s)
[420.795386] [093/131] (611s left) kms_plane_scaling (planes-upscale-20x20)
[420.893621] Starting subtest: planes-upscale-20x20
[420.895875] Starting dynamic subtest: pipe-A
[420.959622] Dynamic subtest pipe-A: SUCCESS (0.066s)
[420.970175] Starting dynamic subtest: pipe-B
[422.136060] Dynamic subtest pipe-B: SUCCESS (1.175s)
[422.147621] Starting dynamic subtest: pipe-C
[423.242900] Dynamic subtest pipe-C: SUCCESS (1.106s)
[423.252778] Starting dynamic subtest: pipe-D
[424.364558] Dynamic subtest pipe-D: SUCCESS (1.121s)
[424.366909] Subtest planes-upscale-20x20: SUCCESS (3.471s)
[425.501408] [094/131] (606s left) i915_pm_rps (waitboost)
[425.557075] Starting subtest: waitboost
[425.634512] Subtest waitboost: FAIL (0.026s)
[425.689301] [095/131] (606s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[425.781652] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[425.784130] Starting dynamic subtest: pipe-A
[425.793824] Dynamic subtest pipe-A: SKIP (0.004s)
[425.804737] Starting dynamic subtest: pipe-B
[425.813820] Dynamic subtest pipe-B: SKIP (0.015s)
[425.823066] Starting dynamic subtest: pipe-C
[425.832212] Dynamic subtest pipe-C: SKIP (0.015s)
[425.841247] Starting dynamic subtest: pipe-D
[425.850057] Dynamic subtest pipe-D: SKIP (0.016s)
[425.854544] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.053s)
[425.926921] [096/131] (606s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[426.024605] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[426.028492] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[426.090513] [097/131] (606s left) gem_fence_thrash (bo-write-verify-threaded-none)
[426.126326] Starting subtest: bo-write-verify-threaded-none
[426.142563] Subtest bo-write-verify-threaded-none: SKIP (0.013s)
[426.178257] [098/131] (605s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[426.270612] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[426.272800] Starting dynamic subtest: pipe-A-default-mode
[426.557725] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[426.562475] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.285s)
[427.324490] [099/131] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[427.430873] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[427.435361] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[427.528181] [100/131] (604s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[427.651347] Starting subtest: cursorB-vs-flipA-varying-size
[427.655924] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[427.776186] [101/131] (604s left) sw_sync (sync_multi_consumer)
[427.812014] Starting subtest: sync_multi_consumer
[428.307481] Subtest sync_multi_consumer: SUCCESS (0.496s)
[428.348536] [102/131] (603s left) syncobj_eventfd (timeline-wait-signaled)
[428.407877] Starting subtest: timeline-wait-signaled
[428.410167] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[428.483742] [103/131] (603s left) api_intel_bb (crc32)
[428.544010] Starting subtest: crc32
[428.546144] Starting dynamic subtest: rcs0-smem0
[428.818072] Dynamic subtest rcs0-smem0: SUCCESS (0.274s)
[428.830392] Starting dynamic subtest: bcs0-smem0
[429.144694] Dynamic subtest bcs0-smem0: SUCCESS (0.323s)
[429.156854] Starting dynamic subtest: vcs0-smem0
[429.473195] Dynamic subtest vcs0-smem0: SUCCESS (0.326s)
[429.485192] Starting dynamic subtest: vcs1-smem0
[429.798320] Dynamic subtest vcs1-smem0: SUCCESS (0.322s)
[429.810281] Starting dynamic subtest: vecs0-smem0
[430.118359] Dynamic subtest vecs0-smem0: SUCCESS (0.317s)
[430.128756] Starting dynamic subtest: ccs0-smem0
[430.432365] Dynamic subtest ccs0-smem0: SUCCESS (0.312s)
[430.435194] Subtest crc32: SUCCESS (1.889s)
[430.535423] [104/131] (601s left) gem_partial_pwrite_pread (write-display)
[430.600996] Subtest write-display: SKIP (0.000s)
[430.676653] [105/131] (601s left) gem_exec_fence (keep-in-fence)
[430.868779] Starting subtest: keep-in-fence
[430.871199] Starting dynamic subtest: rcs0
[430.945076] Dynamic subtest rcs0: SUCCESS (0.076s)
[430.955696] Starting dynamic subtest: bcs0
[431.003552] Dynamic subtest bcs0: SUCCESS (0.056s)
[431.015893] Starting dynamic subtest: vcs0
[432.784577] Dynamic subtest vcs0: SUCCESS (1.777s)
[432.795084] Starting dynamic subtest: vcs1
[434.883352] Dynamic subtest vcs1: SUCCESS (2.046s)
[434.894885] Starting dynamic subtest: vecs0
[436.816314] Dynamic subtest vecs0: SUCCESS (1.982s)
[436.826038] Starting dynamic subtest: ccs0
[437.045060] Dynamic subtest ccs0: SUCCESS (0.228s)
[437.047870] Subtest keep-in-fence: SUCCESS (6.177s)
[438.884678] [106/131] (593s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[438.987565] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[438.991523] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[439.075148] [107/131] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[439.179770] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[439.183876] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[439.280174] [108/131] (593s left) kms_sequence (queue-busy)
[439.375338] Starting subtest: queue-busy
[439.377554] Starting dynamic subtest: pipe-A-eDP-1
[441.285682] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.909s)
[441.295351] Starting dynamic subtest: pipe-B-eDP-1
[443.910889] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.623s)
[443.919990] Starting dynamic subtest: pipe-C-eDP-1
[446.539086] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.627s)
[446.549640] Starting dynamic subtest: pipe-D-eDP-1
[449.061438] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[449.063704] Subtest queue-busy: SUCCESS (9.687s)
[449.825603] [109/131] (582s left) gem_pxp (reject-modify-context-protection-off-2)
[449.946518] Starting subtest: reject-modify-context-protection-off-2
[449.948903] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[451.052646] [110/131] (581s left) kms_psr (psr-cursor-mmap-cpu)
[451.155659] Starting subtest: psr-cursor-mmap-cpu
[451.158042] Starting dynamic subtest: eDP-1
[452.822765] Dynamic subtest eDP-1: SUCCESS (1.666s)
[452.825034] Subtest psr-cursor-mmap-cpu: SUCCESS (1.667s)
[453.666689] [111/131] (578s left) gem_exec_schedule (implicit-boths)
[453.742860] Starting subtest: implicit-boths
[453.744855] Starting dynamic subtest: rcs0
[453.841083] Dynamic subtest rcs0: SUCCESS (0.105s)
[453.852932] Starting dynamic subtest: vcs0
[453.937694] Dynamic subtest vcs0: SUCCESS (0.096s)
[453.946746] Starting dynamic subtest: vcs1
[454.018522] Dynamic subtest vcs1: SUCCESS (0.079s)
[454.028890] Starting dynamic subtest: vecs0
[454.091532] Dynamic subtest vecs0: SUCCESS (0.072s)
[454.102033] Starting dynamic subtest: ccs0
[454.175650] Dynamic subtest ccs0: SUCCESS (0.083s)
[454.178168] Subtest implicit-boths: SUCCESS (0.440s)
[454.901110] [112/131] (577s left) template (a)
[454.964332] Starting subtest: A
[454.966599] Subtest A: SUCCESS (0.000s)
[455.059789] [113/131] (577s left) gem_pxp (display-protected-crc)
[456.176436] Starting subtest: display-protected-crc
[457.744128] Subtest display-protected-crc: SUCCESS (1.568s)
[457.853174] [114/131] (574s left) kms_psr (pr-sprite-mmap-cpu)
[457.948513] Starting subtest: pr-sprite-mmap-cpu
[457.952927] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[458.004697] [115/131] (574s left) gem_busy (extended)
[458.189808] Starting subtest: extended
[458.192181] Starting dynamic subtest: rcs0
[458.285234] Dynamic subtest rcs0: SUCCESS (0.095s)
[458.296527] Starting dynamic subtest: bcs0
[458.326363] Dynamic subtest bcs0: SUCCESS (0.039s)
[458.335498] Starting dynamic subtest: vcs0
[459.792232] Dynamic subtest vcs0: SUCCESS (1.462s)
[459.804260] Starting dynamic subtest: vcs1
[461.840493] Dynamic subtest vcs1: SUCCESS (2.046s)
[461.852456] Starting dynamic subtest: vecs0
[463.823650] Dynamic subtest vecs0: SUCCESS (1.981s)
[463.835568] Starting dynamic subtest: ccs0
[463.868446] Dynamic subtest ccs0: SUCCESS (0.044s)
[463.870906] Subtest extended: SUCCESS (5.680s)
[464.099155] [116/131] (568s left) gem_softpin (softpin)
[464.164247] Starting subtest: softpin
[496.501043] Subtest softpin: SUCCESS (32.336s)
[496.620980] [117/131] (535s left) gem_exec_schedule (u-semaphore-codependency)
[496.687276] Starting subtest: u-semaphore-codependency
[496.702591] Subtest u-semaphore-codependency: SUCCESS (0.021s)
[497.033536] [118/131] (535s left) kms_setmode (invalid-clone-single-crtc-stealing)
[497.099832] Starting subtest: invalid-clone-single-crtc-stealing
[497.106001] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[497.188630] [119/131] (535s left) kms_vrr (max-min)
[497.302328] Starting subtest: max-min
[497.309011] Subtest max-min: SKIP (0.000s)
[497.356957] [120/131] (535s left) kms_color (ctm-max)
[497.463256] Starting subtest: ctm-max
[497.465473] Starting dynamic subtest: pipe-A-eDP-1
[498.128326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[498.138364] Starting dynamic subtest: pipe-B-eDP-1
[499.550453] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[499.561186] Starting dynamic subtest: pipe-C-eDP-1
[500.829116] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s)
[500.839015] Starting dynamic subtest: pipe-D-eDP-1
[502.144562] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[502.147044] Subtest ctm-max: SUCCESS (4.680s)
[502.965497] [121/131] (529s left) kms_prime (basic-crc-vgem)
[505.003661] Starting subtest: basic-crc-vgem
[505.005691] Starting dynamic subtest: second-to-first
[505.858246] Dynamic subtest second-to-first: SUCCESS (0.860s)
[505.860571] Subtest basic-crc-vgem: SUCCESS (0.861s)
[505.922184] [122/131] (526s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[506.041440] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[506.045007] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[506.132233] [123/131] (526s left) gem_userptr_blits (process-exit-busy)
[506.191457] Starting subtest: process-exit-busy
[506.209810] Subtest process-exit-busy: SUCCESS (0.018s)
[506.350140] [124/131] (526s left) kms_cursor_crc (cursor-onscreen-128x42)
[506.552362] Starting subtest: cursor-onscreen-128x42
[506.591880] Subtest cursor-onscreen-128x42: SKIP (0.034s)
[506.802933] [125/131] (525s left) gem_ctx_param (invalid-set-ringsize)
[506.865687] Starting subtest: invalid-set-ringsize
[506.867630] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[506.920432] [126/131] (525s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[508.958969] Starting subtest: modeset-non-lpsp-stress-no-wait
[509.016360] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.056s)
[509.301631] [127/131] (523s left) syncobj_timeline (single-wait-signaled)
[509.356919] Starting subtest: single-wait-signaled
[509.358926] Subtest single-wait-signaled: SUCCESS (0.000s)
[509.431664] [128/131] (523s left) kms_psr (psr-sprite-mmap-cpu)
[509.533583] Starting subtest: psr-sprite-mmap-cpu
[509.535848] Starting dynamic subtest: eDP-1
[511.224049] Dynamic subtest eDP-1: SUCCESS (1.689s)
[511.226445] Subtest psr-sprite-mmap-cpu: SUCCESS (1.690s)
[512.046661] [129/131] (520s left) gem_eio (create-ext)
[512.273381] Starting subtest: create-ext
[512.608306] Subtest create-ext: SUCCESS (0.334s)
[512.705073] [130/131] (520s left) drm_fdinfo (all-busy-check-all)
[512.749332] Starting subtest: all-busy-check-all
[512.756357] Subtest all-busy-check-all: SKIP (0.003s)
[512.803980] [131/131] (519s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[512.949042] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[513.857913] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.911s)
[513.972168] Closing watchdogs
Done.