[58.912392] Initializing watchdogs
[58.912433]   /dev/watchdog0
[58.926596] [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]
[58.931319] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.934098] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.937529] [001/133] (960s left) kms_invalid_mode (zero-hdisplay)
[59.051261] Starting subtest: zero-hdisplay
[59.053535] Starting dynamic subtest: pipe-A-eDP-1
[59.340109] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[59.348217] Starting dynamic subtest: pipe-B-eDP-1
[59.350168] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[59.356611] Starting dynamic subtest: pipe-C-eDP-1
[59.358575] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[59.365181] Starting dynamic subtest: pipe-D-eDP-1
[59.367307] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[59.370222] Subtest zero-hdisplay: SUCCESS (0.292s)
[60.200492] [002/133] (959s left) gem_ccs (block-multicopy-inplace)
[60.267375] Starting subtest: block-multicopy-inplace
[60.272050] Subtest block-multicopy-inplace: SKIP (0.000s)
[60.363297] [003/133] (959s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[60.414261] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[60.471559] [004/133] (959s left) prime_mmap (test_correct)
[60.515705] Starting subtest: test_correct
[60.517857] Starting dynamic subtest: test_correct-smem
[60.546373] Dynamic subtest test_correct-smem: SUCCESS (0.032s)
[60.548598] Subtest test_correct: SUCCESS (0.033s)
[60.646784] [005/133] (958s left) dmabuf_sync_file (export-multiwait)
[60.716018] Starting subtest: export-multiwait
[60.717963] Subtest export-multiwait: SUCCESS (0.001s)
[60.769635] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[60.772951] [006/133] (958s left) kms_busy (extended-modeset-hang-oldfb)
[60.872326] Starting subtest: extended-modeset-hang-oldfb
[60.874710] Starting dynamic subtest: pipe-A
[72.683836] Dynamic subtest pipe-A: SUCCESS (11.808s)
[72.694463] Starting dynamic subtest: pipe-D
[84.954557] Dynamic subtest pipe-D: SUCCESS (12.269s)
[84.957015] Subtest extended-modeset-hang-oldfb: SUCCESS (24.081s)
[85.748190] [007/133] (933s left) gem_exec_fence (syncobj-invalid-flags)
[86.173980] Starting subtest: syncobj-invalid-flags
[86.176573] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[87.909990] [008/133] (931s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[87.971643] Starting subtest: multi-wait-available-submitted-signaled
[87.973931] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[88.066565] [009/133] (931s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[88.164888] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[88.167239] Starting dynamic subtest: pipe-A-default-mode
[89.331878] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[89.336548] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.166s)
[89.469605] [010/133] (930s left) kms_cursor_crc (cursor-onscreen-128x42)
[89.695271] Starting subtest: cursor-onscreen-128x42
[89.742305] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[89.968133] [011/133] (929s left) perf_pmu (all-busy-idle-check-all)
[90.019746] Starting subtest: all-busy-idle-check-all
[91.927060] Subtest all-busy-idle-check-all: SUCCESS (1.906s)
[92.020035] [012/133] (927s left) gen7_exec_parse (chained-batch)
[92.070959] Subtest chained-batch: SKIP (0.000s)
[92.133571] [013/133] (927s left) sriov_basic (enable-vfs-bind-unbind-each)
[92.190976] Starting subtest: enable-vfs-bind-unbind-each
[92.192924] Starting dynamic subtest: numvfs-1
[92.265450] Dynamic subtest numvfs-1: FAIL (0.016s)
[92.276426] Starting dynamic subtest: numvfs-2
[92.351054] Dynamic subtest numvfs-2: FAIL (0.004s)
[92.363762] Starting dynamic subtest: numvfs-3
[92.439361] Dynamic subtest numvfs-3: FAIL (0.003s)
[92.448255] Starting dynamic subtest: numvfs-4
[92.520822] Dynamic subtest numvfs-4: FAIL (0.003s)
[92.529613] Starting dynamic subtest: numvfs-5
[92.602329] Dynamic subtest numvfs-5: FAIL (0.004s)
[92.611896] Starting dynamic subtest: numvfs-6
[92.684786] Dynamic subtest numvfs-6: FAIL (0.003s)
[92.693618] Starting dynamic subtest: numvfs-7
[92.767253] Dynamic subtest numvfs-7: FAIL (0.004s)
[92.777117] Starting dynamic subtest: numvfs-random
[92.850610] Dynamic subtest numvfs-random: FAIL (0.003s)
[92.852999] Subtest enable-vfs-bind-unbind-each: FAIL (0.042s)
[92.926276] [014/133] (927s left) gem_mmap_gtt (basic-small-copy-odd)
[92.979099] Subtest basic-small-copy-odd: SKIP (0.000s)
[93.043876] [015/133] (926s left) kms_frontbuffer_tracking (psr-2p-rte)
[93.156566] Starting subtest: psr-2p-rte
[93.159789] Subtest psr-2p-rte: SKIP (0.000s)
[93.258202] [016/133] (926s left) syncobj_wait (multi-wait-for-submit-signaled)
[93.304994] Starting subtest: multi-wait-for-submit-signaled
[93.307107] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[93.388746] [017/133] (926s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[93.485784] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[94.290044] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.805s)
[94.446723] [018/133] (925s left) kms_psr (psr-cursor-plane-onoff)
[94.553760] Starting subtest: psr-cursor-plane-onoff
[94.556096] Starting dynamic subtest: eDP-1
[96.279600] Dynamic subtest eDP-1: SUCCESS (1.726s)
[96.282040] Subtest psr-cursor-plane-onoff: SUCCESS (1.727s)
[97.156179] [019/133] (923s left) gem_exec_flush (basic-uc-ro-default)
[97.222463] Starting subtest: basic-uc-ro-default
[102.679422] Subtest basic-uc-ro-default: SUCCESS (5.458s)
[102.878354] [020/133] (917s left) vgem_basic (mmap)
[102.942246] Starting subtest: mmap
[102.955093] Subtest mmap: SUCCESS (0.015s)
[103.008958] [021/133] (917s left) kms_plane_multiple (tiling-y)
[103.095568] Starting subtest: tiling-y
[103.099600] Subtest tiling-y: SKIP (0.000s)
[103.167403] [022/133] (917s left) kms_properties (get_properties-sanity-atomic)
[103.270280] Starting subtest: get_properties-sanity-atomic
[103.272610] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[103.344369] [023/133] (917s left) kms_psr (fbc-pr-dpms)
[103.439296] Starting subtest: fbc-pr-dpms
[103.443533] Subtest fbc-pr-dpms: SKIP (0.000s)
[103.520711] [024/133] (916s left) kms_cursor_crc (cursor-sliding-64x64)
[103.690690] Starting subtest: cursor-sliding-64x64
[103.695389] Starting dynamic subtest: pipe-A-eDP-1
[106.913296] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.218s)
[106.940139] Starting dynamic subtest: pipe-D-eDP-1
[110.805280] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.870s)
[110.807650] Subtest cursor-sliding-64x64: SUCCESS (7.113s)
[111.602513] [025/133] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[111.706244] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[111.710225] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[111.794434] [026/133] (908s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[111.888602] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[111.892736] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[111.980513] [027/133] (908s left) gem_exec_schedule (fifo)
[112.051550] Starting subtest: fifo
[112.053862] Starting dynamic subtest: rcs0
[112.139454] Dynamic subtest rcs0: SUCCESS (0.098s)
[112.149474] Starting dynamic subtest: vcs0
[112.219349] Dynamic subtest vcs0: SUCCESS (0.079s)
[112.230086] Starting dynamic subtest: vcs1
[112.303038] Dynamic subtest vcs1: SUCCESS (0.083s)
[112.314132] Starting dynamic subtest: vecs0
[112.376608] Dynamic subtest vecs0: SUCCESS (0.073s)
[112.386755] Starting dynamic subtest: ccs0
[112.455699] Dynamic subtest ccs0: SUCCESS (0.078s)
[112.458766] Subtest fifo: SUCCESS (0.413s)
[113.959083] [028/133] (906s left) kms_addfb_basic (addfb25-4-tiled)
[114.053503] Starting subtest: addfb25-4-tiled
[114.055834] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[114.150295] [029/133] (906s left) kms_rotation_crc (primary-rotation-180)
[114.242280] Starting subtest: primary-rotation-180
[121.143177] Subtest primary-rotation-180: SUCCESS (6.901s)
[122.361085] [030/133] (898s left) kms_color (ctm-negative)
[122.458083] Starting subtest: ctm-negative
[122.460399] Starting dynamic subtest: pipe-A-eDP-1
[123.203847] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[123.216186] Starting dynamic subtest: pipe-B-eDP-1
[124.599526] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[124.608900] Starting dynamic subtest: pipe-C-eDP-1
[125.940492] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.339s)
[125.949704] Starting dynamic subtest: pipe-D-eDP-1
[127.269403] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[127.271432] Subtest ctm-negative: SUCCESS (4.810s)
[128.067311] [031/133] (892s left) kms_psr (psr-sprite-plane-move)
[128.170072] Starting subtest: psr-sprite-plane-move
[128.172534] Starting dynamic subtest: eDP-1
[129.899085] Dynamic subtest eDP-1: SUCCESS (1.729s)
[129.901440] Subtest psr-sprite-plane-move: SUCCESS (1.729s)
[130.730291] [032/133] (889s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[130.828321] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[130.832690] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[130.928565] [033/133] (889s left) gem_exec_schedule (preempt-engines)
[131.001913] Starting subtest: preempt-engines
[131.004243] Starting dynamic subtest: rcs0
[133.306761] Dynamic subtest rcs0: SUCCESS (2.303s)
[133.319719] Starting dynamic subtest: bcs0
[135.549077] Dynamic subtest bcs0: SUCCESS (2.241s)
[135.561431] Starting dynamic subtest: vcs0
[137.830583] Dynamic subtest vcs0: SUCCESS (2.280s)
[137.843751] Starting dynamic subtest: vcs1
[140.179534] Dynamic subtest vcs1: SUCCESS (2.347s)
[140.189122] Starting dynamic subtest: vecs0
[142.446941] Dynamic subtest vecs0: SUCCESS (2.267s)
[142.458292] Starting dynamic subtest: ccs0
[144.738611] Dynamic subtest ccs0: SUCCESS (2.290s)
[144.740847] Subtest preempt-engines: SUCCESS (13.736s)
[145.033513] [034/133] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[145.139078] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[145.143256] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[145.229814] [035/133] (875s left) kms_psr (fbc-psr2-sprite-plane-move)
[145.321884] Starting subtest: fbc-psr2-sprite-plane-move
[145.324156] Starting dynamic subtest: eDP-1
[145.328601] Dynamic subtest eDP-1: SKIP (0.000s)
[145.333113] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[145.405584] [036/133] (875s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[145.508188] Starting subtest: plane-upscale-20x20-with-pixel-format
[145.510585] Starting dynamic subtest: pipe-A
[146.555065] Dynamic subtest pipe-A: SUCCESS (1.050s)
[146.562523] Starting dynamic subtest: pipe-B
[148.726497] Dynamic subtest pipe-B: SUCCESS (2.171s)
[148.734400] Starting dynamic subtest: pipe-C
[149.916063] Dynamic subtest pipe-C: SUCCESS (1.188s)
[149.925763] Starting dynamic subtest: pipe-D
[151.061510] Dynamic subtest pipe-D: SUCCESS (1.144s)
[151.063813] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.556s)
[152.262722] [037/133] (868s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[152.363294] Starting subtest: pr-overlay-plane-move-continuous-sf
[152.367277] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[152.443226] [038/133] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[152.548980] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[161.074328] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.528s)
[161.188370] [039/133] (859s left) gem_softpin (evict-snoop-interruptible)
[161.252657] Starting subtest: evict-snoop-interruptible
[161.257316] Subtest evict-snoop-interruptible: SKIP (0.000s)
[161.379177] [040/133] (859s left) gem_create (create-ext-placement-each)
[161.557709] Starting subtest: create-ext-placement-each
[161.560066] Subtest create-ext-placement-each: SUCCESS (0.000s)
[161.640771] [041/133] (859s left) kms_content_protection (atomic-dpms)
[161.783434] Starting subtest: atomic-dpms
[161.788345] Subtest atomic-dpms: SKIP (0.000s)
[161.910246] [042/133] (859s left) kms_vblank (wait-idle)
[162.003033] Starting subtest: wait-idle
[162.004953] Starting dynamic subtest: pipe-A-eDP-1
[163.758065] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[163.772404] Starting dynamic subtest: pipe-D-eDP-1
[166.228455] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.468s)
[166.230365] Subtest wait-idle: SUCCESS (4.225s)
[167.046431] [043/133] (854s left) kms_pm_backlight (basic-brightness)
[167.146190] Starting subtest: basic-brightness
[167.194256] Starting dynamic subtest: eDP-1
[167.509473] Dynamic subtest eDP-1: SUCCESS (0.313s)
[167.512034] Subtest basic-brightness: SUCCESS (0.363s)
[168.376825] [044/133] (852s left) kms_setmode (invalid-clone-single-crtc)
[168.443611] Starting subtest: invalid-clone-single-crtc
[168.450575] Subtest invalid-clone-single-crtc: SKIP (0.001s)
[168.542802] [045/133] (852s left) kms_chamelium_frames (hdmi-crc-fast)
[168.914426] Subtest hdmi-crc-fast: SKIP (0.000s)
[169.680349] [046/133] (851s left) perf_pmu (busy)
[169.726557] Starting subtest: busy
[169.728874] Starting dynamic subtest: rcs0
[170.319918] Dynamic subtest rcs0: SUCCESS (0.594s)
[170.331130] Starting dynamic subtest: bcs0
[170.884869] Dynamic subtest bcs0: SUCCESS (0.563s)
[170.896097] Starting dynamic subtest: vcs0
[172.886487] Dynamic subtest vcs0: SUCCESS (1.998s)
[172.897916] Starting dynamic subtest: vcs1
[174.934973] Dynamic subtest vcs1: SUCCESS (2.044s)
[174.944727] Starting dynamic subtest: vecs0
[176.918460] Dynamic subtest vecs0: SUCCESS (1.981s)
[176.928518] Starting dynamic subtest: ccs0
[177.482594] Dynamic subtest ccs0: SUCCESS (0.563s)
[177.485170] Subtest busy: SUCCESS (7.758s)
[177.582514] [047/133] (843s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[177.638670] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[177.716474] [048/133] (843s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[177.818486] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[177.822853] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[177.894486] [049/133] (843s left) i915_suspend (basic-s3-without-i915)
[177.936127] Starting subtest: basic-s3-without-i915
[179.635906] Subtest basic-s3-without-i915: SKIP (1.697s)
[181.173754] [050/133] (840s left) gem_exec_balancer (parallel)
[181.448050] Starting subtest: parallel
[182.373878] Subtest parallel: SUCCESS (0.928s)
[182.976941] [051/133] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[183.095627] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[183.100036] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[183.200018] [052/133] (838s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[185.067398] Starting subtest: gem-execbuf-stress-pc8
[185.108275] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[185.493486] [053/133] (836s left) gem_exec_store (cachelines)
[185.554212] Starting subtest: cachelines
[185.556489] Starting dynamic subtest: rcs0
[185.619723] Dynamic subtest rcs0: SUCCESS (0.066s)
[185.631193] Starting dynamic subtest: bcs0
[185.678511] Dynamic subtest bcs0: SUCCESS (0.057s)
[185.695038] Starting dynamic subtest: vcs0
[185.737962] Dynamic subtest vcs0: SUCCESS (0.058s)
[185.748729] Starting dynamic subtest: vcs1
[185.793809] Dynamic subtest vcs1: SUCCESS (0.054s)
[185.804024] Starting dynamic subtest: vecs0
[185.849739] Dynamic subtest vecs0: SUCCESS (0.053s)
[185.860723] Starting dynamic subtest: ccs0
[185.899722] Dynamic subtest ccs0: SUCCESS (0.048s)
[185.902133] Subtest cachelines: SUCCESS (0.347s)
[186.110245] [054/133] (835s left) kms_sequence (queue-busy)
[186.199543] Starting subtest: queue-busy
[186.201945] Starting dynamic subtest: pipe-A-eDP-1
[188.147659] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[188.157747] Starting dynamic subtest: pipe-B-eDP-1
[190.707798] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s)
[190.717029] Starting dynamic subtest: pipe-C-eDP-1
[193.317816] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[193.326741] Starting dynamic subtest: pipe-D-eDP-1
[195.860287] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[195.862612] Subtest queue-busy: SUCCESS (9.658s)
[196.659623] [055/133] (825s left) kms_prime (d3hot)
[196.741364] Subtest D3hot: SKIP (0.000s)
[196.849440] [056/133] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[196.957189] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[203.469401] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.517s)
[203.569253] [057/133] (818s left) gem_watchdog (default-physical)
[203.649105] Starting subtest: default-physical
[205.402667] Subtest default-physical: SUCCESS (1.765s)
[205.497885] [058/133] (816s left) gem_eio (wait-wedge-10ms)
[205.686966] Starting subtest: wait-wedge-10ms
[206.941579] Subtest wait-wedge-10ms: SUCCESS (1.255s)
[207.058752] [059/133] (814s left) gem_partial_pwrite_pread (reads)
[207.113986] Subtest reads: SKIP (0.000s)
[207.202300] [060/133] (814s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[207.293635] Starting subtest: pipe-fbc-rte
[207.300262] Starting dynamic subtest: pipe-B-eDP-1
[212.737964] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.448s)
[212.745567] Subtest pipe-fbc-rte: SUCCESS (5.450s)
[215.000399] [061/133] (806s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[215.069638] Starting subtest: etime-multi-wait-available-unsubmitted
[215.177751] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s)
[215.254761] [062/133] (806s left) kms_cursor_legacy (torture-move)
[215.362343] Starting subtest: torture-move
[215.364515] Starting dynamic subtest: pipe-A
[221.455320] Dynamic subtest pipe-A: SUCCESS (6.088s)
[221.470209] Starting dynamic subtest: pipe-B
[228.503695] Dynamic subtest pipe-B: SUCCESS (7.046s)
[228.519291] Starting dynamic subtest: pipe-C
[235.272831] Dynamic subtest pipe-C: SUCCESS (6.766s)
[235.288297] Starting dynamic subtest: pipe-D
[242.406597] Dynamic subtest pipe-D: SUCCESS (7.133s)
[242.415724] Starting dynamic subtest: all-pipes
[248.951737] Dynamic subtest all-pipes: SUCCESS (6.542s)
[248.954652] Subtest torture-move: SUCCESS (33.588s)
[249.109411] [063/133] (772s left) gem_ctx_param (set-priority-range)
[249.173564] Starting subtest: set-priority-range
[249.189967] Subtest set-priority-range: SUCCESS (0.017s)
[249.303503] [064/133] (772s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[249.395580] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[254.144893] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.752s)
[255.313480] [065/133] (766s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[255.399330] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[255.401715] Starting dynamic subtest: pipe-A-eDP-1
[255.410860] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[255.424376] Starting dynamic subtest: pipe-B-eDP-1
[255.432894] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[255.444392] Starting dynamic subtest: pipe-C-eDP-1
[255.452525] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.460729] Starting dynamic subtest: pipe-D-eDP-1
[255.468799] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.472776] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[257.671193] [066/133] (764s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[257.730675] Subtest tiled-to-untiled: SKIP (0.000s)
[257.802299] [067/133] (764s left) perf (create-destroy-userspace-config)
[257.907401] Starting subtest: create-destroy-userspace-config
[257.928263] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[257.968475] [068/133] (764s left) gem_mmap_offset (bad-flags)
[258.025085] Starting subtest: bad-flags
[258.027027] Subtest bad-flags: SUCCESS (0.000s)
[258.124657] [069/133] (764s left) gem_ctx_persistence (userptr)
[258.176680] Starting subtest: userptr
[258.336626] Subtest userptr: SUCCESS (0.159s)
[258.417450] [070/133] (763s left) kms_lease (lease-invalid-connector)
[258.504425] Starting subtest: lease-invalid-connector
[258.506737] Starting dynamic subtest: pipe-A-eDP-1
[258.509014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[258.518692] Starting dynamic subtest: pipe-B-eDP-1
[258.521054] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[258.529260] Starting dynamic subtest: pipe-C-eDP-1
[258.531463] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[258.539331] Starting dynamic subtest: pipe-D-eDP-1
[258.541162] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[258.543021] Subtest lease-invalid-connector: SUCCESS (0.004s)
[258.579027] [071/133] (763s left) kms_getfb (getfb2-handle-zero)
[258.669397] Starting subtest: getfb2-handle-zero
[258.671304] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[258.763783] [072/133] (763s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[258.851484] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[258.855060] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[258.935677] [073/133] (763s left) gem_userptr_blits (unsync-overlap)
[258.996000] Subtest unsync-overlap: SKIP (0.000s)
[259.120506] [074/133] (763s left) gem_exec_flush (basic-uc-rw-default)
[259.175611] Starting subtest: basic-uc-rw-default
[264.635216] Subtest basic-uc-rw-default: SUCCESS (5.459s)
[264.824315] [075/133] (757s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[264.918304] Starting subtest: psr-2p-primscrn-cur-indfb-move
[264.922635] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[265.022657] [076/133] (757s left) gem_exec_async (forked-writes)
[265.089668] Starting subtest: forked-writes
[265.092085] Starting dynamic subtest: rcs0
[265.123916] Dynamic subtest rcs0: SUCCESS (0.034s)
[265.136481] Starting dynamic subtest: bcs0
[265.150557] Dynamic subtest bcs0: SUCCESS (0.025s)
[265.160061] Starting dynamic subtest: vcs0
[265.173532] Dynamic subtest vcs0: SUCCESS (0.022s)
[265.183603] Starting dynamic subtest: vcs1
[265.197100] Dynamic subtest vcs1: SUCCESS (0.023s)
[265.207333] Starting dynamic subtest: vecs0
[265.225159] Dynamic subtest vecs0: SUCCESS (0.027s)
[265.234518] Starting dynamic subtest: ccs0
[265.249119] Dynamic subtest ccs0: SUCCESS (0.023s)
[265.251729] Subtest forked-writes: SUCCESS (0.160s)
[265.467772] [077/133] (757s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[265.564479] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[266.521760] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.957s)
[266.666983] [078/133] (755s left) kms_plane_alpha_blend (alpha-7efc)
[266.759990] Starting subtest: alpha-7efc
[267.036449] Starting dynamic subtest: pipe-A-eDP-1
[267.639299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[267.666559] Starting dynamic subtest: pipe-D-eDP-1
[268.964307] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[268.966773] Subtest alpha-7efc: SUCCESS (2.206s)
[269.808459] [079/133] (752s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[269.930302] Starting subtest: 2x-cursor-vs-flip-atomic
[269.936450] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[270.075108] [080/133] (752s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[270.167830] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[270.194593] Starting dynamic subtest: pipe-A-plane-0
[270.617287] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[270.629143] Starting dynamic subtest: pipe-A-plane-3
[270.893976] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[270.902788] Starting dynamic subtest: pipe-A-plane-5
[270.906384] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[271.996467] Starting dynamic subtest: pipe-B-plane-0
[272.411280] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[272.420594] Starting dynamic subtest: pipe-B-plane-3
[272.668892] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[272.686891] Starting dynamic subtest: pipe-B-plane-5
[272.692049] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[272.990180] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.821s)
[273.881034] [081/133] (748s left) syncobj_timeline (single-wait-available-signaled)
[273.943220] Starting subtest: single-wait-available-signaled
[273.945328] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[274.047114] [082/133] (748s left) i915_drm_fdinfo (memory-info-purgeable)
[274.086551] Starting subtest: memory-info-purgeable
[274.088927] Starting dynamic subtest: smem0
[276.574124] Dynamic subtest smem0: SUCCESS (2.491s)
[276.576715] Subtest memory-info-purgeable: SUCCESS (2.493s)
[276.662568] [083/133] (746s left) kms_chamelium_color (ctm-max)
[276.756717] Subtest ctm-max: SKIP (0.000s)
[276.803342] [084/133] (746s left) gem_exec_reloc (basic-range-active)
[276.871049] Subtest basic-range-active: SKIP (0.000s)
[276.945343] [085/133] (745s left) perf (sysctl-defaults)
[277.015321] Starting subtest: sysctl-defaults
[277.017534] Subtest sysctl-defaults: SUCCESS (0.000s)
[277.074967] [086/133] (745s left) api_intel_allocator (open-vm)
[277.124296] Starting subtest: open-vm
[277.126214] Subtest open-vm: SUCCESS (0.003s)
[277.234853] [087/133] (745s left) gem_lmem_swapping (heavy-verify-multi)
[277.277184] Subtest heavy-verify-multi: SKIP (0.000s)
[277.318465] [088/133] (745s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[277.707043] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[278.484315] [089/133] (744s left) perf (enable-disable)
[278.566655] Starting subtest: enable-disable
[278.569055] Starting dynamic subtest: 0-rcs0
[280.805966] Dynamic subtest 0-rcs0: SUCCESS (2.237s)
[280.815067] Starting dynamic subtest: 1-vcs0
[285.283545] Dynamic subtest 1-vcs0: SUCCESS (4.476s)
[285.285998] Subtest enable-disable: SUCCESS (6.715s)
[285.333271] [090/133] (737s left) gem_exec_reloc (basic-range)
[285.408736] Subtest basic-range: SKIP (0.000s)
[285.484522] [091/133] (737s left) vgem_basic (dmabuf-fence)
[285.529688] Starting subtest: dmabuf-fence
[285.531911] Subtest dmabuf-fence: SUCCESS (0.000s)
[285.586918] [092/133] (737s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[285.681024] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[285.683293] Starting dynamic subtest: pipe-A-eDP-1
[285.705734] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.719262] Starting dynamic subtest: pipe-B-eDP-1
[285.740400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.750242] Starting dynamic subtest: pipe-C-eDP-1
[285.771849] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.779892] Starting dynamic subtest: pipe-D-eDP-1
[285.804304] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.809014] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[287.891673] [093/133] (735s left) i915_module_load (reload-no-display)
[287.925613] Starting subtest: reload-no-display
[293.743672] Subtest reload-no-display: SUCCESS (5.820s)
[293.773672] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[293.774368] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[293.777443] [094/133] (729s left) gem_exec_schedule (semaphore-power)
[295.458989] Subtest semaphore-power: SKIP (0.000s)
[295.606219] [FACT gem_exec_schedule (semaphore-power)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[295.607534] [FACT gem_exec_schedule (semaphore-power)] new: kernel.kmod_is_loaded.i915: true
[295.611285] [095/133] (727s left) kms_atomic (plane-immutable-zpos)
[295.702876] Starting subtest: plane-immutable-zpos
[295.705158] Starting dynamic subtest: pipe-A-eDP-1
[296.355964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.654s)
[296.358332] Subtest plane-immutable-zpos: SUCCESS (0.655s)
[297.239096] [096/133] (726s left) perf_pmu (render-node-busy)
[297.308917] Starting subtest: render-node-busy
[297.311373] Starting dynamic subtest: rcs0
[297.905051] Dynamic subtest rcs0: SUCCESS (0.595s)
[297.915662] Starting dynamic subtest: bcs0
[298.462546] Dynamic subtest bcs0: SUCCESS (0.556s)
[298.473684] Starting dynamic subtest: vcs0
[299.928378] Dynamic subtest vcs0: SUCCESS (1.461s)
[299.939533] Starting dynamic subtest: vcs1
[301.846386] Dynamic subtest vcs1: SUCCESS (1.915s)
[301.860855] Starting dynamic subtest: vecs0
[303.895096] Dynamic subtest vecs0: SUCCESS (2.045s)
[303.905300] Starting dynamic subtest: ccs0
[304.459985] Dynamic subtest ccs0: SUCCESS (0.559s)
[304.462753] Subtest render-node-busy: SUCCESS (7.149s)
[304.533696] [097/133] (718s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[304.631739] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[304.636082] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[304.699996] [098/133] (718s left) gem_mmap_gtt (basic-small-bo)
[304.760232] Subtest basic-small-bo: SKIP (0.000s)
[304.819314] [099/133] (718s left) gem_pxp (reject-modify-context-protection-off-2)
[304.937748] Starting subtest: reject-modify-context-protection-off-2
[304.940234] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[305.042250] [100/133] (718s left) syncobj_timeline (multi-wait-all-available-signaled)
[305.104837] Starting subtest: multi-wait-all-available-signaled
[305.107207] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[305.212592] [101/133] (718s left) kms_psr (pr-primary-render)
[305.311224] Starting subtest: pr-primary-render
[305.315291] Subtest pr-primary-render: SKIP (0.000s)
[305.382251] [102/133] (718s left) perf (short-reads)
[305.502401] Starting subtest: short-reads
[305.518586] Subtest short-reads: SUCCESS (0.016s)
[305.558650] [103/133] (718s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[305.659013] Starting subtest: 2x-absolute-wf_vblank-interruptible
[305.671328] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[305.746800] [104/133] (717s left) kms_frontbuffer_tracking (psr-suspend)
[305.855280] Starting subtest: psr-suspend
[344.338120] Subtest psr-suspend: SUCCESS (8.143s)
[344.460054] [105/133] (679s left) gem_pxp (display-protected-crc)
[344.567780] Starting subtest: display-protected-crc
[346.231081] Subtest display-protected-crc: SUCCESS (1.661s)
[346.351081] [106/133] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[346.449232] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[346.454009] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[346.549374] [107/133] (677s left) gem_workarounds (suspend-resume)
[346.614761] Starting subtest: suspend-resume
[363.089603] Subtest suspend-resume: SUCCESS (1.427s)
[363.242477] [108/133] (660s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[363.354039] Starting subtest: 4-tiled-32bpp-rotate-270
[363.373960] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[363.493067] [109/133] (660s left) kms_cursor_crc (cursor-sliding-128x42)
[363.724308] Starting subtest: cursor-sliding-128x42
[363.773939] Subtest cursor-sliding-128x42: SKIP (0.047s)
[363.962952] [110/133] (659s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[364.052382] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[364.056558] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[364.158438] [111/133] (659s left) kms_draw_crc (draw-method-mmap-cpu)
[364.243967] Starting subtest: draw-method-mmap-cpu
[364.245598] Starting dynamic subtest: xrgb8888-untiled
[364.477195] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[364.490553] Starting dynamic subtest: rgb565-untiled
[364.688511] Dynamic subtest rgb565-untiled: SUCCESS (0.209s)
[364.697620] Starting dynamic subtest: xrgb2101010-untiled
[364.900293] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[364.911584] Starting dynamic subtest: xbgr16161616f-untiled
[365.100718] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.197s)
[365.112368] Starting dynamic subtest: xrgb8888-xtiled
[365.234102] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[365.245021] Starting dynamic subtest: rgb565-xtiled
[365.356398] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[365.365525] Starting dynamic subtest: xrgb2101010-xtiled
[365.467723] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[365.476574] Starting dynamic subtest: xbgr16161616f-xtiled
[365.601373] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[365.610516] Starting dynamic subtest: xrgb8888-4tiled
[365.735039] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[365.746235] Starting dynamic subtest: rgb565-4tiled
[365.880084] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[365.890646] Starting dynamic subtest: xrgb2101010-4tiled
[366.013832] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[366.024834] Starting dynamic subtest: xbgr16161616f-4tiled
[366.158026] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.142s)
[366.159987] Subtest draw-method-mmap-cpu: SUCCESS (1.912s)
[366.257762] [112/133] (657s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[366.326196] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[366.329908] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[366.511365] [113/133] (657s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[366.609029] Starting subtest: fbc-rgb101010-draw-render
[371.198490] Subtest fbc-rgb101010-draw-render: SUCCESS (4.586s)
[372.395547] [114/133] (651s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[372.507523] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[372.509771] Starting dynamic subtest: pipe-A-eDP-1
[372.530526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[372.540682] Starting dynamic subtest: pipe-B-eDP-1
[372.560317] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[372.569398] Starting dynamic subtest: pipe-C-eDP-1
[372.588952] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[372.597679] Starting dynamic subtest: pipe-D-eDP-1
[372.617186] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[372.619386] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[374.751606] [115/133] (649s left) api_intel_bb (object-reloc-keep-cache)
[374.807418] Starting subtest: object-reloc-keep-cache
[374.811892] Subtest object-reloc-keep-cache: SKIP (0.003s)
[374.931347] [116/133] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[375.043956] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[375.048380] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[375.159790] [117/133] (649s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[375.255717] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[375.259710] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[375.354428] [118/133] (648s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[375.415778] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[375.519366] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s)
[375.597124] [119/133] (648s left) kms_flip (modeset-vs-vblank-race-interruptible)
[375.702329] Starting subtest: modeset-vs-vblank-race-interruptible
[375.704691] Starting dynamic subtest: A-eDP1
[380.357348] Dynamic subtest A-eDP1: SUCCESS (4.649s)
[380.368431] Starting dynamic subtest: B-eDP1
[384.991641] Dynamic subtest B-eDP1: SUCCESS (4.629s)
[385.006996] Starting dynamic subtest: C-eDP1
[389.618704] Dynamic subtest C-eDP1: SUCCESS (4.622s)
[389.632061] Starting dynamic subtest: D-eDP1
[394.245143] Dynamic subtest D-eDP1: SUCCESS (4.621s)
[394.250053] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.536s)
[395.406428] [120/133] (628s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[395.512325] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[395.514587] Starting dynamic subtest: pipe-A-eDP-1
[395.534531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[395.546911] Starting dynamic subtest: pipe-B-eDP-1
[395.566200] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[395.574330] Starting dynamic subtest: pipe-C-eDP-1
[395.592911] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[395.600982] Starting dynamic subtest: pipe-D-eDP-1
[395.620000] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[395.621904] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[397.771388] [121/133] (626s left) kms_addfb_basic (bad-pitch-1024)
[397.827265] Starting subtest: bad-pitch-1024
[397.829966] Subtest bad-pitch-1024: SUCCESS (0.000s)
[397.965338] [122/133] (626s left) gem_fenced_exec_thrash (too-many-fences)
[398.019798] Subtest too-many-fences: SKIP (0.000s)
[398.082008] [123/133] (626s left) kms_psr (fbc-psr2-primary-render)
[398.178597] Starting subtest: fbc-psr2-primary-render
[398.181030] Starting dynamic subtest: eDP-1
[398.185666] Dynamic subtest eDP-1: SKIP (0.000s)
[398.190246] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[398.258798] [124/133] (626s left) gem_exec_fence (expired-history)
[398.681000] Starting subtest: expired-history
[406.006533] Subtest expired-history: SUCCESS (7.322s)
[406.595474] [125/133] (617s left) gem_softpin (softpin)
[406.666286] Starting subtest: softpin
[438.964230] Subtest softpin: SUCCESS (32.277s)
[439.065188] [126/133] (585s left) gem_spin_batch (resubmit-new)
[439.128556] Starting subtest: resubmit-new
[439.130728] Starting dynamic subtest: rcs0
[439.143204] Dynamic subtest rcs0: SUCCESS (0.017s)
[439.153454] Starting dynamic subtest: bcs0
[439.155334] Dynamic subtest bcs0: SUCCESS (0.007s)
[439.165505] Starting dynamic subtest: vcs0
[439.167926] Dynamic subtest vcs0: SUCCESS (0.007s)
[439.178338] Starting dynamic subtest: vcs1
[439.181116] Dynamic subtest vcs1: SUCCESS (0.006s)
[439.190856] Starting dynamic subtest: vecs0
[439.192789] Dynamic subtest vecs0: SUCCESS (0.006s)
[439.201299] Starting dynamic subtest: ccs0
[439.203300] Dynamic subtest ccs0: SUCCESS (0.007s)
[439.205337] Subtest resubmit-new: SUCCESS (0.055s)
[440.322653] [127/133] (584s left) sysfs_defaults (readonly)
[440.381925] Starting subtest: readonly
[440.384409] Starting dynamic subtest: vecs0
[440.386831] Dynamic subtest vecs0: SUCCESS (0.000s)
[440.397049] Starting dynamic subtest: ccs0
[440.399336] Dynamic subtest ccs0: SUCCESS (0.000s)
[440.408054] Starting dynamic subtest: vcs0
[440.410341] Dynamic subtest vcs0: SUCCESS (0.000s)
[440.419347] Starting dynamic subtest: bcs0
[440.421653] Dynamic subtest bcs0: SUCCESS (0.000s)
[440.430386] Starting dynamic subtest: rcs0
[440.432687] Dynamic subtest rcs0: SUCCESS (0.000s)
[440.441515] Starting dynamic subtest: vcs1
[440.443529] Dynamic subtest vcs1: SUCCESS (0.000s)
[440.445472] Subtest readonly: SUCCESS (0.006s)
[440.517897] [128/133] (584s left) gem_ctx_param (invalid-get-engines)
[440.573290] Starting subtest: invalid-get-engines
[440.575632] Subtest invalid-get-engines: SUCCESS (0.001s)
[440.688033] [129/133] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[440.792499] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[440.796635] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[440.898581] [130/133] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[440.996421] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[441.000882] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[441.093861] [131/133] (583s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[441.198364] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[441.203065] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[441.307081] [132/133] (583s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[441.391122] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[441.394961] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[441.481222] [133/133] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[441.575768] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[441.579245] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[441.677557] Closing watchdogs
results: parsing output: 0/ for test: kms_invalid_mode
results: parsing output: 1/ for test: gem_ccs
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: prime_mmap
results: parsing output: 4/ for test: dmabuf_sync_file
results: parsing output: 5/ for test: kms_busy
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: gen7_exec_parse
results: parsing output: 12/ for test: sriov_basic
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: kms_plane_multiple
results: parsing output: 21/ for test: kms_properties
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_color
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: kms_pm_backlight
results: parsing output: 43/ for test: kms_setmode
results: parsing output: 44/ for test: kms_chamelium_frames
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: i915_suspend
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: i915_pm_rpm
results: parsing output: 52/ for test: gem_exec_store
results: parsing output: 53/ for test: kms_sequence
results: parsing output: 54/ for test: kms_prime
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_watchdog
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_partial_pwrite_pread
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_set_tiling_vs_blt
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: gem_mmap_offset
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: kms_lease
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_async
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_plane_alpha_blend
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: kms_chamelium_color
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: perf
results: parsing output: 85/ for test: api_intel_allocator
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: kms_chamelium_hpd
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: vgem_basic
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: i915_module_load
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_atomic
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_workarounds
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: gem_fenced_exec_thrash
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: gem_spin_batch
results: parsing output: 126/ for test: sysfs_defaults
results: parsing output: 127/ for test: gem_ctx_param
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.