[57.490593] Initializing watchdogs
[57.490657]   /dev/watchdog0
[57.504486] [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.508735] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.511582] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.514908] [001/133] (960s left) sysfs_timeslice_duration (invalid)
[57.600069] Starting subtest: invalid
[57.602414] Starting dynamic subtest: vecs0
[57.604628] Dynamic subtest vecs0: SUCCESS (0.000s)
[57.612510] Starting dynamic subtest: ccs0
[57.614356] Dynamic subtest ccs0: SUCCESS (0.000s)
[57.620710] Starting dynamic subtest: vcs0
[57.622549] Dynamic subtest vcs0: SUCCESS (0.000s)
[57.628741] Starting dynamic subtest: bcs0
[57.630597] Dynamic subtest bcs0: SUCCESS (0.000s)
[57.637763] Starting dynamic subtest: rcs0
[57.639783] Dynamic subtest rcs0: SUCCESS (0.000s)
[57.646504] Starting dynamic subtest: vcs1
[57.648327] Dynamic subtest vcs1: SUCCESS (0.000s)
[57.650132] Subtest invalid: SUCCESS (0.003s)
[57.699204] [002/133] (960s left) gem_userptr_blits (sync-unmap-after-close)
[57.770255] Starting subtest: sync-unmap-after-close
[57.788663] Subtest sync-unmap-after-close: SUCCESS (0.020s)
[57.908306] [003/133] (960s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[58.005474] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[58.007740] Starting dynamic subtest: pipe-A-eDP-1
[58.031199] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.039787] Starting dynamic subtest: pipe-B-eDP-1
[58.061217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.067784] Starting dynamic subtest: pipe-C-eDP-1
[58.089412] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.095922] Starting dynamic subtest: pipe-D-eDP-1
[58.117950] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.122308] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[60.223607] [004/133] (957s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[60.329124] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[60.331328] Starting dynamic subtest: pipe-A-eDP-1
[60.353695] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.361330] Starting dynamic subtest: pipe-B-eDP-1
[60.382344] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.389073] Starting dynamic subtest: pipe-C-eDP-1
[60.410653] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.417323] Starting dynamic subtest: pipe-D-eDP-1
[60.439206] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.443249] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[62.495427] [005/133] (955s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[62.567037] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[62.571677] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[62.744974] [006/133] (955s left) kms_cursor_crc (cursor-random-32x10)
[62.901753] Starting subtest: cursor-random-32x10
[62.944794] Subtest cursor-random-32x10: SKIP (0.039s)
[63.177185] [007/133] (955s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[63.276277] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[63.280362] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[63.385220] [008/133] (954s left) kms_prime (basic-crc-hybrid)
[63.467980] Subtest basic-crc-hybrid: SKIP (0.000s)
[63.574650] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[63.577173] [009/133] (954s left) gem_blits (basic)
[63.645024] Starting subtest: basic
[65.025236] Subtest basic: SUCCESS (1.382s)
[65.124503] [010/133] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[65.237167] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[72.010375] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.783s)
[72.155744] [011/133] (946s left) gem_softpin (allocator-evict)
[72.217992] Starting subtest: allocator-evict
[72.220463] Starting dynamic subtest: rcs0
[95.429805] Dynamic subtest rcs0: SUCCESS (23.217s)
[95.439116] Starting dynamic subtest: bcs0
[119.285855] Dynamic subtest bcs0: SUCCESS (23.856s)
[119.293509] Starting dynamic subtest: vcs0
[143.074273] Dynamic subtest vcs0: SUCCESS (23.788s)
[143.087715] Starting dynamic subtest: vcs1
[166.842089] Dynamic subtest vcs1: SUCCESS (23.765s)
[166.850851] Starting dynamic subtest: vecs0
[190.663842] Dynamic subtest vecs0: SUCCESS (23.820s)
[190.674522] Starting dynamic subtest: ccs0
[214.585159] Dynamic subtest ccs0: SUCCESS (23.920s)
[214.587889] Subtest allocator-evict: SUCCESS (142.368s)
[214.666675] [012/133] (803s left) gem_vm_create (isolation)
[214.767692] Starting subtest: isolation
[214.782215] Subtest isolation: SUCCESS (0.014s)
[214.920343] [013/133] (803s left) sriov_basic (bind-unbind-vf)
[214.970316] Starting subtest: bind-unbind-vf
[214.972604] Starting dynamic subtest: vf-1
[215.053141] Dynamic subtest vf-1: FAIL (0.029s)
[215.061543] Starting dynamic subtest: vf-2
[215.135252] Dynamic subtest vf-2: FAIL (0.004s)
[215.144660] Starting dynamic subtest: vf-3
[215.217940] Dynamic subtest vf-3: FAIL (0.004s)
[215.226795] Starting dynamic subtest: vf-4
[215.299312] Dynamic subtest vf-4: FAIL (0.004s)
[215.308606] Starting dynamic subtest: vf-5
[215.381865] Dynamic subtest vf-5: FAIL (0.004s)
[215.390880] Starting dynamic subtest: vf-6
[215.464619] Dynamic subtest vf-6: FAIL (0.004s)
[215.473628] Starting dynamic subtest: vf-7
[215.542266] Dynamic subtest vf-7: FAIL (0.004s)
[215.551534] Starting dynamic subtest: vf-random
[215.611421] Dynamic subtest vf-random: FAIL (0.004s)
[215.619205] Starting dynamic subtest: vf-last
[215.678320] Dynamic subtest vf-last: FAIL (0.504s)
[215.680233] Subtest bind-unbind-vf: FAIL (0.562s)
[215.715669] [014/133] (802s left) kms_vrr (negative-basic)
[215.816569] Starting subtest: negative-basic
[215.823441] Starting dynamic subtest: pipe-A-eDP-1
[221.250017] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.426s)
[221.543403] Subtest negative-basic: SUCCESS (5.728s)
[222.348050] [015/133] (796s left) gem_pxp (fail-invalid-protected-context)
[222.490231] Starting subtest: fail-invalid-protected-context
[222.492225] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[222.593101] [016/133] (795s left) kms_plane_cursor (viewport)
[222.697583] Starting subtest: viewport
[222.701970] Starting dynamic subtest: pipe-A-eDP-1-size-64
[225.135114] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.438s)
[225.196355] Starting dynamic subtest: pipe-A-eDP-1-size-128
[227.703737] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.516s)
[227.762843] Starting dynamic subtest: pipe-A-eDP-1-size-256
[230.204158] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[230.552811] Starting dynamic subtest: pipe-B-eDP-1-size-64
[233.681696] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.139s)
[233.744629] Starting dynamic subtest: pipe-B-eDP-1-size-128
[236.204550] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s)
[236.266451] Starting dynamic subtest: pipe-B-eDP-1-size-256
[238.683148] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.427s)
[239.033468] Starting dynamic subtest: pipe-C-eDP-1-size-64
[241.753085] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.729s)
[241.788746] Starting dynamic subtest: pipe-C-eDP-1-size-128
[243.907933] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.124s)
[243.948889] Starting dynamic subtest: pipe-C-eDP-1-size-256
[246.086236] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[246.416641] Starting dynamic subtest: pipe-D-eDP-1-size-64
[249.165830] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.760s)
[249.201906] Starting dynamic subtest: pipe-D-eDP-1-size-128
[251.276607] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s)
[251.313255] Starting dynamic subtest: pipe-D-eDP-1-size-256
[253.354379] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.047s)
[253.673605] Subtest viewport: SUCCESS (30.975s)
[254.477435] [017/133] (764s left) syncobj_timeline (single-wait-available-submitted)
[254.542502] Starting subtest: single-wait-available-submitted
[254.544941] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[254.641353] [018/133] (764s left) gen9_exec_parse (batch-invalid-length)
[254.715492] Subtest batch-invalid-length: SKIP (0.000s)
[254.791896] [019/133] (763s left) i915_drm_fdinfo (isolation)
[254.833107] Starting subtest: isolation
[254.834984] Starting dynamic subtest: rcs0
[254.862243] Dynamic subtest rcs0: SKIP (0.028s)
[254.871675] Starting dynamic subtest: bcs0
[254.875725] Dynamic subtest bcs0: SKIP (0.000s)
[254.886407] Starting dynamic subtest: vcs0
[254.890620] Dynamic subtest vcs0: SKIP (0.000s)
[254.897639] Starting dynamic subtest: vcs1
[254.901584] Dynamic subtest vcs1: SKIP (0.000s)
[254.908567] Starting dynamic subtest: vecs0
[254.912507] Dynamic subtest vecs0: SKIP (0.000s)
[254.919281] Starting dynamic subtest: ccs0
[254.923119] Dynamic subtest ccs0: SKIP (0.000s)
[254.927046] Subtest isolation: SKIP (0.033s)
[254.962389] [020/133] (763s left) gem_exec_balancer (parallel-contexts)
[255.235764] Starting subtest: parallel-contexts
[257.989944] Subtest parallel-contexts: SUCCESS (2.754s)
[258.947528] [021/133] (759s left) kms_lease (atomic-implicit-crtc)
[259.048222] Starting subtest: atomic-implicit-crtc
[259.050453] Starting dynamic subtest: pipe-A-eDP-1
[259.061203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[259.069437] Starting dynamic subtest: pipe-B-eDP-1
[259.080318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[259.089098] Starting dynamic subtest: pipe-C-eDP-1
[259.099392] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[259.107067] Starting dynamic subtest: pipe-D-eDP-1
[259.117304] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[259.119449] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[259.194541] [022/133] (759s left) syncobj_timeline (device-signal-unordered)
[259.257082] Starting subtest: device-signal-unordered
[259.259436] Subtest device-signal-unordered: SUCCESS (0.001s)
[259.350620] [023/133] (759s left) gem_mmap_gtt (cpuset-big-copy)
[259.416524] Subtest cpuset-big-copy: SKIP (0.000s)
[259.479349] [024/133] (759s left) kms_cursor_crc (cursor-onscreen-512x512)
[259.776945] Starting subtest: cursor-onscreen-512x512
[259.781517] Subtest cursor-onscreen-512x512: SKIP (0.002s)
[259.938045] [025/133] (759s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[260.036030] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[261.126453] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.091s)
[261.258956] [026/133] (757s left) syncobj_wait (reset-multiple-signaled)
[261.316493] Starting subtest: reset-multiple-signaled
[261.318502] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[261.408717] [027/133] (757s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[261.523777] Starting subtest: yf-tiled-8bpp-rotate-90
[261.527489] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[261.614750] [028/133] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[261.705424] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[265.914530] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.211s)
[267.112234] [029/133] (752s left) gem_exec_nop (basic-sequential)
[267.189842] Starting subtest: basic-sequential
[283.028121] Subtest basic-sequential: SUCCESS (15.847s)
[283.263158] [030/133] (735s left) kms_async_flips (test-time-stamp-atomic)
[283.355093] Starting subtest: test-time-stamp-atomic
[283.739123] Starting dynamic subtest: pipe-A-eDP-1
[284.505034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.765s)
[284.881422] Starting dynamic subtest: pipe-B-eDP-1
[285.645629] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.768s)
[286.009171] Starting dynamic subtest: pipe-C-eDP-1
[286.776167] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[287.139484] Starting dynamic subtest: pipe-D-eDP-1
[287.911060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[287.913310] Subtest test-time-stamp-atomic: SUCCESS (4.556s)
[289.064868] [031/133] (730s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[289.168812] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[289.172966] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[289.288869] [032/133] (729s left) gem_exec_balancer (bonded-false-hang)
[289.548043] Starting subtest: bonded-false-hang
[289.553067] Subtest bonded-false-hang: SKIP (0.000s)
[289.643662] [033/133] (729s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[289.730899] Starting subtest: plane-upscale-20x20-with-rotation
[289.733244] Starting dynamic subtest: pipe-A
[289.955992] Dynamic subtest pipe-A: SUCCESS (0.227s)
[289.969145] Starting dynamic subtest: pipe-B
[291.257779] Dynamic subtest pipe-B: SUCCESS (1.300s)
[291.266410] Starting dynamic subtest: pipe-C
[292.592053] Dynamic subtest pipe-C: SUCCESS (1.332s)
[292.600797] Starting dynamic subtest: pipe-D
[293.930069] Dynamic subtest pipe-D: SUCCESS (1.337s)
[293.932214] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.202s)
[295.111703] [034/133] (724s left) gem_exec_whisper (basic-contexts-all)
[295.189477] Starting subtest: basic-contexts-all
[306.074501] Subtest basic-contexts-all: SUCCESS (10.884s)
[306.259779] [035/133] (713s left) i915_suspend (basic-s3-without-i915)
[306.301073] Starting subtest: basic-s3-without-i915
[309.606194] Subtest basic-s3-without-i915: SKIP (3.302s)
[311.181253] [036/133] (708s left) gem_linear_blits (basic)
[311.427359] Starting subtest: basic
[311.434929] Subtest basic: SUCCESS (0.012s)
[311.571649] [037/133] (707s left) kms_frontbuffer_tracking (fbc-suspend)
[311.726792] Starting subtest: fbc-suspend
[349.897379] Subtest fbc-suspend: SUCCESS (7.622s)
[351.066101] [038/133] (668s left) perf_pmu (multi-client)
[351.114160] Starting subtest: multi-client
[351.116040] Starting dynamic subtest: rcs0
[352.157703] Dynamic subtest rcs0: SUCCESS (1.055s)
[352.168954] Starting dynamic subtest: bcs0
[353.207132] Dynamic subtest bcs0: SUCCESS (1.057s)
[353.218518] Starting dynamic subtest: vcs0
[354.257882] Dynamic subtest vcs0: SUCCESS (1.058s)
[354.268325] Starting dynamic subtest: vcs1
[355.546713] Dynamic subtest vcs1: SUCCESS (1.295s)
[355.555911] Starting dynamic subtest: vecs0
[357.530730] Dynamic subtest vecs0: SUCCESS (1.994s)
[357.542399] Starting dynamic subtest: ccs0
[359.514874] Dynamic subtest ccs0: SUCCESS (1.991s)
[359.517740] Subtest multi-client: SUCCESS (8.467s)
[359.632054] [039/133] (659s left) i915_fb_tiling (basic-x-tiling)
[359.695558] Subtest basic-x-tiling: SKIP (0.000s)
[359.752819] [040/133] (659s left) gem_close_race (basic-process)
[359.824333] Starting subtest: basic-process
[359.874577] Subtest basic-process: SUCCESS (0.051s)
[360.056615] [041/133] (659s left) api_intel_allocator (default-alignment)
[360.115036] Starting subtest: default-alignment
[360.117337] Subtest default-alignment: SUCCESS (0.004s)
[360.250791] [042/133] (659s left) syncobj_wait (multi-wait-all-submitted)
[360.327453] Starting subtest: multi-wait-all-submitted
[360.429630] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[360.523286] [043/133] (659s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[360.627760] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[360.630138] Starting dynamic subtest: pipe-A-default-mode
[361.748015] Dynamic subtest pipe-A-default-mode: SKIP (1.121s)
[361.752050] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.123s)
[361.906746] [044/133] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[362.000469] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[362.004557] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[362.100764] [045/133] (657s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[362.211633] Starting subtest: fbcpsr-rgb565-draw-render
[369.159193] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.966s)
[369.298417] [046/133] (650s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[369.410912] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[370.487865] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.078s)
[370.609473] [047/133] (649s left) kms_async_flips (async-flip-hang)
[370.700524] Starting subtest: async-flip-hang
[371.072018] Starting dynamic subtest: pipe-A-eDP-1
[385.994719] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.921s)
[386.366798] Starting dynamic subtest: pipe-B-eDP-1
[401.980451] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.613s)
[402.373944] Starting dynamic subtest: pipe-C-eDP-1
[417.976729] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.608s)
[418.355229] Starting dynamic subtest: pipe-D-eDP-1
[433.973824] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.627s)
[433.976313] Subtest async-flip-hang: SUCCESS (63.272s)
[435.175050] [048/133] (584s left) kms_big_fb (y-tiled-addfb)
[435.268232] Starting subtest: y-tiled-addfb
[435.272657] Subtest y-tiled-addfb: SKIP (0.000s)
[435.360995] [049/133] (584s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[435.462626] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[435.466789] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[435.568924] [050/133] (584s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[435.622620] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[435.624952] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[435.738765] [051/133] (584s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[435.832603] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[440.466876] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.639s)
[441.583700] [052/133] (578s left) gem_mmap_offset (oob-read)
[441.637205] Starting subtest: oob-read
[441.639197] Subtest oob-read: SUCCESS (0.000s)
[441.734491] [053/133] (578s left) kms_flip (flip-vs-expired-vblank-interruptible)
[441.830799] Starting subtest: flip-vs-expired-vblank-interruptible
[441.833170] Starting dynamic subtest: A-eDP1
[450.474894] Dynamic subtest A-eDP1: SUCCESS (8.640s)
[450.487039] Starting dynamic subtest: B-eDP1
[459.106768] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[459.116622] Starting dynamic subtest: C-eDP1
[467.725160] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[467.739642] Starting dynamic subtest: D-eDP1
[476.363212] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[476.368049] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.531s)
[477.528984] [054/133] (542s left) gem_exec_schedule (preempt-engines)
[477.598096] Starting subtest: preempt-engines
[477.600285] Starting dynamic subtest: rcs0
[479.889663] Dynamic subtest rcs0: SUCCESS (2.292s)
[479.907398] Starting dynamic subtest: bcs0
[482.158518] Dynamic subtest bcs0: SUCCESS (2.267s)
[482.167689] Starting dynamic subtest: vcs0
[484.487022] Dynamic subtest vcs0: SUCCESS (2.326s)
[484.499885] Starting dynamic subtest: vcs1
[486.769570] Dynamic subtest vcs1: SUCCESS (2.280s)
[486.780448] Starting dynamic subtest: vecs0
[489.032250] Dynamic subtest vecs0: SUCCESS (2.261s)
[489.045847] Starting dynamic subtest: ccs0
[491.324483] Dynamic subtest ccs0: SUCCESS (2.290s)
[491.327145] Subtest preempt-engines: SUCCESS (13.729s)
[491.661466] [055/133] (528s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[491.784440] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[509.658364] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.876s)
[510.450253] [056/133] (509s left) kms_debugfs (display-off-read-all)
[510.545696] Starting subtest: display-off-read-all
[510.846079] Subtest display-off-read-all: SUCCESS (0.301s)
[511.690167] [057/133] (508s left) kms_plane (plane-panning-bottom-right)
[511.785897] Starting subtest: plane-panning-bottom-right
[511.788082] Starting dynamic subtest: pipe-A
[513.431794] Dynamic subtest pipe-A: SUCCESS (1.647s)
[513.441842] Starting dynamic subtest: pipe-B
[515.802751] Dynamic subtest pipe-B: SUCCESS (2.369s)
[515.805018] Subtest plane-panning-bottom-right: SUCCESS (4.019s)
[516.604999] [058/133] (503s left) kms_psr (fbc-psr2-dpms)
[516.701059] Starting subtest: fbc-psr2-dpms
[516.703452] Starting dynamic subtest: eDP-1
[516.707884] Dynamic subtest eDP-1: SKIP (0.000s)
[516.712309] Subtest fbc-psr2-dpms: SKIP (0.001s)
[516.775304] [059/133] (503s left) kms_content_protection (atomic)
[516.919506] Starting subtest: atomic
[516.923981] Subtest atomic: SKIP (0.000s)
[517.029068] [060/133] (503s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[517.120479] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[517.199615] [061/133] (503s left) kms_psr (fbc-psr-primary-mmap-cpu)
[517.299957] Starting subtest: fbc-psr-primary-mmap-cpu
[517.302223] Starting dynamic subtest: eDP-1
[517.306605] Dynamic subtest eDP-1: SKIP (0.000s)
[517.310988] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[517.389005] [062/133] (503s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[517.461197] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[517.465611] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[517.646586] [063/133] (502s left) kms_addfb_basic (invalid-set-prop-any)
[517.700280] Starting subtest: invalid-set-prop-any
[517.702466] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[517.832735] [064/133] (502s left) kms_big_fb (linear-32bpp-rotate-270)
[517.939338] Starting subtest: linear-32bpp-rotate-270
[517.957905] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[518.072431] [065/133] (502s left) gem_exec_reloc (basic-gtt-noreloc)
[518.136269] Subtest basic-gtt-noreloc: SKIP (0.000s)
[518.210745] [066/133] (502s left) syncobj_timeline (reset-during-wait-for-submit)
[518.261812] Starting subtest: reset-during-wait-for-submit
[518.365149] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[518.463581] [067/133] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[518.560317] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[518.564431] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[518.670087] [068/133] (502s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[518.762497] Starting subtest: primary-x-tiled-reflect-x-0
[525.691105] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.931s)
[526.857573] [069/133] (493s left) kms_psr (psr2-sprite-mmap-gtt)
[526.961248] Starting subtest: psr2-sprite-mmap-gtt
[526.963618] Starting dynamic subtest: eDP-1
[528.357734] Dynamic subtest eDP-1: SKIP (1.394s)
[528.362305] Subtest psr2-sprite-mmap-gtt: SKIP (1.396s)
[528.527038] [070/133] (492s left) gem_exec_schedule (semaphore-power)
[528.713657] Subtest semaphore-power: SKIP (0.000s)
[528.887212] [071/133] (492s left) gem_tiled_pread_pwrite
[529.023731] [072/133] (491s left) gem_exec_parallel (fds)
[529.083091] Starting subtest: fds
[529.085387] Starting dynamic subtest: rcs0
[531.903782] Dynamic subtest rcs0: SUCCESS (2.819s)
[531.915953] Starting dynamic subtest: bcs0
[535.061850] Dynamic subtest bcs0: SUCCESS (3.156s)
[535.074067] Starting dynamic subtest: vcs0
[538.853071] Dynamic subtest vcs0: SUCCESS (3.791s)
[538.862791] Starting dynamic subtest: vcs1
[542.801742] Dynamic subtest vcs1: SUCCESS (3.947s)
[542.811894] Starting dynamic subtest: vecs0
[546.766913] Dynamic subtest vecs0: SUCCESS (3.963s)
[546.777133] Starting dynamic subtest: ccs0
[550.362384] Dynamic subtest ccs0: SUCCESS (3.593s)
[550.365330] Subtest fds: SUCCESS (21.282s)
[550.575978] [073/133] (470s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[550.627254] Starting subtest: multi-wait-all-for-submit-signaled
[550.629188] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[550.712414] [074/133] (470s left) kms_big_fb (4-tiled-addfb-size-overflow)
[550.807279] Starting subtest: 4-tiled-addfb-size-overflow
[550.809444] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[550.900123] [075/133] (470s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[550.993091] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[550.995449] Starting dynamic subtest: A-eDP1
[554.612152] Dynamic subtest A-eDP1: SUCCESS (3.619s)
[554.622800] Starting dynamic subtest: B-eDP1
[557.807842] Dynamic subtest B-eDP1: SUCCESS (3.194s)
[557.818844] Starting dynamic subtest: C-eDP1
[560.913969] Dynamic subtest C-eDP1: SUCCESS (3.107s)
[560.923243] Starting dynamic subtest: D-eDP1
[564.016297] Dynamic subtest D-eDP1: SUCCESS (3.102s)
[564.021346] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.030s)
[564.810265] [076/133] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[564.904445] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[564.908596] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[565.004128] [077/133] (456s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[565.101887] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[569.228057] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.130s)
[570.417356] [078/133] (450s left) kms_vblank (wait-busy-hang)
[570.512076] Starting subtest: wait-busy-hang
[570.514220] Starting dynamic subtest: pipe-A-eDP-1
[597.274488] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.753s)
[597.288872] Starting dynamic subtest: pipe-D-eDP-1
[622.231880] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.954s)
[622.234436] Subtest wait-busy-hang: SUCCESS (51.711s)
[623.079184] [079/133] (398s left) gem_lmem_swapping (parallel-multi)
[623.124042] Subtest parallel-multi: SKIP (0.000s)
[623.164754] [080/133] (398s left) i915_pm_rps (min-max-config-loaded)
[623.227403] Starting subtest: min-max-config-loaded
[623.231640] Subtest min-max-config-loaded: SKIP (0.001s)
[623.322466] [081/133] (397s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[623.413929] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[623.416062] Starting dynamic subtest: pipe-A-default-mode
[626.131317] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[626.133598] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.719s)
[626.977643] [082/133] (394s left) kms_color_pipeline (plane-lut1d)
[627.067020] Starting subtest: plane-lut1d
[627.212472] Starting dynamic subtest: pipe-A-plane-0
[627.608507] Dynamic subtest pipe-A-plane-0: FAIL (0.215s)
[627.625548] Starting dynamic subtest: pipe-A-plane-1
[627.843567] Dynamic subtest pipe-A-plane-1: FAIL (0.158s)
[627.855113] Starting dynamic subtest: pipe-A-plane-2
[628.067275] Dynamic subtest pipe-A-plane-2: FAIL (0.165s)
[628.963082] Starting dynamic subtest: pipe-B-plane-0
[629.392362] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[629.403858] Starting dynamic subtest: pipe-B-plane-1
[629.707665] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[629.718126] Starting dynamic subtest: pipe-B-plane-2
[630.010575] Dynamic subtest pipe-B-plane-2: FAIL (0.155s)
[630.584478] Starting dynamic subtest: pipe-C-plane-0
[631.059824] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[631.070959] Starting dynamic subtest: pipe-C-plane-1
[631.444373] Dynamic subtest pipe-C-plane-1: FAIL (0.166s)
[631.455320] Starting dynamic subtest: pipe-C-plane-2
[631.800564] Dynamic subtest pipe-C-plane-2: FAIL (0.616s)
[632.715724] Starting dynamic subtest: pipe-D-plane-0
[633.288607] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[633.299729] Starting dynamic subtest: pipe-D-plane-1
[633.745492] Dynamic subtest pipe-D-plane-1: FAIL (0.631s)
[633.756354] Starting dynamic subtest: pipe-D-plane-2
[634.170655] Dynamic subtest pipe-D-plane-2: FAIL (0.562s)
[634.355960] Subtest plane-lut1d: FAIL (7.289s)
[635.194146] [083/133] (386s left) kms_joiner (invalid-modeset-ultra-joiner)
[635.309586] Starting subtest: invalid-modeset-ultra-joiner
[635.313934] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[635.376401] [084/133] (386s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[635.467586] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[635.478644] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[635.592764] [085/133] (385s left) gem_exec_reloc (basic-wc-gtt)
[635.665092] Subtest basic-wc-gtt: SKIP (0.000s)
[635.742975] [086/133] (385s left) gem_mmap_gtt (basic-copy)
[635.803381] Subtest basic-copy: SKIP (0.000s)
[635.861264] [087/133] (385s left) kms_psr (fbc-pr-primary-mmap-cpu)
[635.964025] Starting subtest: fbc-pr-primary-mmap-cpu
[635.968150] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[636.050965] [088/133] (385s left) vgem_basic (mmap)
[636.090407] Starting subtest: mmap
[636.115604] Subtest mmap: SUCCESS (0.029s)
[636.173129] [089/133] (385s left) syncobj_wait (invalid-signal-zero-handles)
[636.224134] Starting subtest: invalid-signal-zero-handles
[636.226123] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[636.320937] [090/133] (385s left) kms_properties (colorop-properties-atomic)
[636.417129] Starting subtest: colorop-properties-atomic
[636.418686] Starting dynamic subtest: pipe-A-eDP-1
[636.750645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[636.761479] Starting dynamic subtest: pipe-B-eDP-1
[637.840625] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.088s)
[637.852691] Starting dynamic subtest: pipe-C-eDP-1
[638.881140] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.038s)
[638.890829] Starting dynamic subtest: pipe-D-eDP-1
[639.921004] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.039s)
[639.923273] Subtest colorop-properties-atomic: SUCCESS (3.505s)
[640.730287] [091/133] (380s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[640.830784] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[647.789310] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.961s)
[647.913630] [092/133] (373s left) gem_ctx_shared (q-smoketest)
[647.989096] Starting subtest: Q-smoketest
[647.991300] Starting dynamic subtest: rcs0
[653.551002] Dynamic subtest rcs0: SUCCESS (5.505s)
[653.561685] Starting dynamic subtest: bcs0
[659.060391] Dynamic subtest bcs0: SUCCESS (5.515s)
[659.071541] Starting dynamic subtest: vcs0
[664.541504] Dynamic subtest vcs0: SUCCESS (5.478s)
[664.552262] Starting dynamic subtest: vcs1
[670.012309] Dynamic subtest vcs1: SUCCESS (5.474s)
[670.028049] Starting dynamic subtest: vecs0
[675.518013] Dynamic subtest vecs0: SUCCESS (5.500s)
[675.531864] Starting dynamic subtest: ccs0
[681.012853] Dynamic subtest ccs0: SUCCESS (5.496s)
[681.014898] Subtest Q-smoketest: SUCCESS (32.976s)
[681.154776] [093/133] (340s left) gem_userptr_blits (dmabuf-sync)
[681.232160] Starting subtest: dmabuf-sync
[681.236377] Subtest dmabuf-sync: SKIP (0.002s)
[681.376476] [094/133] (340s left) kms_hdmi_inject (inject-audio)
[681.724459] Starting subtest: inject-audio
[681.999098] Subtest inject-audio: SUCCESS (0.275s)
[682.598658] [095/133] (339s left) gem_ctx_isolation (clean)
[682.659629] Starting subtest: clean
[682.661954] Starting dynamic subtest: rcs0
[682.699922] Dynamic subtest rcs0: SUCCESS (0.040s)
[682.709972] Starting dynamic subtest: bcs0
[682.751920] Dynamic subtest bcs0: SUCCESS (0.051s)
[682.763044] Starting dynamic subtest: vcs0
[682.785198] Dynamic subtest vcs0: SUCCESS (0.032s)
[682.795050] Starting dynamic subtest: vcs1
[684.535029] Dynamic subtest vcs1: SUCCESS (1.749s)
[684.545343] Starting dynamic subtest: vecs0
[686.525921] Dynamic subtest vecs0: SUCCESS (1.990s)
[686.537746] Starting dynamic subtest: ccs0
[688.507497] Dynamic subtest ccs0: SUCCESS (1.980s)
[688.509973] Subtest clean: SUCCESS (5.848s)
[688.742613] [096/133] (333s left) kms_pm_dc (dc5-dpms)
[689.869510] Starting subtest: dc5-dpms
[692.004188] Subtest dc5-dpms: SUCCESS (2.136s)
[692.085542] [097/133] (329s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[692.185312] Starting subtest: invalidate-primary-flip-overlay
[702.937863] Subtest invalidate-primary-flip-overlay: SUCCESS (10.756s)
[703.041683] [098/133] (318s left) gem_mmap_gtt (big-bo-tiledy)
[703.095280] Subtest big-bo-tiledY: SKIP (0.000s)
[703.156721] [099/133] (318s left) gem_ctx_persistence (userptr)
[703.211249] Starting subtest: userptr
[703.366884] Subtest userptr: SUCCESS (0.158s)
[703.449974] [100/133] (318s left) gem_mmap_gtt (hang)
[703.511538] Subtest hang: SKIP (0.000s)
[703.576004] [101/133] (318s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[703.671559] Starting subtest: psr-rgb565-draw-mmap-gtt
[703.674788] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[703.772186] [102/133] (318s left) sw_sync (alloc_fence_invalid_timeline)
[703.817990] Starting subtest: alloc_fence_invalid_timeline
[703.819851] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[703.871135] [103/133] (318s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[703.951621] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[703.953748] Starting dynamic subtest: A-eDP1
[712.869040] Dynamic subtest A-eDP1: SUCCESS (8.917s)
[712.880993] Starting dynamic subtest: B-eDP1
[721.779876] Dynamic subtest B-eDP1: SUCCESS (8.909s)
[721.793498] Starting dynamic subtest: C-eDP1
[730.660480] Dynamic subtest C-eDP1: SUCCESS (8.879s)
[730.671671] Starting dynamic subtest: D-eDP1
[739.566402] Dynamic subtest D-eDP1: SUCCESS (8.906s)
[739.572283] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.625s)
[740.764786] [104/133] (281s left) dumb_buffer (map-invalid-size)
[740.822555] Starting subtest: map-invalid-size
[740.824921] Subtest map-invalid-size: SUCCESS (0.000s)
[740.914452] [105/133] (281s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[741.012662] Starting subtest: extended-modeset-hang-newfb-with-reset
[741.015025] Starting dynamic subtest: pipe-A
[756.288307] Dynamic subtest pipe-A: SUCCESS (15.276s)
[756.298596] Starting dynamic subtest: pipe-D
[772.190022] Dynamic subtest pipe-D: SUCCESS (15.899s)
[772.192428] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.181s)
[773.043029] [106/133] (249s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[773.135552] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[773.139941] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[774.245620] [107/133] (248s left) api_intel_bb (simple-bb-ctx)
[774.311160] Starting subtest: simple-bb-ctx
[774.318058] Subtest simple-bb-ctx: SUCCESS (0.008s)
[774.409955] [108/133] (248s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[774.505030] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[774.530057] Starting dynamic subtest: pipe-A-plane-0
[774.951963] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[774.962743] Starting dynamic subtest: pipe-A-plane-3
[775.207114] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[776.298156] Starting dynamic subtest: pipe-B-plane-0
[776.734710] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[776.748068] Starting dynamic subtest: pipe-B-plane-3
[777.000936] Dynamic subtest pipe-B-plane-3: SUCCESS (0.264s)
[777.321889] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.819s)
[778.145748] [109/133] (244s left) syncobj_wait (reset-during-wait-for-submit)
[778.202088] Starting subtest: reset-during-wait-for-submit
[778.302976] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[778.384517] [110/133] (244s left) kms_flip (2x-flip-vs-dpms)
[778.480478] Starting subtest: 2x-flip-vs-dpms
[778.491447] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[778.576408] [111/133] (243s left) kms_draw_crc (draw-method-blt)
[778.669759] Starting subtest: draw-method-blt
[778.671975] Starting dynamic subtest: xrgb8888-untiled
[778.913462] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[778.923430] Starting dynamic subtest: rgb565-untiled
[779.133747] Dynamic subtest rgb565-untiled: SUCCESS (0.219s)
[779.145928] Starting dynamic subtest: xrgb2101010-untiled
[779.400550] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.265s)
[779.412725] Starting dynamic subtest: xbgr16161616f-untiled
[779.689390] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.287s)
[779.699229] Starting dynamic subtest: xrgb8888-xtiled
[779.800378] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[779.810869] Starting dynamic subtest: rgb565-xtiled
[779.911408] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[779.921297] Starting dynamic subtest: xrgb2101010-xtiled
[780.012064] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[780.024919] Starting dynamic subtest: xbgr16161616f-xtiled
[780.111476] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[780.123684] Starting dynamic subtest: xrgb8888-4tiled
[780.233564] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[780.243304] Starting dynamic subtest: rgb565-4tiled
[780.344785] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[780.354845] Starting dynamic subtest: xrgb2101010-4tiled
[780.444679] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[780.454555] Starting dynamic subtest: xbgr16161616f-4tiled
[780.544585] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[780.546467] Subtest draw-method-blt: SUCCESS (1.880s)
[780.673660] [112/133] (241s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[780.765894] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[780.769296] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[780.862377] [113/133] (241s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[780.926640] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[780.928571] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[781.038216] [114/133] (241s left) kms_universal_plane (universal-plane-sanity)
[781.124370] Starting subtest: universal-plane-sanity
[781.126278] Starting dynamic subtest: pipe-A-eDP-1
[781.723839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[781.738251] Starting dynamic subtest: pipe-B-eDP-1
[782.942318] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s)
[782.952950] Starting dynamic subtest: pipe-C-eDP-1
[784.118752] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.171s)
[784.130166] Starting dynamic subtest: pipe-D-eDP-1
[785.318881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.202s)
[785.321296] Subtest universal-plane-sanity: SUCCESS (4.195s)
[786.142060] [115/133] (236s left) kms_psr (pr-suspend)
[786.245245] Starting subtest: pr-suspend
[786.249715] Subtest pr-suspend: SKIP (0.000s)
[786.319004] [116/133] (236s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[786.403203] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[786.405509] Starting dynamic subtest: pipe-A-eDP-1
[786.414610] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[786.429732] Starting dynamic subtest: pipe-B-eDP-1
[786.439383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[786.449386] Starting dynamic subtest: pipe-C-eDP-1
[786.458029] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[786.467948] Starting dynamic subtest: pipe-D-eDP-1
[786.476623] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[786.480986] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[788.645521] [117/133] (234s left) gem_exec_fence (parallel)
[788.820402] Starting subtest: parallel
[788.822722] Starting dynamic subtest: rcs0
[790.972472] Dynamic subtest rcs0: SUCCESS (2.153s)
[790.983942] Starting dynamic subtest: bcs0
[793.127317] Dynamic subtest bcs0: SUCCESS (2.154s)
[793.138942] Starting dynamic subtest: vcs0
[795.280689] Dynamic subtest vcs0: SUCCESS (2.153s)
[795.292533] Starting dynamic subtest: vcs1
[797.432361] Dynamic subtest vcs1: SUCCESS (2.151s)
[797.442432] Starting dynamic subtest: vecs0
[799.580680] Dynamic subtest vecs0: SUCCESS (2.148s)
[799.593013] Starting dynamic subtest: ccs0
[801.729914] Dynamic subtest ccs0: SUCCESS (2.149s)
[801.731784] Subtest parallel: SUCCESS (12.912s)
[802.624369] [118/133] (220s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[802.729559] Starting subtest: compare-crc-sanitycheck-xr24
[802.731891] Starting dynamic subtest: pipe-A-eDP-1
[803.382260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[803.393648] Starting dynamic subtest: pipe-B-eDP-1
[804.710950] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.329s)
[804.722098] Starting dynamic subtest: pipe-C-eDP-1
[805.904375] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.191s)
[805.914682] Starting dynamic subtest: pipe-D-eDP-1
[807.113064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[807.115452] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.384s)
[807.933071] [119/133] (214s left) gem_create (create-ext-placement-sanity-check)
[808.114454] Starting subtest: create-ext-placement-sanity-check
[808.117108] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[808.214499] [120/133] (214s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[808.306930] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[808.309199] Starting dynamic subtest: pipe-A-eDP-1
[808.333560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[808.346339] Starting dynamic subtest: pipe-B-eDP-1
[808.368874] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[808.378706] Starting dynamic subtest: pipe-C-eDP-1
[808.401109] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[808.410868] Starting dynamic subtest: pipe-D-eDP-1
[808.435074] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[808.439140] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[810.536800] [121/133] (212s left) gem_mmap_wc (read-write)
[810.593130] Subtest read-write: SKIP (0.000s)
[810.650263] [122/133] (212s left) gem_exec_schedule (implicit-boths)
[810.713968] Starting subtest: implicit-boths
[810.716185] Starting dynamic subtest: rcs0
[810.817623] Dynamic subtest rcs0: SUCCESS (0.114s)
[810.830997] Starting dynamic subtest: vcs0
[810.907089] Dynamic subtest vcs0: SUCCESS (0.089s)
[810.919193] Starting dynamic subtest: vcs1
[810.987042] Dynamic subtest vcs1: SUCCESS (0.079s)
[810.999270] Starting dynamic subtest: vecs0
[811.070042] Dynamic subtest vecs0: SUCCESS (0.082s)
[811.080664] Starting dynamic subtest: ccs0
[811.160039] Dynamic subtest ccs0: SUCCESS (0.089s)
[811.162726] Subtest implicit-boths: SUCCESS (0.458s)
[812.598949] [123/133] (210s left) gem_exec_params (dr4-dirt)
[812.671284] Starting subtest: DR4-dirt
[812.673703] Subtest DR4-dirt: SUCCESS (0.000s)
[812.800210] [124/133] (210s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[812.900337] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[819.852102] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.956s)
[820.013664] [125/133] (203s left) kms_cursor_edge_walk (64x64-left-edge)
[820.110184] Starting subtest: 64x64-left-edge
[820.112440] Starting dynamic subtest: pipe-A-eDP-1
[823.568090] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[823.580058] Starting dynamic subtest: pipe-D-eDP-1
[826.755409] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.188s)
[826.757656] Subtest 64x64-left-edge: SUCCESS (6.648s)
[827.626917] [126/133] (195s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[827.741515] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[834.952948] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.213s)
[835.081426] [127/133] (188s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[835.475333] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[836.314850] [128/133] (186s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[836.689308] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[837.512393] [129/133] (185s left) syncobj_wait (wait-for-submit-complex)
[837.571793] Starting subtest: wait-for-submit-complex
[837.632640] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[837.721035] [130/133] (185s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[837.833056] Starting subtest: pr-cursor-plane-update-sf
[837.837301] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[837.916269] [131/133] (185s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[838.019229] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[838.023319] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[838.131454] [132/133] (185s left) gem_close (many-handles-one-vma)
[838.198555] Starting subtest: many-handles-one-vma
[838.222687] Subtest many-handles-one-vma: SUCCESS (0.024s)
[838.344580] [133/133] (185s left) kms_getfb (getfb-handle-not-fb)
[838.437865] Starting subtest: getfb-handle-not-fb
[838.440141] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[838.534183] Closing watchdogs
results: parsing output: 0/ for test: sysfs_timeslice_duration
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_prime
results: parsing output: 8/ for test: gem_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: gem_vm_create
results: parsing output: 12/ for test: sriov_basic
results: parsing output: 13/ for test: kms_vrr
results: parsing output: 14/ for test: gem_pxp
results: parsing output: 15/ for test: kms_plane_cursor
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_nop
results: parsing output: 29/ for test: kms_async_flips
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: i915_suspend
results: parsing output: 35/ for test: gem_linear_blits
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: i915_fb_tiling
results: parsing output: 39/ for test: gem_close_race
results: parsing output: 40/ for test: api_intel_allocator
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_debugfs
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_tiled_pread_pwrite
results: parsing output: 71/ for test: gem_exec_parallel
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: i915_pm_rps
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_color_pipeline
results: parsing output: 82/ for test: kms_joiner
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_properties
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ctx_shared
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_hdmi_inject
results: parsing output: 94/ for test: gem_ctx_isolation
results: parsing output: 95/ for test: kms_pm_dc
results: parsing output: 96/ for test: kms_psr_stress_test
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: dumb_buffer
results: parsing output: 104/ for test: kms_busy
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_universal_plane
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_edge_walk
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_chamelium_frames
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_close
results: parsing output: 132/ for test: kms_getfb
Done.