[59.050080] Initializing watchdogs
[59.050149]   /dev/watchdog0
[59.063954] [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.068148] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.070265] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.073908] [001/133] (960s left) gem_spin_batch (legacy-resubmit)
[59.160747] Starting subtest: legacy-resubmit
[59.163239] Starting dynamic subtest: default
[59.170964] Dynamic subtest default: SUCCESS (0.010s)
[59.182238] Starting dynamic subtest: render
[59.184510] Dynamic subtest render: SUCCESS (0.001s)
[59.191321] Starting dynamic subtest: bsd
[59.193232] Dynamic subtest bsd: SUCCESS (0.003s)
[59.199131] Starting dynamic subtest: bsd1
[59.201076] Dynamic subtest bsd1: SUCCESS (0.001s)
[59.207315] Starting dynamic subtest: bsd2
[59.209184] Dynamic subtest bsd2: SUCCESS (0.004s)
[59.215080] Starting dynamic subtest: blt
[59.216957] Dynamic subtest blt: SUCCESS (0.003s)
[59.222935] Starting dynamic subtest: vebox
[59.224878] Dynamic subtest vebox: SUCCESS (0.004s)
[59.226792] Subtest legacy-resubmit: SUCCESS (0.030s)
[59.439894] [002/133] (960s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[59.539078] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[59.543613] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[60.639951] [003/133] (959s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[61.020224] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[61.848534] [004/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[61.958664] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[61.962673] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[62.046651] [005/133] (957s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[62.142887] Starting subtest: psr-dirtyfb-ioctl
[62.144903] Starting dynamic subtest: A-eDP-1
[66.058619] Dynamic subtest A-eDP-1: SUCCESS (3.916s)
[66.061049] Subtest psr-dirtyfb-ioctl: SUCCESS (3.917s)
[66.852991] [006/133] (952s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[66.959751] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[66.962231] Starting dynamic subtest: pipe-A-eDP-1
[66.986657] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.999270] Starting dynamic subtest: pipe-B-eDP-1
[67.021712] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.031588] Starting dynamic subtest: pipe-C-eDP-1
[67.054211] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.063145] Starting dynamic subtest: pipe-D-eDP-1
[67.090644] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[67.096229] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[69.130038] [007/133] (950s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[69.232132] Starting subtest: 4-tiled-16bpp-rotate-180
[70.594183] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.363s)
[70.712686] [008/133] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[70.816306] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[70.819845] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[70.917724] [009/133] (948s left) kms_pm_rpm (modeset-lpsp-stress)
[73.033736] Starting subtest: modeset-lpsp-stress
[89.541445] Subtest modeset-lpsp-stress: SUCCESS (16.512s)
[89.624470] [010/133] (930s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[89.728158] Starting subtest: y-tiled-32bpp-rotate-180
[89.732246] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[89.854812] [011/133] (930s left) kms_psr (fbc-pr-primary-blt)
[89.943799] Starting subtest: fbc-pr-primary-blt
[89.948187] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[90.019929] [012/133] (929s left) kms_flip (wf_vblank-ts-check)
[90.111193] Starting subtest: wf_vblank-ts-check
[90.113683] Starting dynamic subtest: A-eDP1
[99.036165] Dynamic subtest A-eDP1: SUCCESS (8.929s)
[99.045870] Starting dynamic subtest: B-eDP1
[107.965889] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[107.975281] Starting dynamic subtest: C-eDP1
[116.889070] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[116.896745] Starting dynamic subtest: D-eDP1
[125.824473] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[125.829283] Subtest wf_vblank-ts-check: SUCCESS (35.724s)
[127.039392] [013/133] (892s left) gem_exec_whisper (basic-queues)
[127.115655] Starting subtest: basic-queues
[132.318874] Subtest basic-queues: SUCCESS (5.201s)
[132.497557] [014/133] (887s left) gem_gpgpu_fill (basic)
[132.556179] Starting subtest: basic
[132.558548] Starting dynamic subtest: smem
[132.566850] Dynamic subtest smem: SUCCESS (0.011s)
[132.569347] Subtest basic: SUCCESS (0.011s)
[132.708870] [015/133] (887s left) gem_mmap_offset (bad-flags)
[132.759625] Starting subtest: bad-flags
[132.761863] Subtest bad-flags: SUCCESS (0.000s)
[132.859768] [016/133] (887s left) kms_chamelium_color (ctm-max)
[132.958785] Subtest ctm-max: SKIP (0.000s)
[132.999030] [017/133] (887s left) gem_userptr_blits (huge-split)
[133.078855] Starting subtest: huge-split
[133.085680] Subtest huge-split: SUCCESS (0.007s)
[133.221996] [018/133] (886s left) gem_exec_schedule (preemptive-hang)
[133.395312] Starting subtest: preemptive-hang
[133.398105] Starting dynamic subtest: rcs0
[143.042577] Dynamic subtest rcs0: SUCCESS (9.645s)
[143.052839] Starting dynamic subtest: bcs0
[152.060332] Dynamic subtest bcs0: SUCCESS (9.017s)
[152.069778] Starting dynamic subtest: vcs0
[161.042933] Dynamic subtest vcs0: SUCCESS (8.982s)
[161.050995] Starting dynamic subtest: vcs1
[170.041130] Dynamic subtest vcs1: SUCCESS (8.995s)
[170.051190] Starting dynamic subtest: vecs0
[179.004599] Dynamic subtest vecs0: SUCCESS (8.963s)
[179.014664] Starting dynamic subtest: ccs0
[188.034047] Dynamic subtest ccs0: SUCCESS (9.028s)
[188.036052] Subtest preemptive-hang: SUCCESS (54.636s)
[188.267832] [019/133] (831s left) sysfs_heartbeat_interval (invalid)
[188.318806] Starting subtest: invalid
[188.321332] Starting dynamic subtest: vecs0
[188.323681] Dynamic subtest vecs0: SUCCESS (0.000s)
[188.332816] Starting dynamic subtest: ccs0
[188.334627] Dynamic subtest ccs0: SUCCESS (0.000s)
[188.341392] Starting dynamic subtest: vcs0
[188.343802] Dynamic subtest vcs0: SUCCESS (0.000s)
[188.350989] Starting dynamic subtest: bcs0
[188.353094] Dynamic subtest bcs0: SUCCESS (0.000s)
[188.360091] Starting dynamic subtest: rcs0
[188.361916] Dynamic subtest rcs0: SUCCESS (0.000s)
[188.369163] Starting dynamic subtest: vcs1
[188.371732] Dynamic subtest vcs1: SUCCESS (0.000s)
[188.374079] Subtest invalid: SUCCESS (0.003s)
[188.423177] [020/133] (831s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[188.525150] Starting subtest: psr-2p-primscrn-cur-indfb-move
[188.529182] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[188.615212] [021/133] (831s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[188.688602] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[188.750368] [022/133] (831s left) syncobj_timeline (single-wait-for-submit-signaled)
[188.810817] Starting subtest: single-wait-for-submit-signaled
[188.813081] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[188.902014] [023/133] (831s left) gem_exec_reloc (basic-wc-gtt-active)
[188.959945] Subtest basic-wc-gtt-active: SKIP (0.000s)
[189.018804] [024/133] (831s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[189.105578] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[189.109643] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[189.178898] [025/133] (831s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[189.270846] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[189.282613] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[189.354377] [026/133] (831s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[189.441049] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[189.444297] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[189.509008] [027/133] (831s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[189.562171] Starting subtest: multi-wait-available-unsubmitted-submitted
[189.564093] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[189.649216] [028/133] (830s left) gen9_exec_parse (bb-start-param)
[189.705659] Subtest bb-start-param: SKIP (0.000s)
[189.777358] [029/133] (830s left) i915_getparams_basic (basic-subslice-total)
[189.827951] Starting subtest: basic-subslice-total
[189.831372] Subtest basic-subslice-total: SUCCESS (0.000s)
[189.914777] [030/133] (830s left) syncobj_wait (multi-wait-submitted)
[189.965854] Starting subtest: multi-wait-submitted
[190.074283] Subtest multi-wait-submitted: SUCCESS (0.107s)
[190.161325] [031/133] (830s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[190.219112] Starting subtest: multi-wait-all-for-submit-signaled
[190.221138] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[190.312515] [032/133] (830s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[190.405653] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[190.409882] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[190.474656] [033/133] (830s left) kms_properties (colorop-properties-atomic)
[190.573895] Starting subtest: colorop-properties-atomic
[190.576176] Starting dynamic subtest: pipe-A-eDP-1
[190.918517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.343s)
[190.932996] Starting dynamic subtest: pipe-B-eDP-1
[192.009186] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.090s)
[192.017813] Starting dynamic subtest: pipe-C-eDP-1
[193.039844] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.030s)
[193.049044] Starting dynamic subtest: pipe-D-eDP-1
[194.076081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.035s)
[194.078366] Subtest colorop-properties-atomic: SUCCESS (3.502s)
[194.867977] [034/133] (825s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[194.962291] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[194.964696] Starting dynamic subtest: pipe-A-eDP-1
[194.988510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[195.001811] Starting dynamic subtest: pipe-B-eDP-1
[195.023440] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[195.031976] Starting dynamic subtest: pipe-C-eDP-1
[195.053451] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[195.061106] Starting dynamic subtest: pipe-D-eDP-1
[195.082739] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[195.087111] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[197.245641] [035/133] (823s left) gem_userptr_blits (readonly-unsync)
[197.323155] Subtest readonly-unsync: SKIP (0.000s)
[197.426342] [036/133] (823s left) kms_psr (fbc-psr2-no-drrs)
[197.519052] Starting subtest: fbc-psr2-no-drrs
[197.520993] Starting dynamic subtest: eDP-1
[197.525180] Dynamic subtest eDP-1: SKIP (0.000s)
[197.529337] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[197.594429] [037/133] (823s left) kms_properties (plane-properties-atomic)
[197.678849] Starting subtest: plane-properties-atomic
[197.681259] Starting dynamic subtest: pipe-A-eDP-1
[198.233264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[198.243773] Starting dynamic subtest: pipe-B-eDP-1
[199.533844] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.300s)
[199.542897] Starting dynamic subtest: pipe-C-eDP-1
[200.762443] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s)
[200.771171] Starting dynamic subtest: pipe-D-eDP-1
[201.995758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[201.998539] Subtest plane-properties-atomic: SUCCESS (4.315s)
[202.799940] [038/133] (818s left) gem_ctx_persistence (heartbeat-hang)
[202.875292] Starting subtest: heartbeat-hang
[202.879805] Subtest heartbeat-hang: SKIP (0.000s)
[202.986283] [039/133] (818s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[203.090983] Starting subtest: x-tiled-8bpp-rotate-270
[203.114948] Subtest x-tiled-8bpp-rotate-270: SKIP (0.024s)
[203.233999] [040/133] (817s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[203.318810] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[203.321099] Starting dynamic subtest: pipe-A-eDP-1
[203.343093] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[203.352265] Starting dynamic subtest: pipe-B-eDP-1
[203.372290] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[203.379196] Starting dynamic subtest: pipe-C-eDP-1
[203.400390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[203.407213] Starting dynamic subtest: pipe-D-eDP-1
[203.428885] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[203.433164] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[205.560067] [041/133] (815s left) fbdev (info)
[205.601144] Starting subtest: info
[205.603371] Subtest info: SUCCESS (0.000s)
[205.660255] [042/133] (815s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[205.764507] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[206.864599] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.100s)
[206.989646] [043/133] (814s left) gem_partial_pwrite_pread (reads)
[207.051959] Subtest reads: SKIP (0.000s)
[207.126818] [044/133] (814s left) kms_vblank (query-idle)
[207.222498] Starting subtest: query-idle
[207.224356] Starting dynamic subtest: pipe-A-eDP-1
[208.969629] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.747s)
[208.983194] Starting dynamic subtest: pipe-D-eDP-1
[211.388271] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[211.390167] Subtest query-idle: SUCCESS (4.165s)
[212.215614] [045/133] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[212.322206] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[212.326172] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[212.410472] [046/133] (808s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[212.528358] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[219.473815] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.947s)
[219.623369] [047/133] (801s left) api_intel_bb (render)
[219.673214] Starting subtest: render
[219.675446] Starting dynamic subtest: render-none-512
[219.773576] Dynamic subtest render-none-512: SUCCESS (0.102s)
[219.784444] Starting dynamic subtest: render-none-1024
[220.437466] Dynamic subtest render-none-1024: SUCCESS (0.662s)
[220.452691] Starting dynamic subtest: render-x-512
[220.520850] Dynamic subtest render-x-512: SUCCESS (0.084s)
[220.529873] Starting dynamic subtest: render-x-1024
[220.875594] Dynamic subtest render-x-1024: SUCCESS (0.353s)
[220.885226] Starting dynamic subtest: render-y-512
[220.958787] Dynamic subtest render-y-512: SUCCESS (0.084s)
[220.967800] Starting dynamic subtest: render-y-1024
[221.297712] Dynamic subtest render-y-1024: SUCCESS (0.337s)
[221.300366] Subtest render: SUCCESS (1.625s)
[221.395517] [048/133] (799s left) gem_workarounds (basic-read-context)
[221.475836] Starting subtest: basic-read-context
[221.487966] Subtest basic-read-context: SUCCESS (0.011s)
[221.623012] [049/133] (799s left) kms_plane (plane-position-hole-dpms)
[221.729932] Starting subtest: plane-position-hole-dpms
[222.265083] Starting dynamic subtest: pipe-A-plane-1
[224.638056] Dynamic subtest pipe-A-plane-1: SUCCESS (2.375s)
[224.646479] Starting dynamic subtest: pipe-A-plane-2
[227.002060] Dynamic subtest pipe-A-plane-2: SUCCESS (2.361s)
[227.011168] Starting dynamic subtest: pipe-A-plane-3
[229.355121] Dynamic subtest pipe-A-plane-3: SUCCESS (2.351s)
[229.364061] Starting dynamic subtest: pipe-A-plane-4
[231.717726] Dynamic subtest pipe-A-plane-4: SUCCESS (2.363s)
[231.729905] Starting dynamic subtest: pipe-A-plane-5
[231.741567] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[232.883444] Starting dynamic subtest: pipe-B-plane-1
[235.325195] Dynamic subtest pipe-B-plane-1: SUCCESS (2.446s)
[235.334273] Starting dynamic subtest: pipe-B-plane-2
[237.662053] Dynamic subtest pipe-B-plane-2: SUCCESS (2.334s)
[237.670699] Starting dynamic subtest: pipe-B-plane-3
[240.044372] Dynamic subtest pipe-B-plane-3: SUCCESS (2.385s)
[240.054775] Starting dynamic subtest: pipe-B-plane-4
[242.441026] Dynamic subtest pipe-B-plane-4: SUCCESS (2.394s)
[242.449302] Starting dynamic subtest: pipe-B-plane-5
[242.463525] Dynamic subtest pipe-B-plane-5: SUCCESS (0.022s)
[242.465750] Subtest plane-position-hole-dpms: SUCCESS (20.733s)
[243.307852] [050/133] (778s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[243.436151] Starting subtest: cursorB-vs-flipB-atomic
[243.440362] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[243.587212] [051/133] (777s left) gem_render_copy_redux (normal)
[243.649721] Starting subtest: normal
[243.902735] Subtest normal: SUCCESS (0.254s)
[244.025933] [052/133] (777s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[244.116966] Starting subtest: psr-rgb101010-draw-blt
[251.337872] Subtest psr-rgb101010-draw-blt: SUCCESS (7.225s)
[251.451303] [053/133] (770s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[251.554692] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[251.559246] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[251.651817] [054/133] (769s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[251.758680] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[256.140415] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.386s)
[257.335886] [055/133] (764s left) kms_flip (flip-vs-suspend-interruptible)
[257.462529] Starting subtest: flip-vs-suspend-interruptible
[257.465019] Starting dynamic subtest: A-eDP1
[402.614925] Dynamic subtest A-eDP1: SUCCESS (12.071s)
[402.617606] Subtest flip-vs-suspend-interruptible: SUCCESS (12.074s)
[402.765812] [056/133] (618s left) kms_color_pipeline (plane-lut1d-lut1d)
[402.866759] Starting subtest: plane-lut1d-lut1d
[403.017621] Starting dynamic subtest: pipe-A-plane-0
[403.184105] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[403.194394] Starting dynamic subtest: pipe-A-plane-1
[403.351006] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[403.361487] Starting dynamic subtest: pipe-A-plane-2
[403.517195] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[404.688360] Starting dynamic subtest: pipe-B-plane-0
[404.838639] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[404.853854] Starting dynamic subtest: pipe-B-plane-1
[404.993037] Dynamic subtest pipe-B-plane-1: SUCCESS (0.153s)
[405.002172] Starting dynamic subtest: pipe-B-plane-2
[405.137373] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[406.312204] Starting dynamic subtest: pipe-C-plane-0
[406.462147] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[406.478287] Starting dynamic subtest: pipe-C-plane-1
[406.627088] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[406.636495] Starting dynamic subtest: pipe-C-plane-2
[406.793971] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[407.968722] Starting dynamic subtest: pipe-D-plane-0
[408.114619] Dynamic subtest pipe-D-plane-0: SUCCESS (0.154s)
[408.124168] Starting dynamic subtest: pipe-D-plane-1
[408.259149] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[408.269411] Starting dynamic subtest: pipe-D-plane-2
[408.438221] Dynamic subtest pipe-D-plane-2: SUCCESS (0.177s)
[408.722174] Subtest plane-lut1d-lut1d: SUCCESS (5.854s)
[409.529438] [057/133] (612s left) dumb_buffer (create-clear)
[409.606124] Starting subtest: create-clear
[443.977279] Subtest create-clear: SUCCESS (34.368s)
[444.061863] [058/133] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[444.163243] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[451.567037] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.407s)
[451.701987] [059/133] (570s left) kms_frontbuffer_tracking (basic)
[451.801629] Starting subtest: basic
[455.032102] Subtest basic: SUCCESS (3.234s)
[455.138989] [060/133] (566s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[455.232076] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[455.236600] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[455.326910] [061/133] (566s left) gem_workarounds (basic-read)
[455.394616] Starting subtest: basic-read
[455.402742] Subtest basic-read: SUCCESS (0.010s)
[455.508009] [062/133] (566s left) api_intel_allocator (alloc-simple)
[455.559311] Starting subtest: alloc-simple
[455.563587] Subtest alloc-simple: SUCCESS (0.004s)
[455.690689] [063/133] (566s left) prime_vgem (basic-gtt)
[455.807370] Starting subtest: basic-gtt
[455.812217] Subtest basic-gtt: SKIP (0.000s)
[455.889012] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[455.893030] [064/133] (566s left) gem_gtt_cpu_tlb
[456.006152] [065/133] (566s left) i915_drm_fdinfo (idle)
[456.048252] Starting subtest: idle
[456.050679] Starting dynamic subtest: rcs0
[456.617511] Dynamic subtest rcs0: SUCCESS (0.570s)
[456.629359] Starting dynamic subtest: bcs0
[457.125763] Dynamic subtest bcs0: SUCCESS (0.504s)
[457.137616] Starting dynamic subtest: vcs0
[457.630837] Dynamic subtest vcs0: SUCCESS (0.503s)
[457.642715] Starting dynamic subtest: vcs1
[458.137050] Dynamic subtest vcs1: SUCCESS (0.503s)
[458.149347] Starting dynamic subtest: vecs0
[458.661866] Dynamic subtest vecs0: SUCCESS (0.502s)
[458.674210] Starting dynamic subtest: ccs0
[459.147518] Dynamic subtest ccs0: SUCCESS (0.503s)
[459.150538] Subtest idle: SUCCESS (3.101s)
[459.225646] [066/133] (562s left) kms_plane_alpha_blend (alpha-7efc)
[459.317277] Starting subtest: alpha-7efc
[459.604187] Starting dynamic subtest: pipe-A-eDP-1
[460.204957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[460.235889] Starting dynamic subtest: pipe-D-eDP-1
[461.573822] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[461.576342] Subtest alpha-7efc: SUCCESS (2.257s)
[462.427384] [067/133] (559s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[462.525869] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[466.485654] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.964s)
[467.635182] [068/133] (554s left) kms_async_flips (alternate-sync-async-flip)
[467.740463] Starting subtest: alternate-sync-async-flip
[468.117675] Starting dynamic subtest: pipe-A-eDP-1
[470.913358] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.799s)
[471.281948] Starting dynamic subtest: pipe-B-eDP-1
[474.046352] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[474.420283] Starting dynamic subtest: pipe-C-eDP-1
[477.180503] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[477.562576] Starting dynamic subtest: pipe-D-eDP-1
[480.307574] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.755s)
[480.310101] Subtest alternate-sync-async-flip: SUCCESS (12.570s)
[481.478056] [069/133] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[481.591283] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[481.597281] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[481.692124] [070/133] (540s left) kms_psr (pr-sprite-render)
[481.789121] Starting subtest: pr-sprite-render
[481.794287] Subtest pr-sprite-render: SKIP (0.000s)
[481.863653] [071/133] (540s left) gem_exec_schedule (u-semaphore-resolve)
[481.938453] Starting subtest: u-semaphore-resolve
[481.968147] Subtest u-semaphore-resolve: SUCCESS (0.040s)
[482.315224] [072/133] (540s left) kms_chamelium_color (ctm-red-to-blue)
[482.413574] Subtest ctm-red-to-blue: SKIP (0.000s)
[482.459006] [073/133] (539s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[482.514807] Starting subtest: yf-tiled-ccs-to-yf-tiled
[482.520372] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[482.711445] [074/133] (539s left) kms_feature_discovery (display-2x)
[482.807458] Starting subtest: display-2x
[482.812862] Subtest display-2x: SKIP (0.000s)
[482.902101] [075/133] (539s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[483.024045] Starting subtest: basic-busy-flip-before-cursor-legacy
[483.029217] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[483.166199] [076/133] (539s left) syncobj_wait (wait-all-complex)
[483.230388] Starting subtest: wait-all-complex
[483.447568] Subtest wait-all-complex: SUCCESS (0.217s)
[483.523042] [077/133] (539s left) kms_atomic_interruptible (universal-setplane-cursor)
[483.614854] Starting subtest: universal-setplane-cursor
[483.617181] Starting dynamic subtest: pipe-A-eDP-1
[490.992554] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.378s)
[490.994941] Subtest universal-setplane-cursor: SUCCESS (7.380s)
[491.857487] [078/133] (530s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[491.959170] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[491.964040] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[492.046119] [079/133] (530s left) kms_getfb (getfb2-handle-closed)
[492.132089] Starting subtest: getfb2-handle-closed
[492.134740] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[492.223798] [080/133] (530s left) i915_pm_rpm (system-suspend)
[494.161913] Starting subtest: system-suspend
[512.396435] Subtest system-suspend: SUCCESS (2.857s)
[512.768633] [081/133] (509s left) gem_mmap_gtt (basic-read-write)
[512.825403] Subtest basic-read-write: SKIP (0.000s)
[512.886034] [082/133] (509s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[513.139359] Starting subtest: cursor-rapid-movement-256x256
[513.144850] Starting dynamic subtest: pipe-A-eDP-1
[513.688272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[513.716246] Starting dynamic subtest: pipe-D-eDP-1
[514.875521] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.166s)
[514.878419] Subtest cursor-rapid-movement-256x256: SUCCESS (1.735s)
[515.722333] [083/133] (507s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[515.815360] Starting subtest: primary-x-tiled-reflect-x-180
[522.956068] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.142s)
[524.112059] [084/133] (498s left) prime_vgem (coherency-gtt)
[524.175681] Starting subtest: coherency-gtt
[524.181029] Subtest coherency-gtt: SKIP (0.000s)
[524.277886] [085/133] (498s left) syncobj_wait (reset-signaled)
[524.336610] Starting subtest: reset-signaled
[524.339438] Subtest reset-signaled: SUCCESS (0.000s)
[524.433822] [086/133] (498s left) kms_content_protection (lic-type-0)
[524.586588] Starting subtest: lic-type-0
[524.591348] Subtest lic-type-0: SKIP (0.000s)
[524.691675] [087/133] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[524.783318] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[524.788311] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[524.878717] [088/133] (498s left) gem_pwrite (basic-exhaustion)
[524.946372] Subtest basic-exhaustion: SKIP (0.000s)
[525.006375] [089/133] (498s left) kms_joiner (basic-force-big-joiner)
[525.103226] Starting subtest: basic-force-big-joiner
[525.108016] Subtest basic-force-big-joiner: SKIP (0.000s)
[525.172021] [090/133] (497s left) gem_ctx_shared (exec-shared-gtt)
[525.237085] Starting subtest: exec-shared-gtt
[525.239247] Starting dynamic subtest: rcs0
[525.244571] Dynamic subtest rcs0: SUCCESS (0.007s)
[525.254431] Starting dynamic subtest: bcs0
[525.256457] Dynamic subtest bcs0: SUCCESS (0.007s)
[525.266048] Starting dynamic subtest: vcs0
[525.267894] Dynamic subtest vcs0: SUCCESS (0.009s)
[525.276128] Starting dynamic subtest: vcs1
[525.277956] Dynamic subtest vcs1: SUCCESS (0.007s)
[525.286314] Starting dynamic subtest: vecs0
[525.288512] Dynamic subtest vecs0: SUCCESS (0.008s)
[525.296949] Starting dynamic subtest: ccs0
[525.298851] Dynamic subtest ccs0: SUCCESS (0.005s)
[525.300647] Subtest exec-shared-gtt: SUCCESS (0.048s)
[525.473382] [091/133] (497s left) perf (whitelisted-registers-userspace-config)
[525.600577] Starting subtest: whitelisted-registers-userspace-config
[525.602625] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[525.650030] [092/133] (497s left) kms_psr (psr2-cursor-mmap-cpu)
[525.750780] Starting subtest: psr2-cursor-mmap-cpu
[525.753086] Starting dynamic subtest: eDP-1
[527.482848] Dynamic subtest eDP-1: SUCCESS (1.732s)
[527.485500] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.733s)
[528.282827] [093/133] (494s left) perf_pmu (faulting-read)
[528.329501] Starting subtest: faulting-read
[528.332189] Starting dynamic subtest: wb
[528.334655] Dynamic subtest wb: SUCCESS (0.001s)
[528.343868] Starting dynamic subtest: wc
[528.346228] Dynamic subtest wc: SUCCESS (0.000s)
[528.355172] Starting dynamic subtest: uc
[528.357489] Dynamic subtest uc: SUCCESS (0.000s)
[528.359970] Subtest faulting-read: SUCCESS (0.003s)
[528.453295] [094/133] (494s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[528.517312] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[528.519620] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[528.605861] [095/133] (494s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[528.703265] Starting subtest: 4-tiled-addfb-size-offset-overflow
[528.706006] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[528.802393] [096/133] (494s left) syncobj_wait (multi-wait-for-submit-signaled)
[528.854512] Starting subtest: multi-wait-for-submit-signaled
[528.857315] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[528.945916] [097/133] (494s left) kms_rotation_crc (bad-pixel-format)
[529.043301] Starting subtest: bad-pixel-format
[529.048254] Subtest bad-pixel-format: SKIP (0.001s)
[529.117465] [098/133] (494s left) kms_cursor_crc (cursor-onscreen-512x512)
[529.375456] Starting subtest: cursor-onscreen-512x512
[529.379972] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[529.518980] [099/133] (493s left) kms_rotation_crc (multiplane-rotation)
[529.615088] Starting subtest: multiplane-rotation
[547.133191] Subtest multiplane-rotation: SUCCESS (17.518s)
[547.238699] [100/133] (476s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[547.324239] Starting subtest: fbc-psr2-sprite-mmap-cpu
[547.326204] Starting dynamic subtest: eDP-1
[547.329817] Dynamic subtest eDP-1: SKIP (0.000s)
[547.333416] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[547.396623] [101/133] (476s left) gem_exec_reloc (basic-gtt-read)
[547.459540] Subtest basic-gtt-read: SKIP (0.000s)
[547.532703] [102/133] (476s left) kms_pm_dc (dc3co-vpb-simulation)
[548.625774] Starting subtest: dc3co-vpb-simulation
[557.331178] Subtest dc3co-vpb-simulation: SKIP (8.704s)
[557.474075] [103/133] (466s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[557.597297] Starting subtest: cursorB-vs-flipB-toggle
[557.602455] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[557.743434] [104/133] (465s left) gem_exec_params (readonly)
[557.799487] Starting subtest: readonly
[557.802064] Subtest readonly: SUCCESS (0.003s)
[557.923143] [105/133] (465s left) gem_userptr_blits (sync-unmap-cycles)
[557.988318] Starting subtest: sync-unmap-cycles
[563.359426] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[563.493938] [106/133] (460s left) gem_exec_balancer (hog)
[563.552881] Starting subtest: hog
[563.557863] Subtest hog: SKIP (0.000s)
[563.856992] [107/133] (459s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[563.965892] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[563.970383] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[564.064849] [108/133] (459s left) kms_flip (2x-flip-vs-panning)
[564.164501] Starting subtest: 2x-flip-vs-panning
[564.172038] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[564.289393] [109/133] (459s left) gem_mmap_gtt (basic-short)
[564.346458] Subtest basic-short: SKIP (0.000s)
[564.405318] [110/133] (459s left) syncobj_basic (bad-destroy-pad)
[564.453481] Starting subtest: bad-destroy-pad
[564.456438] Subtest bad-destroy-pad: SUCCESS (0.000s)
[564.546886] [111/133] (459s left) syncobj_timeline (device-submit-unordered)
[564.607796] Starting subtest: device-submit-unordered
[564.610407] Subtest device-submit-unordered: SUCCESS (0.001s)
[564.703809] [112/133] (459s left) kms_cursor_edge_walk (256x256-right-edge)
[564.802928] Starting subtest: 256x256-right-edge
[564.804810] Starting dynamic subtest: pipe-A-eDP-1
[568.244304] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[568.258380] Starting dynamic subtest: pipe-D-eDP-1
[571.362464] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[571.365442] Subtest 256x256-right-edge: SUCCESS (6.560s)
[572.166205] [113/133] (451s left) gem_ctx_persistence (engines-hostile-preempt)
[572.216920] Starting subtest: engines-hostile-preempt
[572.219447] Starting dynamic subtest: rcs0
[572.280546] Dynamic subtest rcs0: SUCCESS (0.064s)
[572.292621] Starting dynamic subtest: bcs0
[572.334876] Dynamic subtest bcs0: SUCCESS (0.052s)
[572.346623] Starting dynamic subtest: vcs0
[574.327847] Dynamic subtest vcs0: SUCCESS (1.989s)
[574.339427] Starting dynamic subtest: vcs1
[576.365080] Dynamic subtest vcs1: SUCCESS (2.034s)
[576.377156] Starting dynamic subtest: vecs0
[578.348601] Dynamic subtest vecs0: SUCCESS (1.981s)
[578.360980] Starting dynamic subtest: ccs0
[578.426540] Dynamic subtest ccs0: SUCCESS (0.076s)
[578.429397] Subtest engines-hostile-preempt: SUCCESS (6.210s)
[578.507008] [114/133] (445s left) i915_query (test-query-geometry-subslices)
[578.557943] Starting subtest: test-query-geometry-subslices
[578.560041] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[578.667791] [115/133] (445s left) syncobj_wait (wait-for-submit-delayed-submit)
[578.734083] Starting subtest: wait-for-submit-delayed-submit
[578.834342] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[578.917366] [116/133] (445s left) perf (non-zero-reason)
[579.018453] Starting subtest: non-zero-reason
[579.021283] Starting dynamic subtest: 0-rcs0
[584.306585] Dynamic subtest 0-rcs0: SUCCESS (5.286s)
[584.319731] Starting dynamic subtest: 1-vcs0
[588.169171] Dynamic subtest 1-vcs0: SUCCESS (3.861s)
[588.172403] Subtest non-zero-reason: SUCCESS (9.149s)
[588.216472] [117/133] (436s left) kms_plane_lowres (tiling-4)
[588.310246] Starting subtest: tiling-4
[588.312834] Starting dynamic subtest: pipe-A-eDP-1
[588.317959] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[588.604871] Starting dynamic subtest: pipe-B-eDP-1
[588.609994] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[588.619602] Starting dynamic subtest: pipe-C-eDP-1
[588.625348] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[588.634858] Starting dynamic subtest: pipe-D-eDP-1
[588.640315] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[588.645462] Subtest tiling-4: SKIP (0.293s)
[589.401657] [118/133] (434s left) gem_exec_fence (syncobj-import)
[589.855919] Starting subtest: syncobj-import
[589.861809] Subtest syncobj-import: SUCCESS (0.006s)
[591.457669] [119/133] (432s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[591.554370] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[591.559510] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[591.658042] [120/133] (432s left) gem_exec_basic (basic)
[591.716415] Starting subtest: basic
[591.719077] Starting dynamic subtest: rcs0-smem
[591.721300] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[591.733033] Starting dynamic subtest: bcs0-smem
[591.735374] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[591.745503] Starting dynamic subtest: vcs0-smem
[591.748357] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[591.757625] Starting dynamic subtest: vcs1-smem
[591.760408] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[591.770116] Starting dynamic subtest: vecs0-smem
[591.772499] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[591.782435] Starting dynamic subtest: ccs0-smem
[591.785309] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[591.788086] Subtest basic: SUCCESS (0.021s)
[593.389248] [121/133] (431s left) kms_selftest (drm_dp_mst_helper)
[593.442340] Starting subtest: drm_dp_mst_helper
[593.455364] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[593.547401] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.092s)
[593.557070] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[593.687797] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.137s)
[593.697412] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[593.806921] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.118s)
[593.809324] Subtest drm_dp_mst_helper: SUCCESS (0.363s)
[593.971258] [122/133] (430s left) gem_mmap_gtt (basic-write)
[594.028852] Subtest basic-write: SKIP (0.000s)
[594.096421] [123/133] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[594.196843] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[594.201479] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[594.282269] [124/133] (430s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[594.380341] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[594.385175] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[594.448139] [125/133] (430s left) gem_ctx_engines (execute-oneforall)
[594.512369] Starting subtest: execute-oneforall
[595.056339] Subtest execute-oneforall: SUCCESS (0.544s)
[596.455532] [126/133] (428s left) kms_busy (basic-hang)
[596.550374] Starting subtest: basic-hang
[596.553107] Starting dynamic subtest: flip-pipe-A
[597.127146] Dynamic subtest flip-pipe-A: SUCCESS (0.578s)
[597.147604] Starting dynamic subtest: modeset-pipe-A
[600.752155] Dynamic subtest modeset-pipe-A: SUCCESS (3.623s)
[600.763492] Starting dynamic subtest: flip-pipe-D
[601.970814] Dynamic subtest flip-pipe-D: SUCCESS (1.216s)
[601.981403] Starting dynamic subtest: modeset-pipe-D
[605.375532] Dynamic subtest modeset-pipe-D: SUCCESS (3.403s)
[605.378377] Subtest basic-hang: SUCCESS (8.827s)
[606.175457] [127/133] (418s left) i915_query (query-topology-coherent-slice-mask)
[606.247497] Starting subtest: query-topology-coherent-slice-mask
[606.252501] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[606.350446] [128/133] (418s left) syncobj_timeline (host-signal-points)
[606.413889] Starting subtest: host-signal-points
[606.416325] Subtest host-signal-points: SUCCESS (0.004s)
[606.501400] [129/133] (418s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[606.601979] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[607.393118] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[607.566856] [130/133] (417s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[607.662414] Starting subtest: plane-upscale-20x20-with-modifiers
[607.665102] Starting dynamic subtest: pipe-A
[607.998200] Dynamic subtest pipe-A: SUCCESS (0.338s)
[608.008641] Starting dynamic subtest: pipe-B
[609.371015] Dynamic subtest pipe-B: SUCCESS (1.372s)
[609.380872] Starting dynamic subtest: pipe-C
[610.805864] Dynamic subtest pipe-C: SUCCESS (1.433s)
[610.817603] Starting dynamic subtest: pipe-D
[612.227278] Dynamic subtest pipe-D: SUCCESS (1.421s)
[612.230017] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.569s)
[613.403969] [131/133] (411s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[613.520715] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[613.525708] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[613.605049] [132/133] (411s left) prime_busy (after)
[613.654218] Starting subtest: after
[613.659797] Starting dynamic subtest: rcs0
[613.683217] Dynamic subtest rcs0: SUCCESS (0.025s)
[613.694081] Starting dynamic subtest: bcs0
[613.723370] Dynamic subtest bcs0: SUCCESS (0.039s)
[613.733814] Starting dynamic subtest: vcs0
[613.765115] Dynamic subtest vcs0: SUCCESS (0.041s)
[613.775301] Starting dynamic subtest: vcs1
[613.808011] Dynamic subtest vcs1: SUCCESS (0.042s)
[613.818354] Starting dynamic subtest: vecs0
[613.849325] Dynamic subtest vecs0: SUCCESS (0.041s)
[613.859675] Starting dynamic subtest: ccs0
[613.891393] Dynamic subtest ccs0: SUCCESS (0.041s)
[614.000099] Subtest after: SUCCESS (0.344s)
[614.079597] [133/133] (410s left) gem_ringfill (legacy-basic)
[619.399520] Starting subtest: legacy-basic
[619.402642] Starting dynamic subtest: default
[619.445199] Dynamic subtest default: SUCCESS (0.045s)
[619.458002] Starting dynamic subtest: render
[619.485931] Dynamic subtest render: SUCCESS (0.040s)
[619.496632] Starting dynamic subtest: bsd
[619.530491] Dynamic subtest bsd: SUCCESS (0.043s)
[619.541909] Starting dynamic subtest: bsd1
[619.575731] Dynamic subtest bsd1: SUCCESS (0.043s)
[619.588962] Starting dynamic subtest: bsd2
[619.615506] Dynamic subtest bsd2: SUCCESS (0.038s)
[619.625953] Starting dynamic subtest: blt
[619.662216] Dynamic subtest blt: SUCCESS (0.045s)
[619.673722] Starting dynamic subtest: vebox
[619.707608] Dynamic subtest vebox: SUCCESS (0.043s)
[619.710630] Subtest legacy-basic: SUCCESS (0.310s)
[619.790339] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_dirtyfb
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_exec_whisper
results: parsing output: 13/ for test: gem_gpgpu_fill
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: kms_chamelium_color
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: sysfs_heartbeat_interval
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: i915_getparams_basic
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_properties
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: fbdev
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: api_intel_bb
results: parsing output: 47/ for test: gem_workarounds
results: parsing output: 48/ for test: kms_plane
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: gem_render_copy_redux
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_color_pipeline
results: parsing output: 56/ for test: dumb_buffer
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_workarounds
results: parsing output: 61/ for test: api_intel_allocator
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: gem_gtt_cpu_tlb
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_async_flips
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_chamelium_color
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_feature_discovery
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_atomic_interruptible
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_getfb
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: prime_vgem
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_content_protection
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_pwrite
results: parsing output: 88/ for test: kms_joiner
results: parsing output: 89/ for test: gem_ctx_shared
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_pm_dc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: syncobj_basic
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_cursor_edge_walk
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: i915_query
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_plane_lowres
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_basic
results: parsing output: 120/ for test: kms_selftest
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_joiner
results: parsing output: 124/ for test: gem_ctx_engines
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: i915_query
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: prime_busy
results: parsing output: 132/ for test: gem_ringfill
Done.