[57.590602] Initializing watchdogs
[57.590747]   /dev/watchdog0
[57.604860] [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.608949] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.611102] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.614184] [001/130] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[62.703268] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[62.707861] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[63.547157] [002/130] (954s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[63.663587] Starting subtest: 4-tiled-32bpp-rotate-180
[65.405143] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.744s)
[65.696170] [003/130] (952s left) kms_psr (fbc-psr2-sprite-render)
[65.793242] Starting subtest: fbc-psr2-sprite-render
[65.795649] Starting dynamic subtest: eDP-1
[65.799833] Dynamic subtest eDP-1: SKIP (0.000s)
[65.803922] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[65.855990] [004/130] (952s left) gem_render_copy (x-tiled)
[65.909949] Starting subtest: x-tiled
[65.912269] Starting dynamic subtest: smem
[65.954195] Dynamic subtest smem: SUCCESS (0.044s)
[65.956500] Subtest x-tiled: SUCCESS (0.044s)
[66.182481] [005/130] (952s left) dumb_buffer (map-uaf)
[66.240115] Starting subtest: map-uaf
[66.254131] Subtest map-uaf: SUCCESS (0.016s)
[66.359292] [006/130] (951s left) i915_suspend (sysfs-reader)
[66.411868] Starting subtest: sysfs-reader
[85.256364] Subtest sysfs-reader: SUCCESS (3.431s)
[85.322165] [007/130] (948s left) gem_exec_suspend (basic)
[85.389367] Starting subtest: basic
[85.391887] Starting dynamic subtest: smem
[87.332896] Dynamic subtest smem: SUCCESS (1.952s)
[87.335810] Subtest basic: SUCCESS (1.953s)
[87.510898] [008/130] (946s left) gem_spin_batch (spin-all-new)
[87.585472] Starting subtest: spin-all-new
[87.613666] Subtest spin-all-new: SUCCESS (0.029s)
[89.349035] [009/130] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[89.461057] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[89.465962] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[89.564577] [010/130] (944s left) gem_exec_balancer (full-late-pulse)
[89.638359] Starting subtest: full-late-pulse
[94.147554] Subtest full-late-pulse: SUCCESS (4.523s)
[94.474722] [011/130] (939s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[94.603580] Starting subtest: cursorA-vs-flipB-varying-size
[94.609218] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[94.694589] [012/130] (939s left) gem_exec_params (invalid-ring)
[94.752542] Starting subtest: invalid-ring
[94.755446] Subtest invalid-ring: SUCCESS (0.000s)
[94.868047] [013/130] (939s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[94.964745] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[94.967278] Starting dynamic subtest: pipe-A-eDP-1
[94.992979] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[95.007046] Starting dynamic subtest: pipe-B-eDP-1
[95.033138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.040571] Starting dynamic subtest: pipe-C-eDP-1
[95.065903] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.073369] Starting dynamic subtest: pipe-D-eDP-1
[95.099577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.104434] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[97.113737] [014/130] (936s left) kms_sequence (get-forked-busy)
[97.214961] Starting subtest: get-forked-busy
[97.217557] Starting dynamic subtest: pipe-A-eDP-1
[99.151571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[99.161865] Starting dynamic subtest: pipe-B-eDP-1
[101.699251] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.550s)
[101.708577] Starting dynamic subtest: pipe-C-eDP-1
[104.313595] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.617s)
[104.322848] Starting dynamic subtest: pipe-D-eDP-1
[106.843269] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[106.846373] Subtest get-forked-busy: SUCCESS (9.638s)
[107.618423] [015/130] (926s left) kms_big_fb (linear-8bpp-rotate-270)
[107.731397] Starting subtest: linear-8bpp-rotate-270
[107.752555] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[107.879202] [016/130] (926s left) gem_render_copy (yf-tiled-to-vebox-linear)
[107.947844] Starting subtest: yf-tiled-to-vebox-linear
[107.953575] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[108.124597] [017/130] (925s left) kms_psr (fbc-pr-sprite-plane-onoff)
[108.221562] Starting subtest: fbc-pr-sprite-plane-onoff
[108.227439] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[108.288608] [018/130] (925s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[108.392891] Starting subtest: read-crc-frame-sequence
[108.395555] Starting dynamic subtest: pipe-A-eDP-1
[109.118259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[109.126172] Starting dynamic subtest: pipe-B-eDP-1
[110.488729] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.372s)
[110.498007] Starting dynamic subtest: pipe-C-eDP-1
[111.796408] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.307s)
[111.805201] Starting dynamic subtest: pipe-D-eDP-1
[113.089715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s)
[113.092324] Subtest read-crc-frame-sequence: SUCCESS (4.697s)
[113.928430] [019/130] (920s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[114.038105] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[114.040562] Starting dynamic subtest: pipe-A-eDP-1
[114.050437] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[114.059217] Starting dynamic subtest: pipe-B-eDP-1
[114.068851] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[114.076197] Starting dynamic subtest: pipe-C-eDP-1
[114.086456] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[114.093592] Starting dynamic subtest: pipe-D-eDP-1
[114.104145] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[114.109327] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[116.187730] [020/130] (917s left) syncobj_timeline (single-wait-all-signaled)
[116.250413] Starting subtest: single-wait-all-signaled
[116.254967] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[116.354554] [021/130] (917s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[116.469166] Starting subtest: fbcpsr-stridechange
[120.441593] Subtest fbcpsr-stridechange: SUCCESS (3.972s)
[120.569734] [022/130] (913s left) kms_flip (2x-flip-vs-panning-interruptible)
[120.681963] Starting subtest: 2x-flip-vs-panning-interruptible
[120.695071] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[120.786948] [023/130] (913s left) kms_frontbuffer_tracking (psr-suspend)
[120.890289] Starting subtest: psr-suspend
[157.173676] Subtest psr-suspend: SUCCESS (5.531s)
[157.267082] [024/130] (907s left) kms_chamelium_edid (dp-mode-timings)
[157.666370] Subtest dp-mode-timings: SKIP (0.000s)
[158.470982] [025/130] (906s left) prime_mmap (test_aperture_limit)
[158.520618] Starting subtest: test_aperture_limit
[158.523073] Starting dynamic subtest: test_aperture_limit-smem
[158.525764] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.007s)
[158.528552] Subtest test_aperture_limit: SUCCESS (0.007s)
[158.600862] [026/130] (906s left) i915_pm_rpm (debugfs-read)
[160.240146] Starting subtest: debugfs-read
[161.402716] Subtest debugfs-read: SUCCESS (1.164s)
[161.758320] [027/130] (903s left) gem_mmap_gtt (close-race)
[161.823657] Subtest close-race: SKIP (0.000s)
[161.883415] [028/130] (903s left) kms_atomic (plane-immutable-zpos)
[161.974230] Starting subtest: plane-immutable-zpos
[161.976761] Starting dynamic subtest: pipe-A-eDP-1
[162.652460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.679s)
[162.655341] Subtest plane-immutable-zpos: SUCCESS (0.680s)
[163.473328] [029/130] (901s left) i915_power (sanity)
[163.525300] Starting subtest: sanity
[167.584295] Subtest sanity: SUCCESS (4.061s)
[169.128580] [030/130] (896s left) prime_self_import (export-vs-gem_close-race)
[169.166739] Starting subtest: export-vs-gem_close-race
[174.278727] Subtest export-vs-gem_close-race: SUCCESS (5.105s)
[174.333966] [031/130] (890s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[174.453173] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[174.458481] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[174.559931] [032/130] (890s left) kms_plane_multiple (tiling-x)
[174.663352] Starting subtest: tiling-x
[174.665730] Starting dynamic subtest: pipe-A-eDP-1
[178.384576] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.722s)
[178.392577] Starting dynamic subtest: pipe-B-eDP-1
[182.777609] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.397s)
[182.786564] Starting dynamic subtest: pipe-C-eDP-1
[187.075654] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.300s)
[187.084602] Starting dynamic subtest: pipe-D-eDP-1
[191.505436] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.427s)
[191.508450] Subtest tiling-x: SUCCESS (16.848s)
[192.302229] [033/130] (872s left) gem_ctx_persistence (processes)
[192.368218] Starting subtest: processes
[194.138202] Subtest processes: SUCCESS (1.772s)
[194.216786] [034/130] (871s left) gem_vm_create (execbuf)
[194.275390] Starting subtest: execbuf
[194.283758] Subtest execbuf: SUCCESS (0.009s)
[194.395991] [035/130] (870s left) gem_exec_schedule (reorder-wide)
[194.581486] Subtest reorder-wide: SKIP (0.000s)
[194.755880] [036/130] (870s left) kms_color (gamma)
[194.863549] Starting subtest: gamma
[194.866367] Starting dynamic subtest: pipe-A-eDP-1
[195.589600] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[195.598731] Starting dynamic subtest: pipe-B-eDP-1
[196.986937] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[196.996044] Starting dynamic subtest: pipe-C-eDP-1
[198.366349] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[198.381353] Starting dynamic subtest: pipe-D-eDP-1
[199.718621] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s)
[199.721634] Subtest gamma: SUCCESS (4.852s)
[200.513766] [037/130] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[200.624397] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[200.629587] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[200.721937] [038/130] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[200.820617] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[200.825680] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[200.903089] [039/130] (864s left) kms_lease (lease-invalid-connector)
[200.997344] Starting subtest: lease-invalid-connector
[200.999846] Starting dynamic subtest: pipe-A-eDP-1
[201.002473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[201.011283] Starting dynamic subtest: pipe-B-eDP-1
[201.013567] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[201.022101] Starting dynamic subtest: pipe-C-eDP-1
[201.024640] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[201.032742] Starting dynamic subtest: pipe-D-eDP-1
[201.035081] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[201.037363] Subtest lease-invalid-connector: SUCCESS (0.003s)
[201.070352] [040/130] (864s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[201.160496] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[201.163089] Starting dynamic subtest: pipe-A-eDP-1
[201.212761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.052s)
[201.221677] Starting dynamic subtest: pipe-B-eDP-1
[201.266678] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.052s)
[201.275421] Starting dynamic subtest: pipe-C-eDP-1
[201.314419] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.047s)
[201.323334] Starting dynamic subtest: pipe-D-eDP-1
[201.369402] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.054s)
[201.372118] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.209s)
[203.565592] [041/130] (861s left) gem_ctx_persistence (hostile)
[203.635533] Starting subtest: hostile
[213.138789] Subtest hostile: SUCCESS (9.500s)
[213.277408] [042/130] (852s left) gem_exec_nop (basic-sequential)
[213.352478] Starting subtest: basic-sequential
[229.232072] Subtest basic-sequential: SUCCESS (15.867s)
[229.431021] [043/130] (836s left) gem_exec_reloc (basic-concurrent16)
[229.495512] Subtest basic-concurrent16: SKIP (0.000s)
[229.571212] [044/130] (836s left) prime_busy (before-wait)
[229.631506] Starting subtest: before-wait
[229.636670] Starting dynamic subtest: rcs0
[229.659257] Dynamic subtest rcs0: SUCCESS (0.023s)
[229.668287] Starting dynamic subtest: bcs0
[229.703044] Dynamic subtest bcs0: SUCCESS (0.044s)
[229.712317] Starting dynamic subtest: vcs0
[229.747784] Dynamic subtest vcs0: SUCCESS (0.044s)
[229.756108] Starting dynamic subtest: vcs1
[229.791606] Dynamic subtest vcs1: SUCCESS (0.043s)
[229.799781] Starting dynamic subtest: vecs0
[229.835295] Dynamic subtest vecs0: SUCCESS (0.043s)
[229.843486] Starting dynamic subtest: ccs0
[229.879567] Dynamic subtest ccs0: SUCCESS (0.044s)
[229.988752] Subtest before-wait: SUCCESS (0.356s)
[230.057886] [045/130] (835s left) sysfs_heartbeat_interval (mixed)
[230.128731] Starting subtest: mixed
[230.131722] Starting dynamic subtest: vecs0
[235.360734] Dynamic subtest vecs0: SUCCESS (5.233s)
[235.371811] Starting dynamic subtest: ccs0
[240.572059] Dynamic subtest ccs0: SUCCESS (5.212s)
[240.582407] Starting dynamic subtest: vcs0
[245.766743] Dynamic subtest vcs0: SUCCESS (5.196s)
[245.777423] Starting dynamic subtest: bcs0
[250.986421] Dynamic subtest bcs0: SUCCESS (5.219s)
[251.002547] Starting dynamic subtest: rcs0
[256.208882] Dynamic subtest rcs0: SUCCESS (5.219s)
[256.220606] Starting dynamic subtest: vcs1
[261.413793] Dynamic subtest vcs1: SUCCESS (5.201s)
[261.416603] Subtest mixed: SUCCESS (31.288s)
[261.484207] [046/130] (804s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[261.594484] Starting subtest: fbc-farfromfence-mmap-gtt
[261.599565] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[261.701555] [047/130] (804s left) sw_sync (timeline_closed_signaled)
[261.740650] Starting subtest: timeline_closed_signaled
[261.743551] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[261.790259] [048/130] (803s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[261.902544] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[261.907643] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[262.044310] [049/130] (803s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[262.097414] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[262.201144] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[262.269951] [050/130] (803s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[262.467758] Starting subtest: cursor-rapid-movement-128x42
[262.507087] Subtest cursor-rapid-movement-128x42: SKIP (0.035s)
[262.716472] [051/130] (803s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[262.827433] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[262.832379] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[262.882870] [052/130] (803s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[267.908334] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[267.913577] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[268.758257] [053/130] (797s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[268.864172] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[274.127350] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.267s)
[274.234113] [054/130] (791s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[274.344540] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[274.349638] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[274.434392] [055/130] (791s left) gem_exec_schedule (smoketest)
[274.620085] Starting subtest: smoketest
[274.622768] Starting dynamic subtest: rcs0
[280.262313] Dynamic subtest rcs0: SUCCESS (5.520s)
[280.278139] Starting dynamic subtest: bcs0
[285.794011] Dynamic subtest bcs0: SUCCESS (5.534s)
[285.810324] Starting dynamic subtest: vcs0
[291.330556] Dynamic subtest vcs0: SUCCESS (5.530s)
[291.347021] Starting dynamic subtest: vcs1
[296.846797] Dynamic subtest vcs1: SUCCESS (5.531s)
[296.857329] Starting dynamic subtest: vecs0
[302.380583] Dynamic subtest vecs0: SUCCESS (5.516s)
[302.395793] Starting dynamic subtest: ccs0
[307.892749] Dynamic subtest ccs0: SUCCESS (5.519s)
[307.895736] Subtest smoketest: SUCCESS (33.156s)
[308.023185] [056/130] (758s left) sw_sync (sync_busy_fork)
[308.060525] Starting subtest: sync_busy_fork
[309.074913] Subtest sync_busy_fork: SUCCESS (1.014s)
[309.134220] [057/130] (756s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[309.244721] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[309.247560] Starting dynamic subtest: A-eDP1
[318.149524] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[318.158059] Starting dynamic subtest: B-eDP1
[327.071356] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[327.079886] Starting dynamic subtest: C-eDP1
[336.030096] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[336.042001] Starting dynamic subtest: D-eDP1
[344.956506] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[344.959625] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.675s)
[346.117778] [058/130] (719s left) gem_pread (self)
[346.172745] Subtest self: SKIP (0.000s)
[346.223941] [059/130] (719s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[346.322740] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[346.325459] Starting dynamic subtest: pipe-A-eDP-1
[346.349369] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.358380] Starting dynamic subtest: pipe-B-eDP-1
[346.383558] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.391593] Starting dynamic subtest: pipe-C-eDP-1
[346.417395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.425353] Starting dynamic subtest: pipe-D-eDP-1
[346.451574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.456712] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[348.565980] [060/130] (717s left) prime_vgem (fence-flip-hang)
[348.715292] Subtest fence-flip-hang: SKIP (0.000s)
[348.809955] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[348.813685] [061/130] (717s left) kms_setmode (invalid-clone-single-crtc-stealing)
[348.876444] Starting subtest: invalid-clone-single-crtc-stealing
[348.884741] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[348.987511] [062/130] (717s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[349.098785] Starting subtest: yf-tiled-8bpp-rotate-180
[349.103678] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[349.208153] [063/130] (717s left) gem_gpgpu_fill (basic)
[349.272202] Starting subtest: basic
[349.274547] Starting dynamic subtest: smem
[349.279784] Dynamic subtest smem: SUCCESS (0.008s)
[349.282552] Subtest basic: SUCCESS (0.009s)
[349.417042] [064/130] (716s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[349.528429] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[350.640529] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.113s)
[350.856377] [065/130] (715s left) gem_mmap_gtt (big-copy)
[350.910580] Subtest big-copy: SKIP (0.000s)
[350.966759] [066/130] (715s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[351.067605] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[351.070456] Starting dynamic subtest: pipe-A-eDP-1
[383.144665] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.863s)
[383.153439] Starting dynamic subtest: pipe-B-eDP-1
[416.040045] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.548s)
[416.050269] Starting dynamic subtest: pipe-C-eDP-1
[449.023760] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.370s)
[449.034564] Starting dynamic subtest: pipe-D-eDP-1
[482.032422] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.440s)
[482.035015] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.225s)
[483.228918] [067/130] (700s left) sw_sync (sync_merge)
[483.271004] Starting subtest: sync_merge
[483.273616] Subtest sync_merge: SUCCESS (0.000s)
[483.316838] [068/130] (700s left) kms_psr (psr-dpms)
[483.420360] Starting subtest: psr-dpms
[483.422937] Starting dynamic subtest: eDP-1
[486.462184] Dynamic subtest eDP-1: SUCCESS (3.049s)
[486.464623] Subtest psr-dpms: SUCCESS (3.050s)
[487.294284] [069/130] (696s left) gem_exec_fence (basic-busy)
[487.481831] Starting subtest: basic-busy
[487.484242] Starting dynamic subtest: rcs0
[487.588921] Dynamic subtest rcs0: SUCCESS (0.108s)
[487.597492] Starting dynamic subtest: bcs0
[487.653464] Dynamic subtest bcs0: SUCCESS (0.064s)
[487.663899] Starting dynamic subtest: vcs0
[487.713846] Dynamic subtest vcs0: SUCCESS (0.058s)
[487.723236] Starting dynamic subtest: vcs1
[487.773818] Dynamic subtest vcs1: SUCCESS (0.059s)
[487.783419] Starting dynamic subtest: vecs0
[487.836862] Dynamic subtest vecs0: SUCCESS (0.061s)
[487.846636] Starting dynamic subtest: ccs0
[487.899908] Dynamic subtest ccs0: SUCCESS (0.061s)
[487.902627] Subtest basic-busy: SUCCESS (0.419s)
[489.918141] [070/130] (694s left) gem_mmap_offset (mmap-boundaries)
[489.975411] Starting subtest: mmap-boundaries
[489.977747] Starting dynamic subtest: smem0
[491.072792] Dynamic subtest smem0: SUCCESS (1.103s)
[491.075625] Subtest mmap-boundaries: SUCCESS (1.104s)
[491.266487] [071/130] (693s left) kms_fbcon_fbt (fbc-suspend)
[491.326377] Starting subtest: fbc-suspend
[540.247442] Subtest fbc-suspend: SUCCESS (18.211s)
[540.322967] [072/130] (674s left) kms_getfb (getfb2-handle-closed)
[540.382285] Starting subtest: getfb2-handle-closed
[540.384869] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[540.485298] [073/130] (674s left) perf (stress-open-close)
[540.594716] Starting subtest: stress-open-close
[540.596903] Starting dynamic subtest: 0-rcs0
[542.761993] Dynamic subtest 0-rcs0: SUCCESS (2.175s)
[542.770602] Starting dynamic subtest: 1-vecs0
[544.925392] Dynamic subtest 1-vecs0: SUCCESS (2.167s)
[544.927887] Subtest stress-open-close: SUCCESS (4.343s)
[544.962364] [074/130] (670s left) kms_prop_blob (invalid-get-prop-any)
[545.021615] Starting subtest: invalid-get-prop-any
[545.023956] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[545.112257] [075/130] (670s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[545.228191] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[545.232861] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[545.330290] [076/130] (669s left) gem_userptr_blits (dmabuf-unsync)
[545.410211] Subtest dmabuf-unsync: SKIP (0.000s)
[545.545869] [077/130] (669s left) kms_psr (fbc-psr-suspend)
[545.643396] Starting subtest: fbc-psr-suspend
[545.645596] Starting dynamic subtest: eDP-1
[545.649834] Dynamic subtest eDP-1: SKIP (0.000s)
[545.654216] Subtest fbc-psr-suspend: SKIP (0.001s)
[545.712358] [078/130] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[545.827319] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[548.909028] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.090s)
[549.020153] [079/130] (666s left) vgem_basic (create)
[549.066029] Starting subtest: create
[549.068376] Subtest create: SUCCESS (0.000s)
[549.117334] [080/130] (666s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[549.177658] Starting subtest: multi-wait-available-unsubmitted-submitted
[549.180179] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[549.279338] [081/130] (666s left) kms_chamelium_frames (hdmi-aspect-ratio)
[549.662494] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[550.499000] [082/130] (664s left) prime_mmap (test_refcounting)
[550.560733] Starting subtest: test_refcounting
[550.562983] Starting dynamic subtest: test_refcounting-smem
[550.595186] Dynamic subtest test_refcounting-smem: SUCCESS (0.035s)
[550.598013] Subtest test_refcounting: SUCCESS (0.035s)
[550.715383] [083/130] (664s left) syncobj_timeline (reset-unsignaled)
[550.779919] Starting subtest: reset-unsignaled
[550.782653] Subtest reset-unsignaled: SUCCESS (0.000s)
[550.882870] [084/130] (664s left) gem_ctx_exec (basic-close-race)
[550.947173] Starting subtest: basic-close-race
[556.759857] Subtest basic-close-race: SUCCESS (5.764s)
[556.829985] [085/130] (658s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[556.930464] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[562.157501] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.233s)
[562.265476] [086/130] (653s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[562.391668] Starting subtest: cursorA-vs-flipA-toggle
[573.551966] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.149s)
[574.401734] [087/130] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[574.571302] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[579.120592] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.552s)
[579.249769] [088/130] (636s left) api_intel_bb (blit-noreloc-keep-cache)
[579.314685] Starting subtest: blit-noreloc-keep-cache
[579.325959] Subtest blit-noreloc-keep-cache: SUCCESS (0.013s)
[579.442329] [089/130] (636s left) template (a)
[579.503221] Starting subtest: A
[579.505824] Subtest A: SUCCESS (0.000s)
[579.600480] [090/130] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[579.710760] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[579.715674] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[579.805520] [091/130] (635s left) gem_eio (in-flight-1us)
[580.041417] Starting subtest: in-flight-1us
[588.548144] Subtest in-flight-1us: SUCCESS (8.506s)
[588.664777] [092/130] (627s left) gen3_render_tiledy_blits
[588.798056] [093/130] (626s left) kms_vblank (ts-continuation-suspend)
[588.907774] Starting subtest: ts-continuation-suspend
[588.910626] Starting dynamic subtest: pipe-A-eDP-1
[605.416129] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.711s)
[605.439042] Starting dynamic subtest: pipe-D-eDP-1
[622.194899] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.136s)
[622.197397] Subtest ts-continuation-suspend: SUCCESS (3.851s)
[623.048435] [094/130] (622s left) gem_eio (create)
[623.287399] Starting subtest: create
[623.624615] Subtest create: SUCCESS (0.338s)
[623.737816] [095/130] (621s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[623.798771] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[623.909317] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[623.980963] [096/130] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[624.097051] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[624.101565] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[624.207538] [097/130] (621s left) prime_vgem (coherency-gtt)
[624.277892] Starting subtest: coherency-gtt
[624.282550] Subtest coherency-gtt: SKIP (0.000s)
[624.382210] [098/130] (620s left) kms_pm_rpm (modeset-non-lpsp-stress)
[626.230977] Starting subtest: modeset-non-lpsp-stress
[627.396830] Subtest modeset-non-lpsp-stress: SKIP (1.168s)
[627.756174] [099/130] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[627.859191] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[627.863085] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[627.960303] [100/130] (617s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[628.076367] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[631.486628] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (3.423s)
[631.608379] [101/130] (613s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[631.718845] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[632.996137] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.281s)
[633.373486] [102/130] (612s left) kms_vrr (seamless-rr-switch-drrs)
[633.476060] Starting subtest: seamless-rr-switch-drrs
[633.482630] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[633.546700] [103/130] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[633.664790] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[637.275470] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.622s)
[637.433434] [104/130] (608s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[637.544834] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[637.548594] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[637.648002] [105/130] (607s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[637.750874] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[637.752875] Starting dynamic subtest: pipe-A
[637.766147] Dynamic subtest pipe-A: SKIP (0.011s)
[637.775831] Starting dynamic subtest: pipe-B
[637.788726] Dynamic subtest pipe-B: SKIP (0.022s)
[637.797657] Starting dynamic subtest: pipe-C
[637.810834] Dynamic subtest pipe-C: SKIP (0.022s)
[637.819713] Starting dynamic subtest: pipe-D
[637.833311] Dynamic subtest pipe-D: SKIP (0.022s)
[637.836506] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.079s)
[637.937264] [106/130] (607s left) syncobj_basic (test-valid-cycle)
[638.003234] Starting subtest: test-valid-cycle
[638.005215] Subtest test-valid-cycle: SUCCESS (0.000s)
[638.086255] [107/130] (607s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[638.182645] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[638.184437] Starting dynamic subtest: pipe-A
[638.520791] Dynamic subtest pipe-A: SUCCESS (0.338s)
[638.529874] Starting dynamic subtest: pipe-B
[639.870906] Dynamic subtest pipe-B: SUCCESS (1.351s)
[639.880558] Starting dynamic subtest: pipe-C
[641.292137] Dynamic subtest pipe-C: SUCCESS (1.422s)
[641.301438] Starting dynamic subtest: pipe-D
[642.711623] Dynamic subtest pipe-D: SUCCESS (1.419s)
[642.713904] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.534s)
[643.869873] [108/130] (601s left) gen9_exec_parse (bb-start-far)
[643.942269] Subtest bb-start-far: SKIP (0.000s)
[644.027114] [109/130] (601s left) drm_buddy (drm_buddy)
[644.061879] Starting subtest: drm_buddy
[644.075760] Starting dynamic subtest: drm_test_buddy_alloc_limit
[644.218264] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.142s)
[644.229130] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[644.335166] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.116s)
[644.344633] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[644.425419] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.089s)
[644.435195] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[644.536503] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.109s)
[644.546584] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[644.659328] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.121s)
[644.669695] Starting dynamic subtest: drm_test_buddy_alloc_clear
[644.780216] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.119s)
[644.790029] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[644.855662] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.074s)
[644.857603] Subtest drm_buddy: SUCCESS (0.793s)
[645.033360] [110/130] (600s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[645.088761] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[645.091137] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[645.192387] [111/130] (600s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[645.257539] Starting subtest: y-tiled-to-vebox-x-tiled
[645.262139] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[645.438865] [112/130] (600s left) kms_dsc (dsc-with-output-formats)
[645.531212] Starting subtest: dsc-with-output-formats
[645.554576] Subtest dsc-with-output-formats: SKIP (0.000s)
[645.601667] [113/130] (600s left) kms_content_protection (mei-interface)
[645.790310] Starting subtest: mei-interface
[645.794900] Subtest mei-interface: SKIP (0.001s)
[645.915321] [114/130] (599s left) kms_psr (psr2-cursor-render)
[646.014231] Starting subtest: psr2-cursor-render
[646.016518] Starting dynamic subtest: eDP-1
[647.732454] Dynamic subtest eDP-1: SUCCESS (1.718s)
[647.734881] Subtest psr2-cursor-render: SUCCESS (1.719s)
[648.514845] [115/130] (597s left) gem_exec_fence (syncobj-wait)
[648.937600] Starting subtest: syncobj-wait
[650.120292] Subtest syncobj-wait: SUCCESS (1.182s)
[652.026761] [116/130] (593s left) vgem_basic (mmap)
[652.064929] Starting subtest: mmap
[652.069980] Subtest mmap: SUCCESS (0.008s)
[652.113828] [117/130] (593s left) gem_basic (multigpu-create-close)
[652.166969] Starting subtest: multigpu-create-close
[652.171113] Subtest multigpu-create-close: SKIP (0.000s)
[652.259614] [118/130] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[652.371159] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[652.375146] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[652.468356] [119/130] (593s left) gem_partial_pwrite_pread (writes-after-reads)
[652.534559] Subtest writes-after-reads: SKIP (0.000s)
[652.601812] [120/130] (593s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[652.705216] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[652.707470] Starting dynamic subtest: pipe-A-default-mode
[652.992719] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[652.997306] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.285s)
[653.837356] [121/130] (592s left) kms_cursor_crc (cursor-random-512x170)
[654.129270] Starting subtest: cursor-random-512x170
[654.133699] Subtest cursor-random-512x170: SKIP (0.001s)
[654.279918] [122/130] (591s left) kms_feature_discovery (dp-mst)
[654.379020] Starting subtest: dp-mst
[654.383133] Subtest dp-mst: SKIP (0.000s)
[654.451182] [123/130] (591s left) gem_workarounds (suspend-resume)
[654.511145] Starting subtest: suspend-resume
[671.217508] Subtest suspend-resume: SUCCESS (1.447s)
[672.308293] [124/130] (590s left) api_intel_bb (reset-bb)
[672.366931] Starting subtest: reset-bb
[672.372710] Subtest reset-bb: SUCCESS (0.005s)
[672.495389] [125/130] (590s left) gem_mmap_gtt (basic-read-write)
[672.558340] Subtest basic-read-write: SKIP (0.000s)
[672.623894] [126/130] (589s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[672.688313] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[672.690971] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[672.800062] [127/130] (589s left) gem_exec_whisper (basic-sync)
[672.869445] Starting subtest: basic-sync
[682.946749] Subtest basic-sync: SUCCESS (10.101s)
[683.124953] [128/130] (579s left) perf_pmu (event-wait)
[683.167561] Starting subtest: event-wait
[683.170553] Starting dynamic subtest: rcs0
[683.175610] Dynamic subtest rcs0: SKIP (0.000s)
[683.180234] Subtest event-wait: SKIP (0.001s)
[683.284069] [129/130] (579s left) gem_mmap_gtt (basic-write)
[683.354548] Subtest basic-write: SKIP (0.000s)
[683.417071] [130/130] (579s left) prime_vgem (basic-gtt)
[683.514577] Starting subtest: basic-gtt
[683.520324] Subtest basic-gtt: SKIP (0.000s)
[683.621519] Closing watchdogs
Done.