[59.764363] Initializing watchdogs
[59.764426]   /dev/watchdog0
[59.778555] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.783066] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.785544] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.788823] [001/132] (960s left) kms_psr (pr-no-drrs)
[59.909156] Starting subtest: pr-no-drrs
[59.913828] Subtest pr-no-drrs: SKIP (0.000s)
[59.980466] [002/132] (960s left) kms_busy (extended-modeset-hang-oldfb)
[60.077831] Starting subtest: extended-modeset-hang-oldfb
[60.080223] Starting dynamic subtest: pipe-A
[72.019514] Dynamic subtest pipe-A: SUCCESS (11.953s)
[72.030861] Starting dynamic subtest: pipe-D
[84.266589] Dynamic subtest pipe-D: SUCCESS (12.252s)
[84.268870] Subtest extended-modeset-hang-oldfb: SUCCESS (24.208s)
[85.058396] [003/132] (935s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[85.170120] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[85.172491] Starting dynamic subtest: pipe-A-eDP-1
[85.244842] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[85.254943] Starting dynamic subtest: pipe-B-eDP-1
[86.365811] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[86.370292] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.200s)
[87.545323] [004/132] (932s left) gem_ctx_bad_destroy (invalid-pad)
[87.599732] Starting subtest: invalid-pad
[87.602206] Subtest invalid-pad: SUCCESS (0.000s)
[87.673217] [005/132] (932s left) gem_mmap (basic)
[87.720732] Subtest basic: SKIP (0.000s)
[87.780948] [006/132] (932s left) i915_hangman (gt-engine-hang)
[87.848399] Starting subtest: gt-engine-hang
[87.850639] Starting dynamic subtest: rcs0
[89.256018] Dynamic subtest rcs0: SUCCESS (1.406s)
[89.266808] Starting dynamic subtest: bcs0
[91.300682] Dynamic subtest bcs0: SUCCESS (2.045s)
[91.314287] Starting dynamic subtest: vcs0
[93.288798] Dynamic subtest vcs0: SUCCESS (1.987s)
[93.299263] Starting dynamic subtest: vcs1
[95.267153] Dynamic subtest vcs1: SUCCESS (1.977s)
[95.277740] Starting dynamic subtest: vecs0
[97.250924] Dynamic subtest vecs0: SUCCESS (1.983s)
[97.263449] Starting dynamic subtest: ccs0
[99.299531] Dynamic subtest ccs0: SUCCESS (2.048s)
[99.302571] Subtest gt-engine-hang: SUCCESS (11.453s)
[99.380974] [007/132] (921s left) gen9_exec_parse (shadow-peek)
[99.442248] Subtest shadow-peek: SKIP (0.000s)
[99.511603] [008/132] (921s left) kms_plane_scaling (planes-downscale-factor-0-5)
[99.608973] Starting subtest: planes-downscale-factor-0-5
[99.611331] Starting dynamic subtest: pipe-A
[99.628941] Dynamic subtest pipe-A: SKIP (0.018s)
[99.637862] Starting dynamic subtest: pipe-B
[99.662716] Dynamic subtest pipe-B: SKIP (0.033s)
[99.672135] Starting dynamic subtest: pipe-C
[99.703767] Dynamic subtest pipe-C: SKIP (0.040s)
[99.711699] Starting dynamic subtest: pipe-D
[99.733726] Dynamic subtest pipe-D: SKIP (0.032s)
[99.737723] Subtest planes-downscale-factor-0-5: SKIP (0.123s)
[99.822042] [009/132] (920s left) kms_lease (setcrtc-implicit-plane)
[99.912877] Starting subtest: setcrtc-implicit-plane
[99.915262] Starting dynamic subtest: pipe-A-eDP-1
[100.371368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[100.381431] Starting dynamic subtest: pipe-B-eDP-1
[101.476823] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.107s)
[101.485732] Starting dynamic subtest: pipe-C-eDP-1
[102.596246] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[102.607820] Starting dynamic subtest: pipe-D-eDP-1
[103.723083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[103.725578] Subtest setcrtc-implicit-plane: SUCCESS (3.811s)
[104.563620] [010/132] (916s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[104.942213] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[105.763729] [011/132] (914s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[105.858261] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[105.862478] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[105.955750] [012/132] (914s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[106.084432] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[106.088824] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[106.224964] [013/132] (914s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[106.331949] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[113.697734] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.370s)
[113.829205] [014/132] (906s left) kms_cursor_crc (cursor-random-64x64)
[114.006738] Starting subtest: cursor-random-64x64
[114.009048] Starting dynamic subtest: pipe-A-eDP-1
[117.367938] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.357s)
[117.397752] Starting dynamic subtest: pipe-D-eDP-1
[121.352706] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.959s)
[121.354949] Subtest cursor-random-64x64: SUCCESS (7.346s)
[122.200396] [015/132] (898s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[122.309323] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[122.313603] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[122.413776] [016/132] (898s left) gem_ppgtt (blt-vs-render-ctx0)
[122.465970] Starting subtest: blt-vs-render-ctx0
[155.401569] Subtest blt-vs-render-ctx0: SUCCESS (32.931s)
[155.535727] [017/132] (865s left) vgem_basic (create)
[155.686891] Starting subtest: create
[155.689280] Subtest create: SUCCESS (0.000s)
[155.744274] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[155.747342] [018/132] (865s left) kms_big_fb (linear-64bpp-rotate-90)
[155.859110] Starting subtest: linear-64bpp-rotate-90
[155.880126] Subtest linear-64bpp-rotate-90: SKIP (0.021s)
[156.006047] [019/132] (864s left) gem_mmap_wc (write-read-distinct)
[156.066914] Subtest write-read-distinct: SKIP (0.000s)
[156.131307] [020/132] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[156.229622] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[156.233858] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[156.369349] [021/132] (864s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[156.442059] Starting subtest: saturated-hostile-nopreempt
[156.444049] Starting dynamic subtest: rcs0
[156.508475] Dynamic subtest rcs0: SKIP (0.064s)
[156.519491] Starting dynamic subtest: bcs0
[156.529034] Dynamic subtest bcs0: SKIP (0.020s)
[156.537265] Starting dynamic subtest: vcs0
[156.548999] Dynamic subtest vcs0: SKIP (0.019s)
[156.557350] Starting dynamic subtest: vcs1
[156.568028] Dynamic subtest vcs1: SKIP (0.018s)
[156.576021] Starting dynamic subtest: vecs0
[156.584074] Dynamic subtest vecs0: SKIP (0.015s)
[156.592210] Starting dynamic subtest: ccs0
[156.599975] Dynamic subtest ccs0: SKIP (0.015s)
[156.603316] Subtest saturated-hostile-nopreempt: SKIP (0.156s)
[156.688355] [022/132] (864s left) kms_psr (psr-cursor-plane-move)
[156.774077] Starting subtest: psr-cursor-plane-move
[156.775912] Starting dynamic subtest: eDP-1
[158.492596] Dynamic subtest eDP-1: SUCCESS (1.717s)
[158.495056] Subtest psr-cursor-plane-move: SUCCESS (1.718s)
[159.362679] [023/132] (861s left) kms_pm_dc (dc5-dpms)
[160.452127] Starting subtest: dc5-dpms
[162.547880] Subtest dc5-dpms: SUCCESS (2.095s)
[162.625758] [024/132] (858s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[162.721356] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[162.724617] Starting dynamic subtest: pipe-A-eDP-1
[162.747589] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[162.757745] Starting dynamic subtest: pipe-B-eDP-1
[162.778353] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.786542] Starting dynamic subtest: pipe-C-eDP-1
[162.807188] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.815244] Starting dynamic subtest: pipe-D-eDP-1
[162.836423] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.840259] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[164.962575] [025/132] (856s left) kms_async_flips (async-flip-suspend-resume)
[165.071505] Starting subtest: async-flip-suspend-resume
[165.454886] Starting dynamic subtest: pipe-A-eDP-1
[183.056587] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.047s)
[183.432311] Starting dynamic subtest: pipe-B-eDP-1
[201.056423] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.907s)
[201.429994] Starting dynamic subtest: pipe-C-eDP-1
[219.068712] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.906s)
[219.432647] Starting dynamic subtest: pipe-D-eDP-1
[237.059024] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.873s)
[237.061947] Subtest async-flip-suspend-resume: SUCCESS (13.206s)
[238.228203] [026/132] (783s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[238.344710] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[238.349446] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.453145] [027/132] (782s left) i915_query (query-garbage)
[238.509451] Starting subtest: query-garbage
[238.511714] Subtest query-garbage: SUCCESS (0.000s)
[238.601522] [028/132] (782s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[238.710670] Starting subtest: y-tiled-16bpp-rotate-180
[238.715615] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[238.811862] [029/132] (782s left) kms_rotation_crc (primary-rotation-90)
[238.903687] Starting subtest: primary-rotation-90
[238.908776] Subtest primary-rotation-90: SKIP (0.001s)
[238.974843] [030/132] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[239.069661] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[239.074873] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.170521] [031/132] (782s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[239.259945] Starting subtest: fbcpsr-rgb565-draw-render
[246.296510] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.055s)
[246.448535] [032/132] (775s left) gem_mmap (basic-small-bo)
[246.497968] Subtest basic-small-bo: SKIP (0.000s)
[246.560145] [033/132] (775s left) gem_ctx_isolation (dirty-switch)
[246.611962] Starting subtest: dirty-switch
[246.614763] Starting dynamic subtest: rcs0
[246.796775] Dynamic subtest rcs0: SUCCESS (0.185s)
[246.809448] Starting dynamic subtest: bcs0
[247.009276] Dynamic subtest bcs0: SUCCESS (0.212s)
[247.020093] Starting dynamic subtest: vcs0
[247.224775] Dynamic subtest vcs0: SUCCESS (0.216s)
[247.235725] Starting dynamic subtest: vcs1
[249.284803] Dynamic subtest vcs1: SUCCESS (2.061s)
[249.295188] Starting dynamic subtest: vecs0
[251.330489] Dynamic subtest vecs0: SUCCESS (2.047s)
[251.342997] Starting dynamic subtest: ccs0
[253.331836] Dynamic subtest ccs0: SUCCESS (2.003s)
[253.334723] Subtest dirty-switch: SUCCESS (6.728s)
[253.565778] [034/132] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[253.670778] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[253.675936] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[253.761648] [035/132] (767s left) kms_psr (fbc-psr-cursor-plane-onoff)
[253.859466] Starting subtest: fbc-psr-cursor-plane-onoff
[253.861744] Starting dynamic subtest: eDP-1
[253.866563] Dynamic subtest eDP-1: SKIP (0.000s)
[253.870968] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[253.935404] [036/132] (767s left) gem_create (create-invalid-size)
[254.005207] Starting subtest: create-invalid-size
[254.007845] Subtest create-invalid-size: SUCCESS (0.000s)
[254.191603] [037/132] (767s left) kms_vblank (ts-continuation-suspend)
[254.283958] Starting subtest: ts-continuation-suspend
[254.286714] Starting dynamic subtest: pipe-A-eDP-1
[270.341288] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.549s)
[270.358212] Starting dynamic subtest: pipe-D-eDP-1
[287.324775] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.180s)
[287.326698] Subtest ts-continuation-suspend: SUCCESS (3.733s)
[288.144761] [038/132] (733s left) kms_force_connector_basic (prune-stale-modes)
[288.240573] Starting subtest: prune-stale-modes
[288.683856] Subtest prune-stale-modes: SUCCESS (0.444s)
[288.822509] [039/132] (733s left) perf_pmu (pmu-read)
[288.861605] Starting subtest: pmu-read
[288.864028] Subtest pmu-read: SUCCESS (0.002s)
[288.972262] [040/132] (732s left) kms_pipe_crc_basic (hang-read-crc)
[289.075697] Starting subtest: hang-read-crc
[289.077605] Starting dynamic subtest: pipe-A-eDP-1
[291.213850] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.138s)
[291.225859] Starting dynamic subtest: pipe-B-eDP-1
[294.051505] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.839s)
[294.062915] Starting dynamic subtest: pipe-C-eDP-1
[296.697779] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.646s)
[296.708213] Starting dynamic subtest: pipe-D-eDP-1
[299.348186] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.652s)
[299.350528] Subtest hang-read-crc: SUCCESS (10.281s)
[300.179883] [041/132] (721s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[300.286431] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[300.290404] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[300.360111] [042/132] (721s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[300.471961] Starting subtest: flip-vs-cursor-varying-size
[309.454550] Subtest flip-vs-cursor-varying-size: SUCCESS (8.988s)
[310.299117] [043/132] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[310.399673] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[310.403941] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[310.516676] [044/132] (711s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[310.605087] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[310.607477] Starting dynamic subtest: pipe-A-eDP-1
[321.278775] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.688s)
[321.290309] Starting dynamic subtest: pipe-B-eDP-1
[332.675510] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.405s)
[332.677820] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.096s)
[333.531459] [045/132] (688s left) gem_exec_endless (dispatch)
[333.606121] Starting subtest: dispatch
[333.608573] Starting dynamic subtest: rcs0
[333.612961] Dynamic subtest rcs0: SUCCESS (0.005s)
[333.628107] Starting dynamic subtest: bcs0
[333.633076] Dynamic subtest bcs0: SUCCESS (0.004s)
[333.649936] Starting dynamic subtest: vcs0
[333.653951] Dynamic subtest vcs0: SUCCESS (0.005s)
[333.666009] Starting dynamic subtest: vcs1
[333.669965] Dynamic subtest vcs1: SUCCESS (0.005s)
[333.679791] Starting dynamic subtest: vecs0
[333.683780] Dynamic subtest vecs0: SUCCESS (0.006s)
[333.693189] Starting dynamic subtest: ccs0
[333.697265] Dynamic subtest ccs0: SUCCESS (0.005s)
[333.699125] Subtest dispatch: SUCCESS (0.034s)
[335.453527] [046/132] (686s left) api_intel_bb (full-batch)
[335.510079] Starting subtest: full-batch
[335.514827] Subtest full-batch: SUCCESS (0.005s)
[335.624305] [047/132] (686s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[335.713531] Starting subtest: dsc-fractional-bpp-with-bpc
[335.744294] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[335.788550] [048/132] (686s left) gem_userptr_blits (nohangcheck)
[335.859050] Starting subtest: nohangcheck
[336.117872] Subtest nohangcheck: SUCCESS (0.256s)
[336.227468] [049/132] (686s left) i915_pm_rpm (gem-idle)
[337.754011] Starting subtest: gem-idle
[343.947686] Subtest gem-idle: SUCCESS (6.200s)
[344.286975] [050/132] (678s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[345.407517] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[345.411780] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[345.480143] [051/132] (676s left) gem_render_copy (linear)
[345.533853] Starting subtest: linear
[345.536361] Starting dynamic subtest: smem
[345.572841] Dynamic subtest smem: SUCCESS (0.039s)
[345.575284] Subtest linear: SUCCESS (0.040s)
[345.755194] [052/132] (676s left) kms_cursor_crc (cursor-onscreen-256x85)
[346.023078] Starting subtest: cursor-onscreen-256x85
[346.075651] Subtest cursor-onscreen-256x85: SKIP (0.045s)
[346.260016] [053/132] (676s left) gem_ctx_bad_destroy (invalid-default-ctx)
[346.318060] Starting subtest: invalid-default-ctx
[346.320535] Subtest invalid-default-ctx: SUCCESS (0.000s)
[346.396418] [054/132] (676s left) kms_plane (plane-position-hole)
[346.499305] Starting subtest: plane-position-hole
[347.040418] Starting dynamic subtest: pipe-A-plane-1
[348.365054] Dynamic subtest pipe-A-plane-1: SUCCESS (1.324s)
[348.375308] Starting dynamic subtest: pipe-A-plane-2
[349.732550] Dynamic subtest pipe-A-plane-2: SUCCESS (1.366s)
[349.742752] Starting dynamic subtest: pipe-A-plane-3
[351.033908] Dynamic subtest pipe-A-plane-3: SUCCESS (1.302s)
[351.045741] Starting dynamic subtest: pipe-A-plane-4
[352.362878] Dynamic subtest pipe-A-plane-4: SUCCESS (1.326s)
[352.373601] Starting dynamic subtest: pipe-A-plane-5
[352.387543] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[353.590917] Starting dynamic subtest: pipe-B-plane-1
[354.938702] Dynamic subtest pipe-B-plane-1: SUCCESS (1.354s)
[354.949831] Starting dynamic subtest: pipe-B-plane-2
[356.220619] Dynamic subtest pipe-B-plane-2: SUCCESS (1.282s)
[356.237195] Starting dynamic subtest: pipe-B-plane-3
[357.454884] Dynamic subtest pipe-B-plane-3: SUCCESS (1.233s)
[357.465593] Starting dynamic subtest: pipe-B-plane-4
[358.705480] Dynamic subtest pipe-B-plane-4: SUCCESS (1.247s)
[358.717212] Starting dynamic subtest: pipe-B-plane-5
[358.729954] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[358.732598] Subtest plane-position-hole: SUCCESS (12.229s)
[359.521123] [055/132] (663s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[359.616680] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[359.620905] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[359.712617] [056/132] (662s left) i915_drm_fdinfo (busy)
[359.749052] Starting subtest: busy
[359.751035] Starting dynamic subtest: rcs0
[359.772048] Dynamic subtest rcs0: SKIP (0.023s)
[359.784876] Starting dynamic subtest: bcs0
[359.789165] Dynamic subtest bcs0: SKIP (0.000s)
[359.798919] Starting dynamic subtest: vcs0
[359.803395] Dynamic subtest vcs0: SKIP (0.000s)
[359.812827] Starting dynamic subtest: vcs1
[359.816917] Dynamic subtest vcs1: SKIP (0.000s)
[359.826255] Starting dynamic subtest: vecs0
[359.830323] Dynamic subtest vecs0: SKIP (0.000s)
[359.839741] Starting dynamic subtest: ccs0
[359.843903] Dynamic subtest ccs0: SKIP (0.000s)
[359.847887] Subtest busy: SKIP (0.027s)
[359.886177] [057/132] (662s left) gem_mmap_gtt (fault-concurrent)
[359.952995] Subtest fault-concurrent: SKIP (0.000s)
[360.012154] [058/132] (662s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[360.100844] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[360.112286] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[360.215454] [059/132] (662s left) kms_atomic_transition (modeset-transition)
[360.320671] Starting subtest: modeset-transition
[360.322991] Starting dynamic subtest: 1x-outputs
[371.153460] Dynamic subtest 1x-outputs: SUCCESS (10.834s)
[371.156032] Subtest modeset-transition: SUCCESS (10.835s)
[372.027785] [060/132] (650s left) i915_query (test-query-geometry-subslices)
[372.084146] Starting subtest: test-query-geometry-subslices
[372.086050] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[372.195390] [061/132] (650s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[372.582057] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[373.415047] [062/132] (649s left) gem_mmap_gtt (medium-copy-odd)
[373.479782] Subtest medium-copy-odd: SKIP (0.000s)
[373.531071] [063/132] (649s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[373.616213] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[373.618450] Starting dynamic subtest: pipe-A-eDP-1
[373.642727] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[373.656195] Starting dynamic subtest: pipe-B-eDP-1
[373.676944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[373.686715] Starting dynamic subtest: pipe-C-eDP-1
[373.707806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[373.717654] Starting dynamic subtest: pipe-D-eDP-1
[373.740051] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[373.744456] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[375.808978] [064/132] (647s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[375.904502] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[382.685795] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.786s)
[382.826663] [065/132] (640s left) kms_psr (psr-sprite-plane-onoff)
[382.917524] Starting subtest: psr-sprite-plane-onoff
[382.919743] Starting dynamic subtest: eDP-1
[384.663739] Dynamic subtest eDP-1: SUCCESS (1.746s)
[384.666066] Subtest psr-sprite-plane-onoff: SUCCESS (1.748s)
[385.496377] [066/132] (637s left) kms_chamelium_color (ctm-0-75)
[385.589470] Subtest ctm-0-75: SKIP (0.000s)
[385.634934] [067/132] (637s left) fbdev (nullptr)
[385.676233] Starting subtest: nullptr
[385.678410] Subtest nullptr: SUCCESS (0.000s)
[385.743625] [068/132] (637s left) gem_mmap_offset (partial-unmap)
[385.807213] Starting subtest: partial-unmap
[385.809457] Starting dynamic subtest: smem0
[386.314091] Dynamic subtest smem0: SUCCESS (0.506s)
[386.316774] Subtest partial-unmap: SUCCESS (0.507s)
[386.435921] [069/132] (636s left) kms_flip (2x-flip-vs-fences)
[386.534221] Starting subtest: 2x-flip-vs-fences
[386.538664] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[386.634584] [070/132] (636s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[386.692522] Starting subtest: multi-wait-available-unsubmitted-submitted
[386.694887] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[386.791098] [071/132] (636s left) kms_selftest (drm_dp_mst_helper)
[386.833859] Starting subtest: drm_dp_mst_helper
[386.868503] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[386.978744] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.109s)
[386.990329] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[387.097847] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.121s)
[387.108235] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[387.198303] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.098s)
[387.200255] Subtest drm_dp_mst_helper: SUCCESS (0.362s)
[387.363488] [072/132] (635s left) syncobj_timeline (wait-for-submit-snapshot)
[387.410939] Starting subtest: wait-for-submit-snapshot
[387.491993] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[387.571432] [073/132] (635s left) prime_vgem (basic-fence-flip)
[387.645020] Starting subtest: basic-fence-flip
[387.933248] Subtest basic-fence-flip: SUCCESS (0.292s)
[388.027616] [074/132] (635s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[388.124445] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[389.257915] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.134s)
[389.394793] [075/132] (634s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[389.493786] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[389.521256] Starting dynamic subtest: pipe-A-plane-0
[389.821205] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[389.831755] Starting dynamic subtest: pipe-A-plane-3
[390.065322] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[390.075626] Starting dynamic subtest: pipe-A-plane-5
[390.079622] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[391.189932] Starting dynamic subtest: pipe-B-plane-0
[391.481299] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[391.491840] Starting dynamic subtest: pipe-B-plane-3
[391.715203] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[391.729041] Starting dynamic subtest: pipe-B-plane-5
[391.733623] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[392.025026] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.531s)
[392.863599] [076/132] (630s left) gem_exec_balancer (invalid-balancer)
[392.920567] Starting subtest: invalid-balancer
[393.848484] Subtest invalid-balancer: SUCCESS (0.926s)
[394.133601] [077/132] (629s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[394.222172] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[394.226304] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[394.295977] [078/132] (629s left) kms_psr (fbc-pr-sprite-blt)
[394.391744] Starting subtest: fbc-pr-sprite-blt
[394.396119] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[394.463629] [079/132] (629s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[394.523783] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[394.633080] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[394.711537] [080/132] (628s left) kms_flip (nonexisting-fb-interruptible)
[394.800594] Starting subtest: nonexisting-fb-interruptible
[394.802797] Starting dynamic subtest: A-eDP1
[395.959683] Dynamic subtest A-eDP1: SUCCESS (1.158s)
[395.973772] Starting dynamic subtest: B-eDP1
[397.089783] Dynamic subtest B-eDP1: SUCCESS (1.128s)
[397.103628] Starting dynamic subtest: C-eDP1
[398.224932] Dynamic subtest C-eDP1: SUCCESS (1.133s)
[398.236723] Starting dynamic subtest: D-eDP1
[399.354484] Dynamic subtest D-eDP1: SUCCESS (1.129s)
[399.356919] Subtest nonexisting-fb-interruptible: SUCCESS (4.558s)
[400.537579] [081/132] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[400.637399] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[400.641367] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[400.731696] [082/132] (622s left) kms_joiner (basic-big-joiner)
[400.832798] Starting subtest: basic-big-joiner
[400.836971] Subtest basic-big-joiner: SKIP (0.000s)
[400.902561] [083/132] (622s left) prime_self_import (basic-llseek-size)
[400.933953] Starting subtest: basic-llseek-size
[400.949434] Subtest basic-llseek-size: SUCCESS (0.016s)
[401.069711] [084/132] (622s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[401.166549] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[401.823691] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[401.975063] [085/132] (621s left) api_intel_bb (blit-noreloc-keep-cache)
[402.024655] Starting subtest: blit-noreloc-keep-cache
[402.031638] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[402.155301] [086/132] (621s left) kms_fbcon_fbt (fbc)
[402.213082] Starting subtest: fbc
[408.552247] Subtest fbc: SUCCESS (6.342s)
[409.646647] [087/132] (614s left) gem_exec_store (cachelines)
[409.719175] Starting subtest: cachelines
[409.721561] Starting dynamic subtest: rcs0
[409.807120] Dynamic subtest rcs0: SUCCESS (0.089s)
[409.820833] Starting dynamic subtest: bcs0
[409.870611] Dynamic subtest bcs0: SUCCESS (0.062s)
[409.884764] Starting dynamic subtest: vcs0
[409.925490] Dynamic subtest vcs0: SUCCESS (0.052s)
[409.937433] Starting dynamic subtest: vcs1
[409.992994] Dynamic subtest vcs1: SUCCESS (0.066s)
[410.008914] Starting dynamic subtest: vecs0
[410.061831] Dynamic subtest vecs0: SUCCESS (0.066s)
[410.075106] Starting dynamic subtest: ccs0
[410.130780] Dynamic subtest ccs0: SUCCESS (0.067s)
[410.133376] Subtest cachelines: SUCCESS (0.415s)
[410.330788] [088/132] (613s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[410.379299] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[410.480267] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[410.571695] [089/132] (613s left) kms_dp_link_training (non-uhbr-mst)
[410.664415] Starting subtest: non-uhbr-mst
[410.672911] Subtest non-uhbr-mst: SKIP (0.000s)
[410.738122] [090/132] (613s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[410.848765] Starting subtest: flip-vs-cursor-crc-legacy
[411.540183] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.688s)
[412.395460] [091/132] (611s left) kms_properties (get_properties-sanity-atomic)
[412.496203] Starting subtest: get_properties-sanity-atomic
[412.498445] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[412.571781] [092/132] (611s left) gem_lmem_swapping (verify-random-ccs)
[412.617210] Subtest verify-random-ccs: SKIP (0.000s)
[412.667702] [093/132] (611s left) kms_vrr (seamless-rr-switch-virtual)
[412.757246] Starting subtest: seamless-rr-switch-virtual
[412.763675] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[412.831759] [094/132] (611s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[412.930421] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[412.932679] Starting dynamic subtest: pipe-A-eDP-1
[412.990332] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[413.001187] Starting dynamic subtest: pipe-B-eDP-1
[413.058727] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[413.070939] Starting dynamic subtest: pipe-C-eDP-1
[413.130145] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[413.144989] Starting dynamic subtest: pipe-D-eDP-1
[413.202646] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[413.206804] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[415.259506] [095/132] (608s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[415.403590] Starting subtest: dp-mst-type-0-suspend-resume
[415.407905] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[415.522196] [096/132] (608s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[415.622208] Starting subtest: yf-tiled-64bpp-rotate-180
[415.626695] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[415.727724] [097/132] (608s left) gem_exec_schedule (implicit-read-write)
[415.800607] Starting subtest: implicit-read-write
[415.802507] Starting dynamic subtest: rcs0
[415.905571] Dynamic subtest rcs0: SUCCESS (0.115s)
[415.923669] Starting dynamic subtest: vcs0
[415.989332] Dynamic subtest vcs0: SUCCESS (0.083s)
[416.004808] Starting dynamic subtest: vcs1
[416.072008] Dynamic subtest vcs1: SUCCESS (0.083s)
[416.085277] Starting dynamic subtest: vecs0
[416.150975] Dynamic subtest vecs0: SUCCESS (0.077s)
[416.165021] Starting dynamic subtest: ccs0
[416.246956] Dynamic subtest ccs0: SUCCESS (0.096s)
[416.249726] Subtest implicit-read-write: SUCCESS (0.457s)
[417.499212] [098/132] (606s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[417.591570] Starting subtest: primary-y-tiled-reflect-x-0
[417.661764] Subtest primary-y-tiled-reflect-x-0: SKIP (0.070s)
[417.764456] [099/132] (606s left) syncobj_timeline (wait-all-delayed-signal)
[417.818922] Starting subtest: wait-all-delayed-signal
[417.924433] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[418.002186] [100/132] (606s left) kms_flip (basic-flip-vs-wf_vblank)
[418.106306] Starting subtest: basic-flip-vs-wf_vblank
[418.108570] Starting dynamic subtest: A-eDP1
[420.016452] Dynamic subtest A-eDP1: SUCCESS (1.909s)
[420.029068] Starting dynamic subtest: B-eDP1
[421.950930] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[421.964777] Starting dynamic subtest: C-eDP1
[423.863988] Dynamic subtest C-eDP1: SUCCESS (1.908s)
[423.877019] Starting dynamic subtest: D-eDP1
[425.797541] Dynamic subtest D-eDP1: SUCCESS (1.933s)
[425.799704] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.692s)
[427.028600] [101/132] (597s left) gem_exec_reloc (basic-gtt-read-noreloc)
[427.090080] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[427.166652] [102/132] (597s left) gem_lmem_swapping (heavy-random)
[427.210574] Subtest heavy-random: SKIP (0.000s)
[427.256604] [103/132] (597s left) prime_self_import (basic-with_fd_dup)
[427.290930] Starting subtest: basic-with_fd_dup
[427.303230] Subtest basic-with_fd_dup: SUCCESS (0.018s)
[427.407809] [104/132] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[427.500559] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[427.504642] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[427.597958] [105/132] (597s left) gem_softpin (safe-alignment)
[427.654936] Starting subtest: safe-alignment
[427.675641] Subtest safe-alignment: SUCCESS (0.020s)
[429.470582] [106/132] (595s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[429.558104] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[429.560276] Starting dynamic subtest: pipe-A-eDP-1
[429.583985] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.597414] Starting dynamic subtest: pipe-B-eDP-1
[429.619331] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.629867] Starting dynamic subtest: pipe-C-eDP-1
[429.651864] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.662735] Starting dynamic subtest: pipe-D-eDP-1
[429.685054] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[429.689227] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[431.812758] [107/132] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[431.919431] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[431.923729] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[432.020227] [108/132] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[432.116016] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[432.120234] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[432.217096] [109/132] (592s left) gem_pxp (reject-modify-context-protection-off-1)
[432.344036] Starting subtest: reject-modify-context-protection-off-1
[432.346812] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[432.458564] [110/132] (592s left) gem_exec_fence (syncobj-channel)
[432.901762] Starting subtest: syncobj-channel
[433.919351] Subtest syncobj-channel: SUCCESS (1.016s)
[434.512423] [111/132] (590s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[434.570838] Starting subtest: multi-wait-all-for-submit-signaled
[434.573185] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[434.680222] [112/132] (590s left) kms_getfb (getfb2-into-addfb2)
[434.773258] Starting subtest: getfb2-into-addfb2
[434.775521] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[434.869136] [113/132] (590s left) dumb_buffer (create-clear)
[434.921493] Starting subtest: create-clear
[469.234646] Subtest create-clear: SUCCESS (34.310s)
[469.329165] [114/132] (555s left) kms_addfb_basic (bad-pitch-63)
[469.383103] Starting subtest: bad-pitch-63
[469.385432] Subtest bad-pitch-63: SUCCESS (0.000s)
[469.527255] [115/132] (555s left) gem_exec_async (forked-writes)
[469.590286] Starting subtest: forked-writes
[469.592787] Starting dynamic subtest: rcs0
[469.617318] Dynamic subtest rcs0: SUCCESS (0.027s)
[469.630760] Starting dynamic subtest: bcs0
[469.639007] Dynamic subtest bcs0: SUCCESS (0.021s)
[469.650547] Starting dynamic subtest: vcs0
[469.659649] Dynamic subtest vcs0: SUCCESS (0.020s)
[469.672209] Starting dynamic subtest: vcs1
[469.680609] Dynamic subtest vcs1: SUCCESS (0.020s)
[469.692302] Starting dynamic subtest: vecs0
[469.703316] Dynamic subtest vecs0: SUCCESS (0.022s)
[469.715416] Starting dynamic subtest: ccs0
[469.724795] Dynamic subtest ccs0: SUCCESS (0.021s)
[469.726999] Subtest forked-writes: SUCCESS (0.135s)
[469.960783] [116/132] (555s left) syncobj_wait (wait-for-submit-snapshot)
[470.007193] Starting subtest: wait-for-submit-snapshot
[470.087695] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[470.180267] [117/132] (555s left) kms_psr2_su (frontbuffer-xrgb8888)
[470.229884] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[470.302784] [118/132] (554s left) gem_exec_schedule (u-submit-early-slice)
[470.364204] Starting subtest: u-submit-early-slice
[470.366554] Starting dynamic subtest: rcs0
[470.402831] Dynamic subtest rcs0: SUCCESS (0.045s)
[470.417470] Starting dynamic subtest: bcs0
[470.444346] Dynamic subtest bcs0: SUCCESS (0.041s)
[470.459208] Starting dynamic subtest: vcs0
[470.488060] Dynamic subtest vcs0: SUCCESS (0.043s)
[470.498902] Starting dynamic subtest: vcs1
[470.531415] Dynamic subtest vcs1: SUCCESS (0.043s)
[470.542439] Starting dynamic subtest: vecs0
[470.576994] Dynamic subtest vecs0: SUCCESS (0.045s)
[470.588199] Starting dynamic subtest: ccs0
[470.619067] Dynamic subtest ccs0: SUCCESS (0.041s)
[470.621299] Subtest u-submit-early-slice: SUCCESS (0.262s)
[472.531634] [119/132] (552s left) prime_busy (hang)
[472.587784] Starting subtest: hang
[472.590202] Starting dynamic subtest: rcs0
[498.955388] Dynamic subtest rcs0: SUCCESS (26.369s)
[498.966201] Starting dynamic subtest: bcs0
[506.051800] Dynamic subtest bcs0: SUCCESS (7.095s)
[506.064119] Starting dynamic subtest: vcs0
[513.088615] Dynamic subtest vcs0: SUCCESS (7.037s)
[513.101601] Starting dynamic subtest: vcs1
[520.063988] Dynamic subtest vcs1: SUCCESS (6.979s)
[520.078157] Starting dynamic subtest: vecs0
[527.036484] Dynamic subtest vecs0: SUCCESS (6.973s)
[527.050604] Starting dynamic subtest: ccs0
[540.935567] Dynamic subtest ccs0: SUCCESS (13.901s)
[540.938645] Subtest hang: SUCCESS (68.362s)
[541.053650] [120/132] (484s left) gem_ccs (suspend-resume)
[541.106311] Starting subtest: suspend-resume
[541.110871] Subtest suspend-resume: SKIP (0.000s)
[541.211769] [121/132] (484s left) kms_cursor_edge_walk (256x256-right-edge)
[541.316874] Starting subtest: 256x256-right-edge
[541.319245] Starting dynamic subtest: pipe-A-eDP-1
[544.742311] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[544.754780] Starting dynamic subtest: pipe-D-eDP-1
[547.864398] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[547.866254] Subtest 256x256-right-edge: SUCCESS (6.546s)
[548.674080] [122/132] (476s left) gem_pread (self)
[548.738894] Subtest self: SKIP (0.000s)
[548.803892] [123/132] (476s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[548.905114] Starting subtest: yf-tiled-32bpp-rotate-0
[548.909327] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[549.004740] [124/132] (476s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[549.103866] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[549.107893] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[549.204101] [125/132] (476s left) gem_exec_flush (basic-wb-set-default)
[549.262809] Starting subtest: basic-wb-set-default
[554.723697] Subtest basic-wb-set-default: SUCCESS (5.460s)
[554.923368] [126/132] (470s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[555.037416] Starting subtest: fbc-modesetfrombusy
[558.830996] Subtest fbc-modesetfrombusy: SUCCESS (3.796s)
[560.007413] [127/132] (465s left) gem_ctx_create (basic-files)
[560.067370] Starting subtest: basic-files
[562.079338] Subtest basic-files: SUCCESS (2.011s)
[563.496870] [128/132] (462s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[563.598065] Starting subtest: plane-lut1d-pre-ctm3x4
[563.744636] Starting dynamic subtest: pipe-A-plane-0
[563.910874] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[563.922399] Starting dynamic subtest: pipe-A-plane-1
[564.088768] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[564.101499] Starting dynamic subtest: pipe-A-plane-2
[564.244643] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[565.501295] Starting dynamic subtest: pipe-B-plane-0
[565.692206] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[565.703258] Starting dynamic subtest: pipe-B-plane-1
[565.847346] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[565.863890] Starting dynamic subtest: pipe-B-plane-2
[566.003656] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[567.211041] Starting dynamic subtest: pipe-C-plane-0
[567.367456] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[567.378903] Starting dynamic subtest: pipe-C-plane-1
[567.511894] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[567.523879] Starting dynamic subtest: pipe-C-plane-2
[567.645265] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[568.873570] Starting dynamic subtest: pipe-D-plane-0
[568.997466] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[569.009095] Starting dynamic subtest: pipe-D-plane-1
[569.142313] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[569.153343] Starting dynamic subtest: pipe-D-plane-2
[569.275805] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[569.562637] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.964s)
[570.413073] [129/132] (455s left) syncobj_timeline (invalid-wait-bad-flags)
[570.475541] Starting subtest: invalid-wait-bad-flags
[570.478081] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[570.576506] [130/132] (455s left) gem_exec_schedule (lateslice)
[570.646352] Starting subtest: lateslice
[570.648659] Starting dynamic subtest: rcs0
[570.656602] Dynamic subtest rcs0: SUCCESS (0.022s)
[570.670188] Starting dynamic subtest: bcs0
[570.674737] Dynamic subtest bcs0: SUCCESS (0.017s)
[570.685824] Starting dynamic subtest: vcs0
[570.694254] Dynamic subtest vcs0: SUCCESS (0.019s)
[570.706913] Starting dynamic subtest: vcs1
[570.714193] Dynamic subtest vcs1: SUCCESS (0.019s)
[570.724952] Starting dynamic subtest: vecs0
[570.731964] Dynamic subtest vecs0: SUCCESS (0.017s)
[570.742318] Starting dynamic subtest: ccs0
[570.749346] Dynamic subtest ccs0: SUCCESS (0.017s)
[570.751561] Subtest lateslice: SUCCESS (0.115s)
[572.493692] [131/132] (453s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[572.555746] Starting subtest: y-tiled-to-vebox-yf-tiled
[572.560309] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[572.750106] [132/132] (453s left) gem_exec_reloc (basic-range)
[572.806418] Subtest basic-range: SKIP (0.000s)
[572.880852] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_busy
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: gem_ctx_bad_destroy
results: parsing output: 4/ for test: gem_mmap
results: parsing output: 5/ for test: i915_hangman
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_lease
results: parsing output: 9/ for test: kms_chamelium_edid
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ppgtt
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_pm_dc
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: i915_query
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: gem_ctx_isolation
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: kms_force_connector_basic
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: gem_exec_endless
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_dsc
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: gem_ctx_bad_destroy
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_drm_fdinfo
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_atomic_transition
results: parsing output: 59/ for test: i915_query
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_chamelium_color
results: parsing output: 66/ for test: fbdev
results: parsing output: 67/ for test: gem_mmap_offset
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_selftest
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_joiner
results: parsing output: 82/ for test: prime_self_import
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: kms_fbcon_fbt
results: parsing output: 86/ for test: gem_exec_store
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_dp_link_training
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: gem_lmem_swapping
results: parsing output: 92/ for test: kms_vrr
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: gem_lmem_swapping
results: parsing output: 102/ for test: prime_self_import
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_pxp
results: parsing output: 109/ for test: gem_exec_fence
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_getfb
results: parsing output: 112/ for test: dumb_buffer
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: gem_exec_async
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_psr2_su
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: prime_busy
results: parsing output: 119/ for test: gem_ccs
results: parsing output: 120/ for test: kms_cursor_edge_walk
results: parsing output: 121/ for test: gem_pread
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_ctx_create
results: parsing output: 127/ for test: kms_color_pipeline
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: gem_exec_reloc
Done.