[59.898840] Initializing watchdogs
[59.898961]   /dev/watchdog0
[59.937286] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.941600] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.943788] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.947122] [001/156] (960s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[60.064790] Starting subtest: fbc-dirtyfb-ioctl
[60.066668] Starting dynamic subtest: A-eDP-1
[62.705281] Dynamic subtest A-eDP-1: SUCCESS (2.639s)
[62.707869] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.640s)
[63.598547] [002/156] (956s left) gem_exec_fence (syncobj-wait)
[64.047378] Starting subtest: syncobj-wait
[65.338081] Subtest syncobj-wait: SUCCESS (1.289s)
[67.351540] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[67.354356] [003/156] (953s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[67.468505] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[67.472755] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[67.569256] [004/156] (953s left) kms_getfb (getfb-reject-nv12)
[67.675070] Starting subtest: getfb-reject-nv12
[67.677676] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[67.796639] [005/156] (952s left) kms_vblank (wait-busy-hang)
[67.896077] Starting subtest: wait-busy-hang
[67.898210] Starting dynamic subtest: pipe-A-eDP-1
[94.117729] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.220s)
[94.131099] Starting dynamic subtest: pipe-D-eDP-1
[109.153310] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.032s)
[109.155716] Subtest wait-busy-hang: SUCCESS (41.256s)
[109.966772] [006/156] (910s left) gem_ccs (block-copy-uncompressed)
[110.034612] Starting subtest: block-copy-uncompressed
[110.037171] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[110.057736] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[110.069659] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[110.077995] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[110.086780] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[110.094684] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[110.102518] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[110.112326] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[110.114887] Subtest block-copy-uncompressed: SUCCESS (0.077s)
[110.234871] [007/156] (910s left) gem_media_fill (media-fill)
[110.299422] Subtest media-fill: SKIP (0.000s)
[110.405781] [008/156] (910s left) i915_drm_fdinfo (isolation)
[110.449485] Starting subtest: isolation
[110.451817] Starting dynamic subtest: rcs0
[110.482146] Dynamic subtest rcs0: SKIP (0.030s)
[110.490523] Starting dynamic subtest: bcs0
[110.494621] Dynamic subtest bcs0: SKIP (0.001s)
[110.502611] Starting dynamic subtest: vcs0
[110.506604] Dynamic subtest vcs0: SKIP (0.001s)
[110.517413] Starting dynamic subtest: vcs1
[110.521569] Dynamic subtest vcs1: SKIP (0.001s)
[110.529267] Starting dynamic subtest: vecs0
[110.533534] Dynamic subtest vecs0: SKIP (0.000s)
[110.541219] Starting dynamic subtest: ccs0
[110.545573] Dynamic subtest ccs0: SKIP (0.000s)
[110.549967] Subtest isolation: SKIP (0.036s)
[110.588798] [009/156] (910s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[110.687981] Starting subtest: yf-tiled-8bpp-rotate-270
[110.692470] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[110.779725] [010/156] (910s left) core_auth (getclient-master-drop)
[110.812695] Starting subtest: getclient-master-drop
[110.839273] Subtest getclient-master-drop: SUCCESS (0.027s)
[110.955855] [011/156] (909s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[111.053433] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[111.056846] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[111.120786] [012/156] (909s left) gem_reg_read (bad-register)
[111.179394] Starting subtest: bad-register
[111.181064] Subtest bad-register: SUCCESS (0.000s)
[111.258576] [013/156] (909s left) prime_self_import (basic-llseek-bad)
[111.293022] Starting subtest: basic-llseek-bad
[111.321636] Subtest basic-llseek-bad: SUCCESS (0.028s)
[111.403536] [014/156] (909s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[111.506325] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[111.510099] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[111.604228] [015/156] (909s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[111.699070] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[111.701132] Starting dynamic subtest: pipe-A-eDP-1
[111.721035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[111.730937] Starting dynamic subtest: pipe-B-eDP-1
[111.748895] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[111.756399] Starting dynamic subtest: pipe-C-eDP-1
[111.774381] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[111.781750] Starting dynamic subtest: pipe-D-eDP-1
[111.799972] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[111.803490] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s)
[114.039522] [016/156] (907s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[114.440327] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[115.251280] [017/156] (905s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[115.360317] Starting subtest: fbc-tiling-linear
[119.168207] Subtest fbc-tiling-linear: SUCCESS (3.814s)
[120.402798] [018/156] (900s left) gem_exec_balancer (bonded-semaphore)
[120.463846] Starting subtest: bonded-semaphore
[120.468421] Subtest bonded-semaphore: SKIP (0.000s)
[120.764385] [019/156] (900s left) gem_exec_params (invalid-fence-in)
[120.812856] Starting subtest: invalid-fence-in
[120.815187] Subtest invalid-fence-in: SUCCESS (0.000s)
[120.922167] [020/156] (900s left) kms_pm_backlight (fade-with-suspend)
[121.003381] Starting subtest: fade-with-suspend
[137.911755] Starting dynamic subtest: eDP-1
[140.917550] Dynamic subtest eDP-1: SUCCESS (3.009s)
[140.920412] Subtest fade-with-suspend: SUCCESS (5.538s)
[148.817195] [021/156] (879s left) kms_chamelium_audio (hdmi-audio)
[149.222079] Subtest hdmi-audio: SKIP (0.000s)
[150.021313] [022/156] (878s left) kms_flip (flip-vs-expired-vblank-interruptible)
[150.120649] Starting subtest: flip-vs-expired-vblank-interruptible
[150.122899] Starting dynamic subtest: A-eDP1
[158.839552] Dynamic subtest A-eDP1: SUCCESS (8.712s)
[158.851152] Starting dynamic subtest: B-eDP1
[167.481474] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[167.491011] Starting dynamic subtest: C-eDP1
[176.103238] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[176.112400] Starting dynamic subtest: D-eDP1
[184.736338] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[184.741828] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.610s)
[185.906065] [023/156] (842s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[186.006466] Starting subtest: addfb25-y-tiled-legacy
[186.008564] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[186.107118] [024/156] (842s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[186.164585] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[186.166934] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[186.283291] [025/156] (842s left) gem_ppgtt (shrink-vs-evict-pinned)
[186.338203] Starting subtest: shrink-vs-evict-pinned
[191.716439] Subtest shrink-vs-evict-pinned: SUCCESS (5.378s)
[191.815677] [026/156] (836s left) sysfs_heartbeat_interval (precise)
[191.880163] Starting subtest: precise
[191.882567] Starting dynamic subtest: vecs0
[199.693756] Dynamic subtest vecs0: SUCCESS (7.812s)
[199.709043] Starting dynamic subtest: ccs0
[200.771433] Dynamic subtest ccs0: SUCCESS (1.075s)
[200.781099] Starting dynamic subtest: vcs0
[208.712923] Dynamic subtest vcs0: SUCCESS (7.941s)
[208.725286] Starting dynamic subtest: bcs0
[209.780164] Dynamic subtest bcs0: SUCCESS (1.067s)
[209.791859] Starting dynamic subtest: rcs0
[210.883095] Dynamic subtest rcs0: SUCCESS (1.101s)
[210.895348] Starting dynamic subtest: vcs1
[218.706719] Dynamic subtest vcs1: SUCCESS (7.822s)
[218.709424] Subtest precise: SUCCESS (26.824s)
[218.786525] [027/156] (809s left) kms_async_flips (test-cursor)
[218.894474] Starting subtest: test-cursor
[219.269398] Starting dynamic subtest: pipe-A-eDP-1
[220.102786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[220.490136] Starting dynamic subtest: pipe-B-eDP-1
[221.249115] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[221.638724] Starting dynamic subtest: pipe-C-eDP-1
[222.392086] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[222.767798] Starting dynamic subtest: pipe-D-eDP-1
[223.527207] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[223.529565] Subtest test-cursor: SUCCESS (4.635s)
[224.709870] [028/156] (803s left) vgem_basic (setversion)
[224.750084] Starting subtest: setversion
[224.754627] Subtest setversion: SUCCESS (0.000s)
[224.810154] [029/156] (803s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[224.908744] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[231.721286] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.817s)
[231.849813] [030/156] (796s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[231.971521] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[231.975995] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[232.119102] [031/156] (796s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[232.214669] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[232.216909] Starting dynamic subtest: pipe-A-eDP-1
[232.239725] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.253523] Starting dynamic subtest: pipe-B-eDP-1
[232.275276] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.287745] Starting dynamic subtest: pipe-C-eDP-1
[232.308398] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.317590] Starting dynamic subtest: pipe-D-eDP-1
[232.338841] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.342754] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[234.509638] [032/156] (794s left) gem_exec_capture (capture-recoverable)
[234.576337] Starting subtest: capture-recoverable
[234.578599] Subtest capture-recoverable: SUCCESS (0.003s)
[234.694303] [033/156] (794s left) gem_render_copy (linear-to-vebox-yf-tiled)
[234.761880] Starting subtest: linear-to-vebox-yf-tiled
[234.765892] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[234.945836] [034/156] (793s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[235.054186] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[235.678117] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[235.853849] [035/156] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[235.964917] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[243.501489] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.541s)
[243.637811] [036/156] (785s left) kms_cursor_edge_walk (128x128-top-bottom)
[243.742143] Starting subtest: 128x128-top-bottom
[243.744570] Starting dynamic subtest: pipe-A-eDP-1
[247.193872] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[247.204715] Starting dynamic subtest: pipe-D-eDP-1
[250.332331] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[250.334305] Subtest 128x128-top-bottom: SUCCESS (6.591s)
[251.156368] [037/156] (777s left) gem_exec_reloc (basic-cpu-read)
[251.208708] Subtest basic-cpu-read: SKIP (0.000s)
[251.278888] [038/156] (777s left) gem_eio (execbuf)
[251.494840] Starting subtest: execbuf
[251.816857] Subtest execbuf: SUCCESS (0.322s)
[251.947815] [039/156] (777s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[252.048132] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[252.052963] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[252.147374] [040/156] (776s left) gem_userptr_blits (create-destroy-sync)
[252.212673] Starting subtest: create-destroy-sync
[257.234913] Subtest create-destroy-sync: SUCCESS (5.020s)
[257.359008] [041/156] (771s left) template (b)
[257.409563] Starting subtest: B
[257.411968] Subtest B: SUCCESS (0.000s)
[257.524350] [042/156] (771s left) syncobj_timeline (multi-wait-available-submitted)
[257.582467] Starting subtest: multi-wait-available-submitted
[257.584659] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[257.687660] [043/156] (771s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[257.785717] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[257.789664] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[257.889112] [044/156] (771s left) gen3_render_linear_blits
[258.006634] [045/156] (771s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[258.094857] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[258.099076] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[258.173744] [046/156] (771s left) perf_pmu (busy-accuracy-2)
[258.216091] Starting subtest: busy-accuracy-2
[258.218595] Starting dynamic subtest: rcs0
[261.257462] Dynamic subtest rcs0: SUCCESS (3.040s)
[261.269259] Starting dynamic subtest: bcs0
[264.315778] Dynamic subtest bcs0: SUCCESS (3.056s)
[264.326261] Starting dynamic subtest: vcs0
[267.364448] Dynamic subtest vcs0: SUCCESS (3.046s)
[267.376588] Starting dynamic subtest: vcs1
[270.410133] Dynamic subtest vcs1: SUCCESS (3.044s)
[270.422155] Starting dynamic subtest: vecs0
[273.458550] Dynamic subtest vecs0: SUCCESS (3.047s)
[273.471183] Starting dynamic subtest: ccs0
[276.517138] Dynamic subtest ccs0: SUCCESS (3.056s)
[276.519675] Subtest busy-accuracy-2: SUCCESS (18.300s)
[276.632233] [047/156] (752s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[276.729643] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[283.692046] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.967s)
[283.846892] [048/156] (745s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[283.942314] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[284.632898] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[284.796327] [049/156] (744s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[284.886694] Starting subtest: nonblocking-crc-frame-sequence
[284.888985] Starting dynamic subtest: pipe-A-eDP-1
[285.626273] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[285.637057] Starting dynamic subtest: pipe-B-eDP-1
[287.129488] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[287.140193] Starting dynamic subtest: pipe-C-eDP-1
[288.504130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[288.515112] Starting dynamic subtest: pipe-D-eDP-1
[289.926941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.419s)
[289.928993] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.040s)
[290.817443] [050/156] (738s left) gem_ctx_isolation (dirty-switch)
[290.880078] Starting subtest: dirty-switch
[290.882349] Starting dynamic subtest: rcs0
[291.085801] Dynamic subtest rcs0: SUCCESS (0.205s)
[291.097917] Starting dynamic subtest: bcs0
[291.259600] Dynamic subtest bcs0: SUCCESS (0.173s)
[291.272365] Starting dynamic subtest: vcs0
[291.461003] Dynamic subtest vcs0: SUCCESS (0.200s)
[291.476336] Starting dynamic subtest: vcs1
[292.871950] Dynamic subtest vcs1: SUCCESS (1.410s)
[292.882978] Starting dynamic subtest: vecs0
[294.933667] Dynamic subtest vecs0: SUCCESS (2.061s)
[294.945931] Starting dynamic subtest: ccs0
[296.942025] Dynamic subtest ccs0: SUCCESS (2.007s)
[296.944415] Subtest dirty-switch: SUCCESS (6.062s)
[297.189758] [051/156] (732s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[297.292751] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[298.150847] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.859s)
[298.331570] [052/156] (731s left) vgem_basic (sysfs)
[298.375162] Starting subtest: sysfs
[298.377017] Subtest sysfs: SUCCESS (0.000s)
[298.433165] [053/156] (731s left) gem_ctx_shared (q-promotion)
[298.486771] Starting subtest: Q-promotion
[298.489111] Starting dynamic subtest: rcs0
[298.596324] Dynamic subtest rcs0: SUCCESS (0.108s)
[298.615257] Starting dynamic subtest: vcs0
[298.689367] Dynamic subtest vcs0: SUCCESS (0.090s)
[298.704645] Starting dynamic subtest: vcs1
[298.776203] Dynamic subtest vcs1: SUCCESS (0.084s)
[298.794686] Starting dynamic subtest: vecs0
[298.857163] Dynamic subtest vecs0: SUCCESS (0.080s)
[298.875696] Starting dynamic subtest: ccs0
[298.953229] Dynamic subtest ccs0: SUCCESS (0.095s)
[298.955716] Subtest Q-promotion: SUCCESS (0.467s)
[299.821609] [054/156] (729s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[299.920352] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[306.702724] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.787s)
[306.832399] [055/156] (722s left) gem_lmem_swapping (heavy-random)
[306.875170] Subtest heavy-random: SKIP (0.000s)
[306.927326] [056/156] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[307.042724] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[307.046806] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[307.143549] [057/156] (722s left) gem_exec_params (sol-reset-invalid)
[307.200017] Starting subtest: sol-reset-invalid
[307.205156] Subtest sol-reset-invalid: SUCCESS (0.002s)
[308.763813] [058/156] (721s left) gem_eio (reset-stress)
[308.989169] Starting subtest: reset-stress
[308.991434] Starting dynamic subtest: render
[314.082392] Dynamic subtest render: SUCCESS (5.091s)
[314.097952] Starting dynamic subtest: bsd1
[332.249174] Dynamic subtest bsd1: SUCCESS (18.164s)
[332.265821] Starting dynamic subtest: bsd2
[350.233312] Dynamic subtest bsd2: SUCCESS (17.982s)
[350.248538] Starting dynamic subtest: blt
[350.252976] Dynamic subtest blt: SKIP (0.000s)
[350.262344] Starting dynamic subtest: vebox
[368.229528] Dynamic subtest vebox: SUCCESS (17.992s)
[368.232106] Subtest reset-stress: SUCCESS (59.234s)
[369.714162] [059/156] (660s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[369.820385] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[369.824548] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[369.901475] [060/156] (660s left) gem_partial_pwrite_pread (write-display)
[369.955714] Subtest write-display: SKIP (0.000s)
[370.032900] [061/156] (659s left) gem_exec_create (forked)
[370.086214] Starting subtest: forked
[370.088570] Starting dynamic subtest: smem
[390.281279] Dynamic subtest smem: SUCCESS (20.194s)
[390.283646] Subtest forked: SUCCESS (20.196s)
[390.474009] [062/156] (639s left) gem_mmap_wc (write)
[390.537289] Subtest write: SKIP (0.000s)
[390.599018] [063/156] (639s left) kms_content_protection (dp-mst-type-0-hdcp14)
[390.748783] Starting subtest: dp-mst-type-0-hdcp14
[390.752915] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[390.874785] [064/156] (639s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[390.977404] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[390.981324] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[391.084742] [065/156] (639s left) kms_draw_crc (draw-method-mmap-cpu)
[391.169240] Starting subtest: draw-method-mmap-cpu
[391.171158] Starting dynamic subtest: xrgb8888-untiled
[391.410444] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[391.422965] Starting dynamic subtest: rgb565-untiled
[391.632473] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[391.643357] Starting dynamic subtest: xrgb2101010-untiled
[391.854755] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[391.865303] Starting dynamic subtest: xbgr16161616f-untiled
[392.077059] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[392.087341] Starting dynamic subtest: xrgb8888-xtiled
[392.221563] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[392.231229] Starting dynamic subtest: rgb565-xtiled
[392.343896] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[392.356316] Starting dynamic subtest: xrgb2101010-xtiled
[392.477055] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[392.487192] Starting dynamic subtest: xbgr16161616f-xtiled
[392.599093] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[392.613361] Starting dynamic subtest: xrgb8888-4tiled
[392.744737] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[392.756328] Starting dynamic subtest: rgb565-4tiled
[392.877162] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[392.887259] Starting dynamic subtest: xrgb2101010-4tiled
[393.010635] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[393.020724] Starting dynamic subtest: xbgr16161616f-4tiled
[393.154956] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[393.157218] Subtest draw-method-mmap-cpu: SUCCESS (1.989s)
[393.263156] [066/156] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[393.365208] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[400.756895] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.395s)
[400.883340] [067/156] (629s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[400.982580] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[400.986857] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.097932] [068/156] (629s left) kms_rotation_crc (primary-rotation-180)
[401.196668] Starting subtest: primary-rotation-180
[408.284056] Subtest primary-rotation-180: SUCCESS (7.089s)
[409.457227] [069/156] (620s left) vgem_slow (nohang)
[409.498322] Starting subtest: nohang
[419.881554] Subtest nohang: SUCCESS (10.383s)
[419.950404] [070/156] (610s left) i915_query (query-topology-known-pci-ids)
[420.018565] Starting subtest: query-topology-known-pci-ids
[420.023312] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[420.130962] [071/156] (610s left) i915_hangman (engine-engine-error)
[420.195005] Starting subtest: engine-engine-error
[420.197232] Starting dynamic subtest: rcs0
[421.671944] Dynamic subtest rcs0: SUCCESS (1.477s)
[421.687928] Starting dynamic subtest: bcs0
[423.656562] Dynamic subtest bcs0: SUCCESS (1.981s)
[423.671007] Starting dynamic subtest: vcs0
[425.640442] Dynamic subtest vcs0: SUCCESS (1.981s)
[425.653698] Starting dynamic subtest: vcs1
[427.689022] Dynamic subtest vcs1: SUCCESS (2.046s)
[427.702512] Starting dynamic subtest: vecs0
[429.673299] Dynamic subtest vecs0: SUCCESS (1.981s)
[429.687176] Starting dynamic subtest: ccs0
[431.656196] Dynamic subtest ccs0: SUCCESS (1.980s)
[431.659133] Subtest engine-engine-error: SUCCESS (11.462s)
[431.739972] [072/156] (598s left) gem_ctx_persistence (legacy-engines-persistence)
[431.805461] Starting subtest: legacy-engines-persistence
[431.807716] Starting dynamic subtest: render
[432.590929] Dynamic subtest render: SUCCESS (0.784s)
[432.605981] Starting dynamic subtest: bsd1
[433.359354] Dynamic subtest bsd1: SUCCESS (0.766s)
[433.374085] Starting dynamic subtest: bsd2
[434.096952] Dynamic subtest bsd2: SUCCESS (0.734s)
[434.109242] Starting dynamic subtest: blt
[434.863446] Dynamic subtest blt: SUCCESS (0.764s)
[434.876151] Starting dynamic subtest: vebox
[435.656384] Dynamic subtest vebox: SUCCESS (0.790s)
[435.658905] Subtest legacy-engines-persistence: SUCCESS (3.852s)
[435.752443] [073/156] (594s left) perf_pmu (enable-race)
[435.794118] Starting subtest: enable-race
[435.796221] Starting dynamic subtest: rcs0
[448.560738] Dynamic subtest rcs0: SUCCESS (12.768s)
[448.572044] Starting dynamic subtest: bcs0
[461.306648] Dynamic subtest bcs0: SUCCESS (12.742s)
[461.318684] Starting dynamic subtest: vcs0
[476.682388] Dynamic subtest vcs0: SUCCESS (15.372s)
[476.694807] Starting dynamic subtest: vcs1
[492.683132] Dynamic subtest vcs1: SUCCESS (15.996s)
[492.696519] Starting dynamic subtest: vecs0
[508.682753] Dynamic subtest vecs0: SUCCESS (15.996s)
[508.696772] Starting dynamic subtest: ccs0
[521.425333] Dynamic subtest ccs0: SUCCESS (12.740s)
[521.428668] Subtest enable-race: SUCCESS (85.629s)
[521.538596] [074/156] (509s left) kms_psr (pr-primary-page-flip)
[521.641095] Starting subtest: pr-primary-page-flip
[521.645235] Subtest pr-primary-page-flip: SKIP (0.000s)
[521.729329] [075/156] (508s left) perf (rc6-disable)
[521.845424] Starting subtest: rc6-disable
[522.021166] Subtest rc6-disable: SUCCESS (0.177s)
[522.075030] [076/156] (508s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[522.181142] Starting subtest: fbc-rgb565-draw-blt
[526.332018] Subtest fbc-rgb565-draw-blt: SUCCESS (4.158s)
[527.560654] [077/156] (503s left) syncobj_wait (wait-all-complex)
[527.609889] Starting subtest: wait-all-complex
[527.824106] Subtest wait-all-complex: SUCCESS (0.214s)
[527.912564] [078/156] (502s left) gen7_exec_parse (bitmasks)
[527.966591] Subtest bitmasks: SKIP (0.000s)
[528.042110] [079/156] (502s left) gem_watchdog (default-physical)
[528.111687] Starting subtest: default-physical
[529.868028] Subtest default-physical: SUCCESS (1.767s)
[529.964645] [080/156] (500s left) gem_exec_schedule (u-semaphore-noskip)
[530.042345] Starting subtest: u-semaphore-noskip
[530.495459] Subtest u-semaphore-noskip: SUCCESS (0.457s)
[530.830602] [081/156] (500s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[530.883533] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[530.990460] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[531.067838] [082/156] (499s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[531.182718] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[531.187101] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[531.284405] [083/156] (499s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[531.381294] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[531.385625] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[531.485554] [084/156] (499s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[531.539250] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[531.543331] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[531.726103] [085/156] (499s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[531.824775] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[531.829006] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.947182] [086/156] (499s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[532.050219] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[532.054528] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[532.151620] [087/156] (499s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[532.234732] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[532.239170] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[532.309879] [088/156] (498s left) gem_mmap_gtt (hang-user)
[532.368765] Subtest hang-user: SKIP (0.000s)
[532.431321] [089/156] (498s left) kms_psr (pr-cursor-mmap-cpu)
[532.532847] Starting subtest: pr-cursor-mmap-cpu
[532.536806] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[532.606278] [090/156] (498s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[532.717535] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[532.720879] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[532.814584] [091/156] (498s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[532.912575] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[532.916425] Starting dynamic subtest: A-eDP1
[541.803962] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[541.819195] Starting dynamic subtest: B-eDP1
[550.729757] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[550.741921] Starting dynamic subtest: C-eDP1
[559.645268] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[559.657834] Starting dynamic subtest: D-eDP1
[568.580718] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[568.587092] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.671s)
[569.815406] [092/156] (461s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[569.926477] Starting subtest: fbc-rgb101010-draw-render
[572.436701] Subtest fbc-rgb101010-draw-render: SUCCESS (2.515s)
[573.622303] [093/156] (457s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[573.736439] Starting subtest: y-tiled-8bpp-rotate-180
[573.740677] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[573.833299] [094/156] (457s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[573.942607] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[573.946744] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[574.035200] [095/156] (457s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[574.132050] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[574.136084] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[574.237452] [096/156] (457s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[574.331489] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[574.357174] Starting dynamic subtest: pipe-A-plane-0
[574.622326] Dynamic subtest pipe-A-plane-0: SUCCESS (0.266s)
[574.632992] Starting dynamic subtest: pipe-A-plane-3
[574.844660] Dynamic subtest pipe-A-plane-3: SUCCESS (0.222s)
[574.857140] Starting dynamic subtest: pipe-A-plane-5
[574.861025] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[575.995122] Starting dynamic subtest: pipe-B-plane-0
[576.275521] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[576.286526] Starting dynamic subtest: pipe-B-plane-3
[576.487949] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[576.500932] Starting dynamic subtest: pipe-B-plane-5
[576.505310] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[576.795948] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.465s)
[577.680067] [097/156] (453s left) kms_pm_rpm (legacy-planes-dpms)
[579.916825] Starting subtest: legacy-planes-dpms
[579.919395] Starting dynamic subtest: plane-65
[588.249724] Dynamic subtest plane-65: SUCCESS (8.333s)
[588.263533] Starting dynamic subtest: plane-95
[596.597392] Dynamic subtest plane-95: SUCCESS (8.344s)
[596.612070] Starting dynamic subtest: plane-125
[605.030713] Dynamic subtest plane-125: SUCCESS (8.428s)
[605.045549] Starting dynamic subtest: plane-135
[613.456253] Dynamic subtest plane-135: SUCCESS (8.423s)
[613.458687] Subtest legacy-planes-dpms: SUCCESS (33.540s)
[613.874263] [098/156] (417s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[613.979150] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[613.983519] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[614.079102] [099/156] (417s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[614.174444] Starting subtest: fbc-pr-cursor-mmap-gtt
[614.178619] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[614.252542] [100/156] (417s left) gem_close_race (basic-threads)
[614.311571] Starting subtest: basic-threads
[615.666334] Subtest basic-threads: SUCCESS (1.355s)
[615.851252] [101/156] (415s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[615.950704] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[615.954622] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[616.050616] [102/156] (415s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[616.216452] Starting subtest: cursor-rapid-movement-32x10
[616.262236] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[616.542894] [103/156] (415s left) gem_exec_schedule (pi-userfault)
[616.726437] Starting subtest: pi-userfault
[616.728519] Starting dynamic subtest: rcs0
[616.737654] Dynamic subtest rcs0: SUCCESS (0.014s)
[616.750165] Starting dynamic subtest: bcs0
[616.752375] Dynamic subtest bcs0: SUCCESS (0.010s)
[616.763040] Starting dynamic subtest: vcs0
[616.764924] Dynamic subtest vcs0: SUCCESS (0.009s)
[616.775911] Starting dynamic subtest: vcs1
[616.778077] Dynamic subtest vcs1: SUCCESS (0.009s)
[616.788694] Starting dynamic subtest: vecs0
[616.790828] Dynamic subtest vecs0: SUCCESS (0.007s)
[616.801184] Starting dynamic subtest: ccs0
[616.803326] Dynamic subtest ccs0: SUCCESS (0.009s)
[616.805482] Subtest pi-userfault: SUCCESS (0.062s)
[616.975010] [104/156] (414s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[617.073934] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[617.078238] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[617.145311] [105/156] (414s left) kms_chamelium_frames (vga-frame-dump)
[617.532713] Subtest vga-frame-dump: SKIP (0.000s)
[618.368195] [106/156] (413s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[618.470592] Starting subtest: hdr-rgb101010-draw-blt
[618.475018] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[618.580071] [107/156] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[618.677618] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[618.681551] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[618.781747] [108/156] (413s left) gem_exec_fence (basic-busy-all)
[618.846571] Starting subtest: basic-busy-all
[618.931076] Subtest basic-busy-all: SUCCESS (0.086s)
[620.771215] [109/156] (411s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[620.870223] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[625.338379] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.474s)
[626.510075] [110/156] (405s left) gem_exec_whisper (basic-normal-all)
[626.575910] Starting subtest: basic-normal-all
[628.935387] Subtest basic-normal-all: SUCCESS (2.356s)
[629.133206] [111/156] (403s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[629.242088] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[629.246479] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[629.337393] [112/156] (402s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[629.435557] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[629.439970] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[629.513486] [113/156] (402s left) gem_softpin (evict-prime-sanity-check)
[629.573627] Starting subtest: evict-prime-sanity-check
[629.575835] Starting dynamic subtest: rcs0
[630.729197] Dynamic subtest rcs0: SUCCESS (1.154s)
[630.739794] Starting dynamic subtest: bcs0
[631.837424] Dynamic subtest bcs0: SUCCESS (1.108s)
[631.848188] Starting dynamic subtest: vcs0
[633.717322] Dynamic subtest vcs0: SUCCESS (1.876s)
[633.733557] Starting dynamic subtest: vcs1
[635.696803] Dynamic subtest vcs1: SUCCESS (1.976s)
[635.708816] Starting dynamic subtest: vecs0
[637.680562] Dynamic subtest vecs0: SUCCESS (1.981s)
[637.694120] Starting dynamic subtest: ccs0
[638.828520] Dynamic subtest ccs0: SUCCESS (1.147s)
[638.839912] Starting dynamic subtest: all
[639.963123] Dynamic subtest all: SUCCESS (1.132s)
[639.966050] Subtest evict-prime-sanity-check: SUCCESS (10.390s)
[640.045142] [114/156] (392s left) kms_psr (psr-sprite-blt)
[640.155461] Starting subtest: psr-sprite-blt
[640.157773] Starting dynamic subtest: eDP-1
[641.888913] Dynamic subtest eDP-1: SUCCESS (1.733s)
[641.891184] Subtest psr-sprite-blt: SUCCESS (1.735s)
[642.765393] [115/156] (389s left) kms_flip (2x-flip-vs-panning)
[642.868817] Starting subtest: 2x-flip-vs-panning
[642.878646] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[642.960277] [116/156] (389s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[643.060053] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[643.064356] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[643.161792] [117/156] (389s left) kms_psr (psr-primary-mmap-gtt)
[643.251901] Starting subtest: psr-primary-mmap-gtt
[643.254273] Starting dynamic subtest: eDP-1
[644.664257] Dynamic subtest eDP-1: SKIP (1.409s)
[644.669133] Subtest psr-primary-mmap-gtt: SKIP (1.411s)
[644.813427] [118/156] (387s left) gem_exec_params (cliprects_ptr-dirt)
[644.861823] Starting subtest: cliprects_ptr-dirt
[644.864105] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[644.953766] [119/156] (387s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[645.058427] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[645.062803] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[645.148704] [120/156] (387s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[645.257894] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[645.262514] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[645.381584] [121/156] (387s left) gem_partial_pwrite_pread (reads-uncached)
[645.441452] Subtest reads-uncached: SKIP (0.000s)
[645.504387] [122/156] (387s left) i915_pm_rpm (system-suspend-execbuf)
[647.036083] Starting subtest: system-suspend-execbuf
[707.294883] Subtest system-suspend-execbuf: SUCCESS (44.845s)
[707.691660] [123/156] (325s left) kms_cursor_crc (cursor-offscreen-64x21)
[707.888385] Starting subtest: cursor-offscreen-64x21
[707.937368] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[708.155028] [124/156] (324s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[708.258345] Starting subtest: fbcpsr-rgb101010-draw-blt
[713.030726] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.777s)
[713.155877] [125/156] (319s left) kms_pm_rpm (modeset-stress-extra-wait)
[715.283928] Starting subtest: modeset-stress-extra-wait
[769.638384] Subtest modeset-stress-extra-wait: SUCCESS (54.344s)
[769.731514] [126/156] (263s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[769.836169] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[769.840291] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[769.931986] [127/156] (262s left) kms_color (ctm-red-to-blue)
[770.014521] Starting subtest: ctm-red-to-blue
[770.016448] Starting dynamic subtest: pipe-A-eDP-1
[770.733156] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[770.745114] Starting dynamic subtest: pipe-B-eDP-1
[772.206568] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s)
[772.219402] Starting dynamic subtest: pipe-C-eDP-1
[773.584204] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[773.595926] Starting dynamic subtest: pipe-D-eDP-1
[774.907797] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[774.910038] Subtest ctm-red-to-blue: SUCCESS (4.892s)
[775.717995] [128/156] (257s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[775.812895] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[775.816872] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[775.885765] [129/156] (257s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[775.975771] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[775.980557] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[776.073467] [130/156] (256s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[776.170519] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[776.174665] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[776.275848] [131/156] (256s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[776.379309] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[776.383613] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[776.500059] [132/156] (256s left) syncobj_basic (bad-create-flags)
[776.553528] Starting subtest: bad-create-flags
[776.556160] Subtest bad-create-flags: SUCCESS (0.000s)
[776.651764] [133/156] (256s left) gem_exec_parallel (fds)
[776.709267] Starting subtest: fds
[776.711243] Starting dynamic subtest: rcs0
[779.192594] Dynamic subtest rcs0: SUCCESS (2.480s)
[779.203796] Starting dynamic subtest: bcs0
[782.757759] Dynamic subtest bcs0: SUCCESS (3.565s)
[782.768723] Starting dynamic subtest: vcs0
[786.409141] Dynamic subtest vcs0: SUCCESS (3.647s)
[786.423504] Starting dynamic subtest: vcs1
[790.324667] Dynamic subtest vcs1: SUCCESS (3.913s)
[790.336716] Starting dynamic subtest: vecs0
[794.347797] Dynamic subtest vecs0: SUCCESS (4.020s)
[794.364144] Starting dynamic subtest: ccs0
[797.779486] Dynamic subtest ccs0: SUCCESS (3.430s)
[797.782523] Subtest fds: SUCCESS (21.067s)
[797.983332] [134/156] (235s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[798.102575] Starting subtest: x-tiled-8bpp-rotate-90
[798.124986] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[798.240536] [135/156] (235s left) kms_plane (plane-panning-bottom-right-suspend)
[798.327008] Starting subtest: plane-panning-bottom-right-suspend
[798.329294] Starting dynamic subtest: pipe-A
[816.296531] Dynamic subtest pipe-A: SUCCESS (3.224s)
[816.307802] Starting dynamic subtest: pipe-B
[835.289808] Dynamic subtest pipe-B: SUCCESS (3.880s)
[835.292071] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.107s)
[846.134184] [136/156] (197s left) kms_psr (fbc-psr2-cursor-blt)
[846.233929] Starting subtest: fbc-psr2-cursor-blt
[846.236209] Starting dynamic subtest: eDP-1
[846.240255] Dynamic subtest eDP-1: SKIP (0.000s)
[846.244394] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[846.308823] [137/156] (197s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[846.356360] Starting subtest: etime-multi-wait-all-submitted-signaled
[846.460615] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[846.541854] [138/156] (196s left) syncobj_timeline (reset-unsignaled)
[846.601658] Starting subtest: reset-unsignaled
[846.603943] Subtest reset-unsignaled: SUCCESS (0.000s)
[846.726298] [139/156] (196s left) syncobj_timeline (single-wait-available-signaled)
[846.782550] Starting subtest: single-wait-available-signaled
[846.784948] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[846.881494] [140/156] (196s left) perf (enable-disable)
[846.992558] Starting subtest: enable-disable
[846.994889] Starting dynamic subtest: 0-rcs0
[849.286796] Dynamic subtest 0-rcs0: SUCCESS (2.295s)
[849.302200] Starting dynamic subtest: 1-vcs0
[853.830009] Dynamic subtest 1-vcs0: SUCCESS (4.543s)
[853.832788] Subtest enable-disable: SUCCESS (6.840s)
[853.876828] [141/156] (189s left) prime_busy (before)
[853.928939] Starting subtest: before
[853.933753] Starting dynamic subtest: rcs0
[853.976588] Dynamic subtest rcs0: SUCCESS (0.044s)
[853.989204] Starting dynamic subtest: bcs0
[854.045661] Dynamic subtest bcs0: SUCCESS (0.067s)
[854.058554] Starting dynamic subtest: vcs0
[854.087688] Dynamic subtest vcs0: SUCCESS (0.042s)
[854.098254] Starting dynamic subtest: vcs1
[854.130379] Dynamic subtest vcs1: SUCCESS (0.042s)
[854.141459] Starting dynamic subtest: vecs0
[854.172517] Dynamic subtest vecs0: SUCCESS (0.041s)
[854.186375] Starting dynamic subtest: ccs0
[854.216203] Dynamic subtest ccs0: SUCCESS (0.043s)
[854.324463] Subtest before: SUCCESS (0.394s)
[854.401839] [142/156] (189s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[854.515882] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[854.520205] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[854.623186] [143/156] (189s left) i915_suspend (sysfs-reader)
[854.670856] Starting subtest: sysfs-reader
[872.901639] Subtest sysfs-reader: SUCCESS (3.511s)
[882.036116] [144/156] (170s left) kms_mmap_write_crc (main)
[882.134231] Starting subtest: main
[882.136630] Starting dynamic subtest: pipe-A-eDP-1
[885.648516] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.512s)
[885.650796] Subtest main: SUCCESS (3.513s)
[886.544307] [145/156] (166s left) kms_sequence (get-forked)
[886.645349] Starting subtest: get-forked
[886.647573] Starting dynamic subtest: pipe-A-eDP-1
[888.549612] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.904s)
[888.561254] Starting dynamic subtest: pipe-B-eDP-1
[891.095632] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.547s)
[891.107652] Starting dynamic subtest: pipe-C-eDP-1
[893.599913] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.500s)
[893.611719] Starting dynamic subtest: pipe-D-eDP-1
[896.133342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[896.135212] Subtest get-forked: SUCCESS (9.489s)
[896.979452] [146/156] (155s left) dumb_buffer (map-invalid-size)
[897.033240] Starting subtest: map-invalid-size
[897.035391] Subtest map-invalid-size: SUCCESS (0.000s)
[897.147617] [147/156] (155s left) gem_exec_parallel (contexts)
[897.209362] Starting subtest: contexts
[897.211527] Starting dynamic subtest: rcs0
[900.376760] Dynamic subtest rcs0: SUCCESS (3.168s)
[900.388817] Starting dynamic subtest: bcs0
[903.998951] Dynamic subtest bcs0: SUCCESS (3.620s)
[904.012855] Starting dynamic subtest: vcs0
[908.026986] Dynamic subtest vcs0: SUCCESS (4.027s)
[908.038913] Starting dynamic subtest: vcs1
[912.135764] Dynamic subtest vcs1: SUCCESS (4.107s)
[912.154699] Starting dynamic subtest: vecs0
[916.048547] Dynamic subtest vecs0: SUCCESS (3.910s)
[916.062435] Starting dynamic subtest: ccs0
[919.430813] Dynamic subtest ccs0: SUCCESS (3.381s)
[919.432961] Subtest contexts: SUCCESS (22.228s)
[919.621940] [148/156] (133s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[919.734786] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[919.738933] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[919.826102] [149/156] (133s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[919.957907] Starting subtest: flip-vs-cursor-busy-crc-atomic
[920.718928] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.761s)
[921.608675] [150/156] (131s left) gem_exec_fence (long-history)
[922.081724] Starting subtest: long-history
[929.383530] Subtest long-history: SUCCESS (7.303s)
[929.934214] [151/156] (123s left) kms_joiner (basic-ultra-joiner)
[930.037293] Starting subtest: basic-ultra-joiner
[930.041311] Subtest basic-ultra-joiner: SKIP (0.000s)
[930.122330] [152/156] (123s left) api_intel_allocator (fork-simple-stress-signal)
[930.176210] Starting subtest: fork-simple-stress-signal
[935.578500] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[935.706557] [153/156] (117s left) prime_udl
[935.792302] [154/156] (117s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[935.894191] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[935.896413] Starting dynamic subtest: pipe-A-eDP-1
[935.916732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[935.930070] Starting dynamic subtest: pipe-B-eDP-1
[935.948809] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[935.959595] Starting dynamic subtest: pipe-C-eDP-1
[935.978357] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[935.988953] Starting dynamic subtest: pipe-D-eDP-1
[936.008317] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[936.010203] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[938.171115] [155/156] (115s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[938.270197] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[938.272460] Starting dynamic subtest: pipe-A-eDP-1
[938.295349] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[938.309745] Starting dynamic subtest: pipe-B-eDP-1
[938.331354] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[938.343475] Starting dynamic subtest: pipe-C-eDP-1
[938.364881] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[938.376782] Starting dynamic subtest: pipe-D-eDP-1
[938.398505] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[938.402862] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[940.518799] [156/156] (112s left) gem_create (create-ext-placement-all)
[940.686994] Starting subtest: create-ext-placement-all
[940.689589] Subtest create-ext-placement-all: SUCCESS (0.000s)
[940.795962] Closing watchdogs
results: parsing output: 0/ for test: kms_dirtyfb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: gem_ccs
results: parsing output: 6/ for test: gem_media_fill
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: core_auth
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_reg_read
results: parsing output: 12/ for test: prime_self_import
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_pm_backlight
results: parsing output: 20/ for test: kms_chamelium_audio
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_ppgtt
results: parsing output: 25/ for test: sysfs_heartbeat_interval
results: parsing output: 26/ for test: kms_async_flips
results: parsing output: 27/ for test: vgem_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_exec_capture
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_edge_walk
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: template
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gen3_render_linear_blits
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: gem_ctx_isolation
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: vgem_basic
results: parsing output: 52/ for test: gem_ctx_shared
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_lmem_swapping
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: gem_exec_create
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_draw_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: vgem_slow
results: parsing output: 69/ for test: i915_query
results: parsing output: 70/ for test: i915_hangman
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: gen7_exec_parse
results: parsing output: 78/ for test: gem_watchdog
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_big_fb
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_plane
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_close_race
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: kms_chamelium_frames
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_partial_pwrite_pread
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_color
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_basic
results: parsing output: 132/ for test: gem_exec_parallel
results: parsing output: 133/ for test: kms_big_fb
results: parsing output: 134/ for test: kms_plane
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: syncobj_timeline
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: perf
results: parsing output: 140/ for test: prime_busy
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: i915_suspend
results: parsing output: 143/ for test: kms_mmap_write_crc
results: parsing output: 144/ for test: kms_sequence
results: parsing output: 145/ for test: dumb_buffer
results: parsing output: 146/ for test: gem_exec_parallel
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: gem_exec_fence
results: parsing output: 150/ for test: kms_joiner
results: parsing output: 151/ for test: api_intel_allocator
results: parsing output: 152/ for test: prime_udl
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: kms_ccs
results: parsing output: 155/ for test: gem_create
Done.