[57.512877] Initializing watchdogs
[57.513002]   /dev/watchdog0
[57.527577] [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]
[57.531910] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.534327] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.537854] [001/131] (960s left) syncobj_wait (wait-all-snapshot)
[57.600962] Starting subtest: wait-all-snapshot
[57.682429] Subtest wait-all-snapshot: SUCCESS (0.080s)
[57.751216] [002/131] (960s left) kms_setmode (basic)
[57.806687] Starting subtest: basic
[58.174789] Starting dynamic subtest: pipe-A-eDP-1
[60.381740] Dynamic subtest pipe-A-eDP-1: FAIL (2.073s)
[60.613228] Starting dynamic subtest: pipe-B-eDP-1
[62.822301] Dynamic subtest pipe-B-eDP-1: FAIL (2.070s)
[63.004898] Subtest basic: FAIL (5.129s)
[63.840256] [003/131] (954s left) syncobj_timeline (reset-during-wait-for-submit)
[63.889999] Starting subtest: reset-during-wait-for-submit
[63.994635] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[64.063376] [004/131] (954s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[64.164865] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[64.167424] Starting dynamic subtest: pipe-A
[64.177080] Dynamic subtest pipe-A: SKIP (0.005s)
[64.184633] Starting dynamic subtest: pipe-B
[64.194213] Dynamic subtest pipe-B: SKIP (0.015s)
[64.200714] Starting dynamic subtest: pipe-C
[64.210098] Dynamic subtest pipe-C: SKIP (0.019s)
[64.216499] Starting dynamic subtest: pipe-D
[64.229754] Dynamic subtest pipe-D: SKIP (0.019s)
[64.234044] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.059s)
[64.336327] [005/131] (953s left) i915_pm_rps (thresholds-idle)
[64.392767] Starting subtest: thresholds-idle
[64.397613] Subtest thresholds-idle: SKIP (0.000s)
[64.466651] [006/131] (953s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[64.572281] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[64.576889] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[64.673215] [007/131] (953s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[64.782604] Starting subtest: y-tiled-32bpp-rotate-270
[64.786764] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[64.886627] [008/131] (953s left) gen9_exec_parse (batch-zero-length)
[64.944147] Subtest batch-zero-length: SKIP (0.000s)
[65.019549] [009/131] (953s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[65.133781] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[66.126045] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.986s)
[66.265814] [010/131] (952s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[66.385402] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[66.390060] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[66.516160] [011/131] (951s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[66.626054] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[66.630034] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[66.696594] [012/131] (951s left) kms_atomic (crtc-invalid-params)
[66.786717] Starting subtest: crtc-invalid-params
[66.788785] Starting dynamic subtest: pipe-A-eDP-1
[67.150631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[67.152710] Subtest crtc-invalid-params: SUCCESS (0.359s)
[67.991319] [013/131] (950s left) gem_pxp (create-regular-buffer)
[68.128873] Starting subtest: create-regular-buffer
[68.131062] Subtest create-regular-buffer: SUCCESS (0.000s)
[68.238964] [014/131] (950s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[68.336848] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[68.339130] Starting dynamic subtest: pipe-A-eDP-1
[68.361710] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.369608] Starting dynamic subtest: pipe-B-eDP-1
[68.390608] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.396640] Starting dynamic subtest: pipe-C-eDP-1
[68.418552] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.425941] Starting dynamic subtest: pipe-D-eDP-1
[68.449415] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.453794] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[70.463807] [015/131] (948s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[70.567636] Starting subtest: yf-tiled-8bpp-rotate-0
[70.571977] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[70.673756] [016/131] (947s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[70.801869] Starting subtest: modeset-atomic-cursor-hotspot
[70.806508] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[70.928370] [017/131] (947s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[71.036825] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[71.039337] Starting dynamic subtest: pipe-A-eDP-1
[71.063253] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[71.072092] Starting dynamic subtest: pipe-B-eDP-1
[71.095985] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[71.103516] Starting dynamic subtest: pipe-C-eDP-1
[71.126579] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[71.133522] Starting dynamic subtest: pipe-D-eDP-1
[71.157132] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[71.162054] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[73.233923] [018/131] (945s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[73.347869] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[74.592419] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.639s)
[74.622544] [019/131] (944s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[74.726145] Starting subtest: fbcpsr-rgb565-draw-pwrite
[79.585403] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.855s)
[79.702170] [020/131] (939s left) gem_softpin (evict-active)
[79.761607] Starting subtest: evict-active
[79.767806] Subtest evict-active: SUCCESS (0.006s)
[79.909565] [021/131] (938s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[80.001074] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[80.003413] Starting dynamic subtest: pipe-A-default-mode
[80.288150] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[80.292612] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.283s)
[81.128238] [022/131] (937s left) kms_prop_blob (blob-multiple)
[81.190082] Starting subtest: blob-multiple
[81.195104] Subtest blob-multiple: SUCCESS (0.004s)
[81.307421] [023/131] (937s left) kms_getfb (getfb2-handle-protection)
[81.366879] Starting subtest: getfb2-handle-protection
[81.395765] Subtest getfb2-handle-protection: SUCCESS (0.030s)
[81.532867] [024/131] (937s left) gem_exec_whisper (basic-fds-all)
[81.601658] Starting subtest: basic-fds-all
[92.877139] Subtest basic-fds-all: SUCCESS (11.263s)
[93.050935] [025/131] (925s left) gem_userptr_blits (userfault)
[93.125815] Starting subtest: userfault
[93.130429] Subtest userfault: SUCCESS (0.009s)
[93.258240] [026/131] (925s left) api_intel_allocator (standalone)
[93.325147] Starting subtest: standalone
[93.342880] Subtest standalone: SUCCESS (0.020s)
[93.492877] [027/131] (925s left) syncobj_eventfd (timeline-wait-signaled)
[93.557617] Starting subtest: timeline-wait-signaled
[93.560044] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[93.679081] [028/131] (925s left) gem_wait (invalid-buf)
[93.742718] Starting subtest: invalid-buf
[93.745205] Subtest invalid-buf: SUCCESS (0.000s)
[93.988235] [029/131] (925s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[94.095108] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[94.097494] Starting dynamic subtest: pipe-A
[94.182518] Dynamic subtest pipe-A: SUCCESS (0.087s)
[94.191766] Starting dynamic subtest: pipe-B
[95.357462] Dynamic subtest pipe-B: SUCCESS (1.174s)
[95.367118] Starting dynamic subtest: pipe-C
[96.452795] Dynamic subtest pipe-C: SUCCESS (1.094s)
[96.462262] Starting dynamic subtest: pipe-D
[97.578432] Dynamic subtest pipe-D: SUCCESS (1.125s)
[97.580927] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.482s)
[98.722400] [030/131] (920s left) kms_vblank (query-forked-hang)
[98.816941] Starting subtest: query-forked-hang
[98.819330] Starting dynamic subtest: pipe-A-eDP-1
[126.694960] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.869s)
[126.707357] Starting dynamic subtest: pipe-D-eDP-1
[151.726724] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.026s)
[151.729631] Subtest query-forked-hang: SUCCESS (52.899s)
[152.583223] [031/131] (866s left) kms_vrr (flip-dpms)
[152.685125] Starting subtest: flip-dpms
[152.691573] Subtest flip-dpms: SKIP (0.000s)
[152.751165] [032/131] (866s left) perf_pmu (busy-check-all)
[152.792715] Starting subtest: busy-check-all
[152.795268] Starting dynamic subtest: rcs0
[153.344803] Dynamic subtest rcs0: SUCCESS (0.552s)
[153.355659] Starting dynamic subtest: bcs0
[153.892547] Dynamic subtest bcs0: SUCCESS (0.548s)
[153.902583] Starting dynamic subtest: vcs0
[155.948392] Dynamic subtest vcs0: SUCCESS (2.053s)
[155.959625] Starting dynamic subtest: vcs1
[157.931803] Dynamic subtest vcs1: SUCCESS (1.983s)
[157.943198] Starting dynamic subtest: vecs0
[159.917613] Dynamic subtest vecs0: SUCCESS (1.985s)
[159.929271] Starting dynamic subtest: ccs0
[160.471565] Dynamic subtest ccs0: SUCCESS (0.555s)
[160.474621] Subtest busy-check-all: SUCCESS (7.679s)
[160.563160] [033/131] (858s left) kms_atomic_interruptible (legacy-cursor)
[160.659806] Starting subtest: legacy-cursor
[160.662124] Starting dynamic subtest: pipe-A-eDP-1
[168.096168] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.435s)
[168.098457] Subtest legacy-cursor: SUCCESS (7.436s)
[168.922267] [034/131] (850s left) gem_flink_basic (bad-open)
[168.983993] Starting subtest: bad-open
[168.986385] Subtest bad-open: SUCCESS (0.000s)
[169.064039] [035/131] (850s left) kms_chamelium_frames (dp-crc-fast)
[169.459668] Subtest dp-crc-fast: SKIP (0.000s)
[170.229497] [036/131] (849s left) kms_pm_backlight (fade-with-suspend)
[170.326785] Starting subtest: fade-with-suspend
[186.616823] Starting dynamic subtest: eDP-1
[189.272392] Dynamic subtest eDP-1: SUCCESS (2.659s)
[189.275651] Subtest fade-with-suspend: SUCCESS (3.974s)
[190.085840] [037/131] (844s left) syncobj_timeline (wait-all-snapshot)
[190.156045] Starting subtest: wait-all-snapshot
[190.235605] Subtest wait-all-snapshot: SUCCESS (0.081s)
[190.305427] [038/131] (844s left) gem_exec_reloc (basic-concurrent16)
[190.373179] Subtest basic-concurrent16: SKIP (0.000s)
[190.452825] [039/131] (843s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[190.563459] Starting subtest: fbc-psr-cursor-mmap-gtt
[190.565709] Starting dynamic subtest: eDP-1
[190.570039] Dynamic subtest eDP-1: SKIP (0.000s)
[190.574528] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[190.628521] [040/131] (843s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[190.739796] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[190.743748] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[190.859475] [041/131] (843s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[195.821533] Starting subtest: psr2-plane-move-sf-dmg-area
[195.823941] Starting dynamic subtest: pipe-A-eDP-1
[200.974197] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.082s)
[200.982911] Starting dynamic subtest: pipe-B-eDP-1
[206.055726] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.006s)
[206.058319] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.092s)
[206.932014] [042/131] (827s left) gem_exec_balancer (full-pulse)
[207.002355] Starting subtest: full-pulse
[211.650715] Subtest full-pulse: SUCCESS (4.616s)
[211.956964] [043/131] (822s left) gem_create (create-massive)
[212.017425] Starting subtest: create-massive
[212.019753] Subtest create-massive: SUCCESS (0.000s)
[212.198946] [044/131] (822s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[212.314996] Starting subtest: fbc-rgb101010-draw-blt
[215.889890] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.566s)
[216.022054] [045/131] (818s left) syncobj_wait (wait-delayed-signal)
[216.084858] Starting subtest: wait-delayed-signal
[216.186862] Subtest wait-delayed-signal: SUCCESS (0.102s)
[216.256827] [046/131] (818s left) gem_gtt_cpu_tlb
[216.368599] [047/131] (818s left) gem_exec_fence (submit3)
[216.551699] Starting subtest: submit3
[216.556710] Subtest submit3: SKIP (0.000s)
[217.955021] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[217.958386] [048/131] (816s left) gem_workarounds (reset-context)
[218.024531] Starting subtest: reset-context
[218.204085] Subtest reset-context: SUCCESS (0.179s)
[218.322637] [049/131] (816s left) kms_lease (lease-unleased-crtc)
[218.413673] Starting subtest: lease-unleased-crtc
[218.415957] Starting dynamic subtest: pipe-A-eDP-1
[218.707077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[218.717515] Starting dynamic subtest: pipe-B-eDP-1
[219.473575] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[219.483373] Starting dynamic subtest: pipe-C-eDP-1
[219.485710] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[219.494996] Starting dynamic subtest: pipe-D-eDP-1
[219.497120] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[219.499354] Subtest lease-unleased-crtc: SUCCESS (1.075s)
[219.831331] [050/131] (815s left) kms_flip (basic-flip-vs-wf_vblank)
[219.930777] Starting subtest: basic-flip-vs-wf_vblank
[219.933218] Starting dynamic subtest: A-eDP1
[221.880533] Dynamic subtest A-eDP1: SUCCESS (1.946s)
[221.891449] Starting dynamic subtest: B-eDP1
[223.805196] Dynamic subtest B-eDP1: SUCCESS (1.921s)
[223.814064] Starting dynamic subtest: C-eDP1
[225.723272] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[225.732268] Starting dynamic subtest: D-eDP1
[227.650755] Dynamic subtest D-eDP1: SUCCESS (1.925s)
[227.653105] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.713s)
[228.870120] [051/131] (806s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[228.976135] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[228.980392] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[229.037684] [052/131] (806s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[234.036343] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[234.038804] Starting dynamic subtest: pipe-A-eDP-1
[234.820978] Dynamic subtest pipe-A-eDP-1: SKIP (0.781s)
[234.829704] Starting dynamic subtest: pipe-B-eDP-1
[235.953217] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[235.957956] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.910s)
[237.127047] [053/131] (797s left) kms_psr (psr-cursor-mmap-gtt)
[237.225890] Starting subtest: psr-cursor-mmap-gtt
[237.228227] Starting dynamic subtest: eDP-1
[238.919131] Dynamic subtest eDP-1: SUCCESS (1.690s)
[238.921288] Subtest psr-cursor-mmap-gtt: SUCCESS (1.690s)
[239.775668] [054/131] (795s left) sw_sync (sync_merge)
[239.811899] Starting subtest: sync_merge
[239.814231] Subtest sync_merge: SUCCESS (0.000s)
[239.863427] [055/131] (795s left) gem_set_tiling_vs_pwrite
[239.990364] [056/131] (795s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[240.083421] Starting subtest: random-ccs-data-yf-tiled-ccs
[240.085840] Starting dynamic subtest: pipe-A-eDP-1
[240.111208] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.120426] Starting dynamic subtest: pipe-B-eDP-1
[240.143253] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.151811] Starting dynamic subtest: pipe-C-eDP-1
[240.174864] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.184119] Starting dynamic subtest: pipe-D-eDP-1
[240.208876] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.213051] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[242.225227] [057/131] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[242.332414] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[246.895694] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.565s)
[247.038761] [058/131] (788s left) gem_create (create-clear)
[247.095117] Starting subtest: create-clear
[247.097139] Starting dynamic subtest: smem0
[280.632811] Dynamic subtest smem0: SUCCESS (33.523s)
[280.634951] Subtest create-clear: SUCCESS (33.524s)
[281.006144] [059/131] (754s left) gem_exec_balancer (bonded-dual)
[281.073576] Starting subtest: bonded-dual
[281.078070] Subtest bonded-dual: SKIP (0.000s)
[281.335205] [060/131] (754s left) gem_lmem_swapping (verify-random-ccs)
[281.384072] Subtest verify-random-ccs: SKIP (0.000s)
[281.424628] [061/131] (753s left) gem_exec_fence (syncobj-signal)
[281.911145] Starting subtest: syncobj-signal
[281.918052] Subtest syncobj-signal: SUCCESS (0.007s)
[283.015439] [062/131] (752s left) sriov_basic (bind-unbind-vf)
[283.081438] Starting subtest: bind-unbind-vf
[283.083829] Starting dynamic subtest: vf-1
[283.158720] Dynamic subtest vf-1: FAIL (0.005s)
[283.169132] Starting dynamic subtest: vf-2
[283.244306] Dynamic subtest vf-2: FAIL (0.003s)
[283.255603] Starting dynamic subtest: vf-3
[283.329319] Dynamic subtest vf-3: FAIL (0.003s)
[283.339231] Starting dynamic subtest: vf-4
[283.412560] Dynamic subtest vf-4: FAIL (0.004s)
[283.423109] Starting dynamic subtest: vf-5
[283.496020] Dynamic subtest vf-5: FAIL (0.004s)
[283.506791] Starting dynamic subtest: vf-6
[283.583036] Dynamic subtest vf-6: FAIL (0.003s)
[283.593331] Starting dynamic subtest: vf-7
[283.667879] Dynamic subtest vf-7: FAIL (0.003s)
[283.677968] Starting dynamic subtest: vf-random
[283.750189] Dynamic subtest vf-random: FAIL (0.003s)
[283.760881] Starting dynamic subtest: vf-last
[283.831643] Dynamic subtest vf-last: FAIL (0.521s)
[283.833554] Subtest bind-unbind-vf: FAIL (0.554s)
[283.869043] [063/131] (751s left) gem_workarounds (reset)
[283.940989] Starting subtest: reset
[284.117473] Subtest reset: SUCCESS (0.177s)
[284.257961] [064/131] (751s left) gem_ctx_shared (exec-single-timeline)
[284.326183] Starting subtest: exec-single-timeline
[284.328517] Starting dynamic subtest: rcs0
[285.379035] Dynamic subtest rcs0: SUCCESS (1.050s)
[285.389401] Starting dynamic subtest: bcs0
[286.466617] Dynamic subtest bcs0: SUCCESS (1.085s)
[286.476557] Starting dynamic subtest: vcs0
[287.555694] Dynamic subtest vcs0: SUCCESS (1.087s)
[287.566962] Starting dynamic subtest: vcs1
[288.645953] Dynamic subtest vcs1: SUCCESS (1.085s)
[288.655683] Starting dynamic subtest: vecs0
[289.731653] Dynamic subtest vecs0: SUCCESS (1.085s)
[289.744127] Starting dynamic subtest: ccs0
[290.820200] Dynamic subtest ccs0: SUCCESS (1.086s)
[290.822964] Subtest exec-single-timeline: SUCCESS (6.491s)
[291.058869] [065/131] (744s left) gem_exec_reloc (basic-write-gtt-active)
[291.119035] Subtest basic-write-gtt-active: SKIP (0.000s)
[291.195345] [066/131] (744s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[291.249047] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[291.253650] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[291.428452] [067/131] (744s left) gem_mmap_gtt (basic-write-read-distinct)
[291.493330] Subtest basic-write-read-distinct: SKIP (0.000s)
[291.553409] [068/131] (744s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[291.850409] Starting subtest: cursor-rapid-movement-max-size
[291.856921] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[291.963192] [069/131] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[292.070486] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[292.074972] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[292.168843] [070/131] (743s left) drm_fdinfo (virtual-busy-idle)
[292.209290] Starting subtest: virtual-busy-idle
[292.214020] Subtest virtual-busy-idle: SKIP (0.000s)
[292.305175] [071/131] (743s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[292.366866] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[292.422753] [072/131] (743s left) gem_exec_suspend (basic)
[292.480158] Starting subtest: basic
[292.482373] Starting dynamic subtest: smem
[293.927508] Dynamic subtest smem: SUCCESS (1.444s)
[293.930579] Subtest basic: SUCCESS (1.445s)
[294.109936] [073/131] (741s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[294.175296] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[294.179973] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[294.353365] [074/131] (741s left) kms_plane_scaling (2x-scaler-multi-pipe)
[294.454450] Starting subtest: 2x-scaler-multi-pipe
[294.458836] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[294.567194] [075/131] (741s left) kms_fbcon_fbt (fbc)
[294.626310] Starting subtest: fbc
[299.842259] Subtest fbc: SUCCESS (5.217s)
[299.940597] [076/131] (736s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[299.994128] Starting subtest: multi-wait-all-for-submit-unsubmitted
[300.098169] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[300.171043] [077/131] (735s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[300.284872] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[300.289330] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[300.395105] [078/131] (735s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[300.501740] Starting subtest: primary-4-tiled-reflect-x-180
[307.440139] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.941s)
[308.590094] [079/131] (727s left) kms_big_fb (linear-64bpp-rotate-0)
[308.701283] Starting subtest: linear-64bpp-rotate-0
[311.060806] Subtest linear-64bpp-rotate-0: SUCCESS (2.361s)
[311.301950] [080/131] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[311.407904] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[314.941340] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (3.538s)
[315.072790] [081/131] (721s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[315.171336] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[315.173294] Starting dynamic subtest: pipe-A-eDP-1
[315.683578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.511s)
[315.695348] Starting dynamic subtest: pipe-B-eDP-1
[315.717004] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s)
[315.728684] Starting dynamic subtest: pipe-C-eDP-1
[315.748100] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[315.758322] Starting dynamic subtest: pipe-D-eDP-1
[315.777873] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[315.779779] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.529s)
[317.965177] [082/131] (718s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[318.026954] Starting subtest: multi-wait-all-for-submit-available-submitted
[318.029386] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[318.135181] [083/131] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[318.239125] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[318.243267] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[318.328212] [084/131] (717s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[318.392172] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[318.472935] [085/131] (717s left) i915_pm_freq_api (freq-reset-multiple)
[318.538436] Starting subtest: freq-reset-multiple
[318.540618] Starting dynamic subtest: gt0
[328.374889] Dynamic subtest gt0: SUCCESS (9.833s)
[328.384946] Starting dynamic subtest: gt1
[336.939130] Dynamic subtest gt1: SUCCESS (8.563s)
[336.942011] Subtest freq-reset-multiple: SUCCESS (18.398s)
[337.013152] [086/131] (699s left) kms_content_protection (dp-mst-type-0)
[337.195401] Starting subtest: dp-mst-type-0
[337.199934] Subtest dp-mst-type-0: SKIP (0.000s)
[337.302341] [087/131] (699s left) syncobj_wait (wait-all-for-submit-complex)
[337.355671] Starting subtest: wait-all-for-submit-complex
[337.570040] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[337.638601] [088/131] (698s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[337.741931] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[337.744277] Starting dynamic subtest: pipe-A-default-mode
[338.030844] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[338.035285] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.285s)
[338.893572] [089/131] (697s left) gem_exec_parallel (contexts)
[338.954555] Starting subtest: contexts
[338.957112] Starting dynamic subtest: rcs0
[341.820305] Dynamic subtest rcs0: SUCCESS (2.864s)
[341.829491] Starting dynamic subtest: bcs0
[345.734984] Dynamic subtest bcs0: SUCCESS (3.912s)
[345.749739] Starting dynamic subtest: vcs0
[350.372190] Dynamic subtest vcs0: SUCCESS (4.634s)
[350.382125] Starting dynamic subtest: vcs1
[354.399696] Dynamic subtest vcs1: SUCCESS (4.024s)
[354.411709] Starting dynamic subtest: vecs0
[358.401510] Dynamic subtest vecs0: SUCCESS (3.998s)
[358.413630] Starting dynamic subtest: ccs0
[362.280794] Dynamic subtest ccs0: SUCCESS (3.876s)
[362.283063] Subtest contexts: SUCCESS (23.320s)
[362.465980] [090/131] (674s left) kms_atomic_transition (plane-all-transition-fencing)
[362.582965] Starting subtest: plane-all-transition-fencing
[362.585285] Starting dynamic subtest: pipe-A-eDP-1
[365.144240] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[365.391872] Starting dynamic subtest: pipe-B-eDP-1
[368.679482] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.244s)
[368.913080] Subtest plane-all-transition-fencing: SUCCESS (6.328s)
[369.746892] [091/131] (666s left) perf (mi-rpc)
[369.854955] Starting subtest: mi-rpc
[369.859016] Subtest mi-rpc: SKIP (0.000s)
[369.897152] [092/131] (666s left) gem_exec_reloc (basic-gtt-read-active)
[369.960747] Subtest basic-gtt-read-active: SKIP (0.000s)
[370.035857] [093/131] (666s left) kms_psr (fbc-pr-dpms)
[370.134725] Starting subtest: fbc-pr-dpms
[370.139062] Subtest fbc-pr-dpms: SKIP (0.000s)
[370.201587] [094/131] (666s left) kms_flip (blocking-absolute-wf_vblank)
[370.298650] Starting subtest: blocking-absolute-wf_vblank
[370.300839] Starting dynamic subtest: A-eDP1
[379.143943] Dynamic subtest A-eDP1: SUCCESS (8.807s)
[379.155174] Starting dynamic subtest: B-eDP1
[387.878241] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[387.889427] Starting dynamic subtest: C-eDP1
[396.600673] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[396.611725] Starting dynamic subtest: D-eDP1
[405.324742] Dynamic subtest D-eDP1: SUCCESS (8.718s)
[405.326711] Subtest blocking-absolute-wf_vblank: SUCCESS (34.973s)
[406.481373] [095/131] (630s left) kms_psr (pr-dpms)
[406.593477] Starting subtest: pr-dpms
[406.597437] Subtest pr-dpms: SKIP (0.000s)
[406.661335] [096/131] (630s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[406.766344] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[406.781344] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.013s)
[406.855806] [097/131] (629s left) kms_color (legacy-gamma)
[406.959766] Starting subtest: legacy-gamma
[406.962094] Starting dynamic subtest: pipe-A-eDP-1
[407.670014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[407.680295] Starting dynamic subtest: pipe-B-eDP-1
[409.075845] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[409.085537] Starting dynamic subtest: pipe-C-eDP-1
[410.450773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[410.460347] Starting dynamic subtest: pipe-D-eDP-1
[411.781031] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[411.783492] Subtest legacy-gamma: SUCCESS (4.819s)
[412.591664] [098/131] (624s left) kms_display_modes (mst-extended-mode-negative)
[412.698570] Starting subtest: mst-extended-mode-negative
[412.703297] Subtest mst-extended-mode-negative: SKIP (0.000s)
[412.762953] [099/131] (624s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[412.853471] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[412.858029] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[413.923912] [100/131] (622s left) kms_psr (pr-suspend)
[414.028595] Starting subtest: pr-suspend
[414.033239] Subtest pr-suspend: SKIP (0.000s)
[414.098709] [101/131] (622s left) gem_eio (wait-wedge-immediate)
[414.333469] Starting subtest: wait-wedge-immediate
[415.989862] Subtest wait-wedge-immediate: SUCCESS (1.657s)
[416.142814] [102/131] (620s left) drm_fdinfo (memory-info-active)
[416.183481] Starting subtest: memory-info-active
[416.185681] Starting dynamic subtest: smem0
[418.881298] Dynamic subtest smem0: SUCCESS (2.697s)
[418.883699] Subtest memory-info-active: SUCCESS (2.698s)
[418.948328] [103/131] (618s left) gem_eio (wait-10ms)
[419.189419] Starting subtest: wait-10ms
[419.582993] Subtest wait-10ms: SUCCESS (0.396s)
[419.739327] [104/131] (617s left) gem_lmem_swapping (heavy-verify-random-ccs)
[419.781583] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[419.820749] [105/131] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[419.924369] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[419.928575] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[420.018050] [106/131] (617s left) syncobj_wait (single-wait-signaled)
[420.072661] Starting subtest: single-wait-signaled
[420.074933] Subtest single-wait-signaled: SUCCESS (0.000s)
[420.178243] [107/131] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[420.292390] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[424.805865] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.516s)
[424.947088] [108/131] (612s left) kms_properties (invalid-properties-atomic)
[425.053702] Starting subtest: invalid-properties-atomic
[425.326292] Subtest invalid-properties-atomic: SUCCESS (0.271s)
[425.400060] [109/131] (611s left) kms_cursor_crc (cursor-random-max-size)
[425.691748] Starting subtest: cursor-random-max-size
[425.698167] Subtest cursor-random-max-size: SKIP (0.000s)
[425.836916] [110/131] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[425.936400] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[431.048225] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.116s)
[431.191083] [111/131] (606s left) gem_mmap_wc (pf-nonblock)
[431.262385] Subtest pf-nonblock: SKIP (0.000s)
[431.327133] [112/131] (606s left) syncobj_timeline (invalid-query-bad-pad)
[431.378776] Starting subtest: invalid-query-bad-pad
[431.381032] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[431.492424] [113/131] (605s left) i915_suspend (basic-s3-without-i915)
[431.531131] Starting subtest: basic-s3-without-i915
[435.150644] Subtest basic-s3-without-i915: SKIP (3.615s)
[436.563081] [114/131] (600s left) kms_pm_rpm (modeset-lpsp-stress)
[438.109444] Starting subtest: modeset-lpsp-stress
[454.065501] Subtest modeset-lpsp-stress: SUCCESS (15.957s)
[454.148030] [115/131] (583s left) gem_exec_schedule (timeslicing)
[454.225677] Starting subtest: timeslicing
[454.227770] Starting dynamic subtest: rcs0
[454.240489] Dynamic subtest rcs0: SUCCESS (0.022s)
[454.250714] Starting dynamic subtest: bcs0
[454.260253] Dynamic subtest bcs0: SUCCESS (0.019s)
[454.269294] Starting dynamic subtest: vcs0
[454.280783] Dynamic subtest vcs0: SUCCESS (0.020s)
[454.288832] Starting dynamic subtest: vcs1
[454.299383] Dynamic subtest vcs1: SUCCESS (0.018s)
[454.307290] Starting dynamic subtest: vecs0
[454.320049] Dynamic subtest vecs0: SUCCESS (0.020s)
[454.328214] Starting dynamic subtest: ccs0
[454.341480] Dynamic subtest ccs0: SUCCESS (0.021s)
[454.343823] Subtest timeslicing: SUCCESS (0.124s)
[455.948083] [116/131] (581s left) gem_ctx_persistence (engines-mixed-process)
[456.013794] Starting subtest: engines-mixed-process
[456.016381] Starting dynamic subtest: rcs0
[457.927530] Dynamic subtest rcs0: SUCCESS (1.913s)
[457.938306] Starting dynamic subtest: bcs0
[459.921111] Dynamic subtest bcs0: SUCCESS (1.991s)
[459.931947] Starting dynamic subtest: vcs0
[461.930768] Dynamic subtest vcs0: SUCCESS (2.009s)
[461.941330] Starting dynamic subtest: vcs1
[463.916517] Dynamic subtest vcs1: SUCCESS (1.985s)
[463.927366] Starting dynamic subtest: vecs0
[465.911293] Dynamic subtest vecs0: SUCCESS (1.993s)
[465.921355] Starting dynamic subtest: ccs0
[467.912375] Dynamic subtest ccs0: SUCCESS (1.999s)
[467.915169] Subtest engines-mixed-process: SUCCESS (11.900s)
[467.991692] [117/131] (569s left) sysfs_heartbeat_interval (mixed)
[468.062631] Starting subtest: mixed
[468.064967] Starting dynamic subtest: vecs0
[473.297889] Dynamic subtest vecs0: SUCCESS (5.234s)
[473.308368] Starting dynamic subtest: ccs0
[478.520930] Dynamic subtest ccs0: SUCCESS (5.222s)
[478.532486] Starting dynamic subtest: vcs0
[483.733126] Dynamic subtest vcs0: SUCCESS (5.210s)
[483.743738] Starting dynamic subtest: bcs0
[488.960917] Dynamic subtest bcs0: SUCCESS (5.226s)
[488.971921] Starting dynamic subtest: rcs0
[494.153309] Dynamic subtest rcs0: SUCCESS (5.191s)
[494.165438] Starting dynamic subtest: vcs1
[499.373240] Dynamic subtest vcs1: SUCCESS (5.216s)
[499.375630] Subtest mixed: SUCCESS (31.309s)
[499.442927] [118/131] (538s left) kms_chamelium_frames (vga-frame-dump)
[499.830306] Subtest vga-frame-dump: SKIP (0.000s)
[500.614764] [119/131] (536s left) kms_frontbuffer_tracking (psr-slowdraw)
[500.716036] Starting subtest: psr-slowdraw
[523.872968] Subtest psr-slowdraw: SUCCESS (23.157s)
[524.003808] [120/131] (513s left) perf_pmu (pmu-read)
[524.048438] Starting subtest: pmu-read
[524.050809] Subtest pmu-read: SUCCESS (0.002s)
[524.173261] [121/131] (513s left) kms_pipe_crc_basic (suspend-read-crc)
[524.274898] Starting subtest: suspend-read-crc
[524.277193] Starting dynamic subtest: pipe-A-eDP-1
[541.511436] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.553s)
[541.521304] Starting dynamic subtest: pipe-B-eDP-1
[559.237637] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.864s)
[559.247075] Starting dynamic subtest: pipe-C-eDP-1
[577.192290] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.749s)
[577.204614] Starting dynamic subtest: pipe-D-eDP-1
[595.155973] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.742s)
[595.159096] Subtest suspend-read-crc: SUCCESS (10.913s)
[596.026371] [122/131] (501s left) kms_frontbuffer_tracking (fbc-suspend)
[596.142092] Starting subtest: fbc-suspend
[631.838891] Subtest fbc-suspend: SUCCESS (5.998s)
[631.963838] [123/131] (495s left) kms_atomic (plane-primary-legacy)
[632.063065] Starting subtest: plane-primary-legacy
[632.065631] Starting dynamic subtest: pipe-A-eDP-1
[632.523356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[632.526492] Subtest plane-primary-legacy: SUCCESS (0.450s)
[633.345272] [124/131] (494s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[633.461953] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[637.283834] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.772s)
[637.416183] [125/131] (490s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[637.518202] Starting subtest: psr-1p-primscrn-cur-indfb-move
[642.686117] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.129s)
[642.840384] [126/131] (484s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)
[643.295474] Subtest fbc-dirty-rectangle-out-visible-area: SKIP (0.000s)
[643.351370] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)] new: kernel.kmod_is_loaded.xe: true
[643.354973] [127/131] (484s left) gem_userptr_blits (nohangcheck)
[643.427496] Starting subtest: nohangcheck
[643.687473] Subtest nohangcheck: SUCCESS (0.255s)
[643.808516] [128/131] (483s left) kms_flip (2x-wf_vblank-ts-check)
[643.912476] Starting subtest: 2x-wf_vblank-ts-check
[643.923696] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[644.002134] [129/131] (483s left) core_setmaster (master-drop-set-root)
[645.888676] Starting subtest: master-drop-set-root
[645.893961] Subtest master-drop-set-root: SUCCESS (0.002s)
[645.936780] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.amdgpu: true
[645.941039] [130/131] (481s left) gem_exec_schedule (preemptive-hang)
[646.119333] Starting subtest: preemptive-hang
[646.122258] Starting dynamic subtest: rcs0
[655.347439] Dynamic subtest rcs0: SUCCESS (9.199s)
[655.362631] Starting dynamic subtest: bcs0
[664.308076] Dynamic subtest bcs0: SUCCESS (8.959s)
[664.322891] Starting dynamic subtest: vcs0
[673.396184] Dynamic subtest vcs0: SUCCESS (9.099s)
[673.411477] Starting dynamic subtest: vcs1
[682.349961] Dynamic subtest vcs1: SUCCESS (8.959s)
[682.361556] Starting dynamic subtest: vecs0
[691.315804] Dynamic subtest vecs0: SUCCESS (8.961s)
[691.325263] Starting dynamic subtest: ccs0
[700.341720] Dynamic subtest ccs0: SUCCESS (9.020s)
[700.344125] Subtest preemptive-hang: SUCCESS (54.206s)
[700.578894] [131/131] (427s left) prime_vgem (basic-read)
[700.658298] Starting subtest: basic-read
[700.668021] Subtest basic-read: SKIP (0.007s)
[700.740355] Closing watchdogs
Done.