[56.985369] Initializing watchdogs
[56.985414]   /dev/watchdog0
[56.999993] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.004714] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.007479] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.010698] [001/133] (960s left) gem_bad_reloc (negative-reloc-bltcopy)
[57.090091] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[57.160713] [002/133] (960s left) gem_ctx_persistence (engines-hostile-preempt)
[57.226985] Starting subtest: engines-hostile-preempt
[57.229048] Starting dynamic subtest: rcs0
[57.321890] Dynamic subtest rcs0: SUCCESS (0.097s)
[57.332056] Starting dynamic subtest: bcs0
[57.382079] Dynamic subtest bcs0: SUCCESS (0.059s)
[57.391453] Starting dynamic subtest: vcs0
[58.895650] Dynamic subtest vcs0: SUCCESS (1.511s)
[58.905942] Starting dynamic subtest: vcs1
[60.881665] Dynamic subtest vcs1: SUCCESS (1.985s)
[60.891768] Starting dynamic subtest: vecs0
[62.932444] Dynamic subtest vecs0: SUCCESS (2.050s)
[62.942432] Starting dynamic subtest: ccs0
[62.986910] Dynamic subtest ccs0: SUCCESS (0.055s)
[62.990270] Subtest engines-hostile-preempt: SUCCESS (5.763s)
[63.064972] [003/133] (954s left) kms_setmode (basic)
[63.117602] Starting subtest: basic
[63.474102] Starting dynamic subtest: pipe-A-eDP-1
[65.556062] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.077s)
[65.909759] Starting dynamic subtest: pipe-B-eDP-1
[67.991287] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.089s)
[68.297844] Subtest basic: SUCCESS (5.177s)
[69.146087] [004/133] (948s left) kms_lease (lease-get)
[69.248425] Starting subtest: lease-get
[69.250715] Starting dynamic subtest: pipe-A-eDP-1
[69.253077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[69.264176] Starting dynamic subtest: pipe-B-eDP-1
[69.266065] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[69.276852] Starting dynamic subtest: pipe-C-eDP-1
[69.278745] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[69.285185] Starting dynamic subtest: pipe-D-eDP-1
[69.287046] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[69.289333] Subtest lease-get: SUCCESS (0.007s)
[69.344782] [005/133] (948s left) kms_atomic_interruptible (legacy-dpms)
[69.441628] Starting subtest: legacy-dpms
[69.444271] Starting dynamic subtest: pipe-A-eDP-1
[76.869589] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.427s)
[76.871797] Subtest legacy-dpms: SUCCESS (7.429s)
[77.701854] [006/133] (940s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[77.797190] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[77.799399] Starting dynamic subtest: pipe-A
[78.845458] Dynamic subtest pipe-A: SUCCESS (1.050s)
[78.855883] Starting dynamic subtest: pipe-B
[80.987988] Dynamic subtest pipe-B: SUCCESS (2.142s)
[80.996673] Starting dynamic subtest: pipe-C
[82.191416] Dynamic subtest pipe-C: SUCCESS (1.202s)
[82.200052] Starting dynamic subtest: pipe-D
[83.423389] Dynamic subtest pipe-D: SUCCESS (1.231s)
[83.425789] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.628s)
[84.618975] [007/133] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[84.732526] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[91.278048] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.551s)
[91.399775] [008/133] (926s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[91.489711] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[91.491972] Starting dynamic subtest: pipe-A-eDP-1
[91.515028] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[91.523886] Starting dynamic subtest: pipe-B-eDP-1
[91.545194] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.552451] Starting dynamic subtest: pipe-C-eDP-1
[91.574228] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.581314] Starting dynamic subtest: pipe-D-eDP-1
[91.603300] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.607753] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[93.708797] [009/133] (924s left) gem_fence_thrash (bo-write-verify-threaded-x)
[93.744166] Starting subtest: bo-write-verify-threaded-x
[93.764070] Subtest bo-write-verify-threaded-x: SKIP (0.017s)
[93.820252] [010/133] (924s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[94.201242] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[95.020981] [011/133] (922s left) gem_exec_schedule (submit-golden-slice)
[95.106189] Starting subtest: submit-golden-slice
[95.108577] Starting dynamic subtest: rcs0
[95.141867] Dynamic subtest rcs0: SUCCESS (0.043s)
[95.152205] Starting dynamic subtest: bcs0
[95.179757] Dynamic subtest bcs0: SUCCESS (0.038s)
[95.189128] Starting dynamic subtest: vcs0
[95.210722] Dynamic subtest vcs0: SUCCESS (0.031s)
[95.219716] Starting dynamic subtest: vcs1
[95.240503] Dynamic subtest vcs1: SUCCESS (0.030s)
[95.247891] Starting dynamic subtest: vecs0
[95.273662] Dynamic subtest vecs0: SUCCESS (0.033s)
[95.280863] Starting dynamic subtest: ccs0
[95.304734] Dynamic subtest ccs0: SUCCESS (0.031s)
[95.307146] Subtest submit-golden-slice: SUCCESS (0.207s)
[96.996670] [012/133] (920s left) gem_exec_params (invalid-ring2)
[97.047757] Starting subtest: invalid-ring2
[97.050143] Subtest invalid-ring2: SUCCESS (0.000s)
[97.140764] [013/133] (920s left) gem_pread (self)
[97.204787] Subtest self: SKIP (0.000s)
[97.257573] [014/133] (920s left) kms_big_fb (x-tiled-addfb)
[97.357208] Starting subtest: x-tiled-addfb
[97.359429] Subtest x-tiled-addfb: SUCCESS (0.000s)
[97.465805] [015/133] (920s left) gem_softpin (32b-excludes-last-page)
[97.531023] Starting subtest: 32b-excludes-last-page
[97.535704] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[97.667424] [016/133] (920s left) kms_hdr (static-toggle-dpms)
[97.779105] Starting subtest: static-toggle-dpms
[97.785528] Subtest static-toggle-dpms: SKIP (0.000s)
[97.848026] [017/133] (920s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[97.943965] Starting subtest: psr-1p-pri-indfb-multidraw
[120.986491] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.046s)
[121.130301] [018/133] (897s left) gem_basic (create-fd-close)
[121.200517] Starting subtest: create-fd-close
[121.203974] Subtest create-fd-close: SUCCESS (0.000s)
[121.294851] [019/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[121.397242] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[121.400757] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[121.494906] [020/133] (896s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[121.595648] Starting subtest: plane-lut1d-ctm3x4
[121.742235] Starting dynamic subtest: pipe-A-plane-0
[121.908007] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[121.915630] Starting dynamic subtest: pipe-A-plane-1
[122.074765] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[122.082561] Starting dynamic subtest: pipe-A-plane-2
[122.219429] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[123.476448] Starting dynamic subtest: pipe-B-plane-0
[123.636439] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[123.645131] Starting dynamic subtest: pipe-B-plane-1
[123.803848] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[123.811928] Starting dynamic subtest: pipe-B-plane-2
[123.947675] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[125.111750] Starting dynamic subtest: pipe-C-plane-0
[125.250053] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[125.259276] Starting dynamic subtest: pipe-C-plane-1
[125.405624] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[125.414322] Starting dynamic subtest: pipe-C-plane-2
[125.561024] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[126.718995] Starting dynamic subtest: pipe-D-plane-0
[126.862170] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[126.869903] Starting dynamic subtest: pipe-D-plane-1
[127.006442] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[127.014077] Starting dynamic subtest: pipe-D-plane-2
[127.150721] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[127.435735] Subtest plane-lut1d-ctm3x4: SUCCESS (5.842s)
[128.289510] [021/133] (889s left) gem_ccs (ctrl-surf-copy)
[128.359098] Starting subtest: ctrl-surf-copy
[128.363775] Subtest ctrl-surf-copy: SKIP (0.000s)
[128.455028] [022/133] (889s left) gem_exec_parallel (engines)
[128.513282] Starting subtest: engines
[128.515643] Starting dynamic subtest: basic
[131.861064] Dynamic subtest basic: SUCCESS (3.345s)
[131.870778] Starting dynamic subtest: contexts
[136.213775] Dynamic subtest contexts: SUCCESS (4.350s)
[136.224666] Starting dynamic subtest: fds
[140.062480] Dynamic subtest fds: SUCCESS (3.846s)
[140.072586] Starting dynamic subtest: userptr
[141.907948] Dynamic subtest userptr: SUCCESS (1.843s)
[141.910458] Subtest engines: SUCCESS (13.395s)
[142.104186] [023/133] (876s left) gem_exec_balancer (sequential)
[142.173592] Starting subtest: sequential
[145.267162] Subtest sequential: SUCCESS (3.093s)
[145.591280] [024/133] (872s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[145.692621] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[145.697073] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[145.789991] [025/133] (872s left) gem_fence_thrash (bo-write-verify-x)
[145.826738] Starting subtest: bo-write-verify-x
[145.841075] Subtest bo-write-verify-x: SKIP (0.012s)
[145.895180] [026/133] (872s left) kms_pipe_crc_basic (hang-read-crc)
[145.987064] Starting subtest: hang-read-crc
[145.989417] Starting dynamic subtest: pipe-A-eDP-1
[148.075839] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s)
[148.084753] Starting dynamic subtest: pipe-B-eDP-1
[150.849675] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[150.860599] Starting dynamic subtest: pipe-C-eDP-1
[153.568415] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.716s)
[153.576765] Starting dynamic subtest: pipe-D-eDP-1
[156.238727] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.670s)
[156.241116] Subtest hang-read-crc: SUCCESS (10.253s)
[157.065488] [027/133] (861s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[157.163682] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[157.165896] Starting dynamic subtest: pipe-A-eDP-1
[157.262636] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[157.272296] Starting dynamic subtest: pipe-B-eDP-1
[158.443665] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[158.448250] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.282s)
[159.630585] [028/133] (858s left) gem_compute (compute-square)
[159.687994] Starting subtest: compute-square
[159.691728] Subtest compute-square: SUCCESS (0.007s)
[159.799230] [029/133] (858s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[159.893414] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[164.072236] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.182s)
[165.234416] [030/133] (853s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[165.329761] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[165.333895] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[165.416187] [031/133] (853s left) kms_dsc (dsc-with-bpc-formats)
[165.516117] Starting subtest: dsc-with-bpc-formats
[165.627219] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[165.663954] [032/133] (853s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[165.768179] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[165.772321] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[165.854983] [033/133] (852s left) kms_flip (wf_vblank-ts-check-interruptible)
[165.957402] Starting subtest: wf_vblank-ts-check-interruptible
[165.959691] Starting dynamic subtest: A-eDP1
[174.865629] Dynamic subtest A-eDP1: SUCCESS (8.907s)
[174.878189] Starting dynamic subtest: B-eDP1
[183.802516] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[183.812890] Starting dynamic subtest: C-eDP1
[192.730364] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[192.744928] Starting dynamic subtest: D-eDP1
[201.661843] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[201.667187] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.709s)
[202.877904] [034/133] (815s left) gem_eio (unwedge-stress)
[203.121173] Starting subtest: unwedge-stress
[203.123379] Starting dynamic subtest: render
[208.064512] Dynamic subtest render: SUCCESS (4.942s)
[208.078451] Starting dynamic subtest: bsd1
[226.337072] Dynamic subtest bsd1: SUCCESS (18.273s)
[226.352367] Starting dynamic subtest: bsd2
[248.372302] Dynamic subtest bsd2: SUCCESS (22.032s)
[248.386828] Starting dynamic subtest: blt
[248.391060] Dynamic subtest blt: SKIP (0.000s)
[248.399230] Starting dynamic subtest: vebox
[266.435557] Dynamic subtest vebox: SUCCESS (18.060s)
[266.438194] Subtest unwedge-stress: SUCCESS (63.314s)
[267.962275] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[267.966069] [035/133] (750s left) gem_close (basic)
[268.037086] Starting subtest: basic
[268.039449] Subtest basic: SUCCESS (0.000s)
[268.134567] [036/133] (750s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[268.239132] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[268.918159] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s)
[269.097275] [037/133] (749s left) i915_query (query-regions-unallocated)
[269.150271] Starting subtest: query-regions-unallocated
[269.152195] Subtest query-regions-unallocated: SUCCESS (0.000s)
[269.237268] [038/133] (749s left) i915_drm_fdinfo (virtual-busy-hang)
[269.282208] Starting subtest: virtual-busy-hang
[269.286555] Subtest virtual-busy-hang: SKIP (0.000s)
[269.351394] [039/133] (749s left) gem_ctx_persistence (legacy-engines-queued)
[269.415817] Starting subtest: legacy-engines-queued
[269.418531] Starting dynamic subtest: render
[269.501048] Dynamic subtest render: SUCCESS (0.084s)
[269.513178] Starting dynamic subtest: bsd1
[270.899064] Dynamic subtest bsd1: SUCCESS (1.394s)
[270.909702] Starting dynamic subtest: bsd2
[272.882671] Dynamic subtest bsd2: SUCCESS (1.981s)
[272.894723] Starting dynamic subtest: blt
[272.957048] Dynamic subtest blt: SUCCESS (0.072s)
[272.967908] Starting dynamic subtest: vebox
[274.866762] Dynamic subtest vebox: SUCCESS (1.905s)
[274.869712] Subtest legacy-engines-queued: SUCCESS (5.452s)
[274.953271] [040/133] (744s left) kms_debugfs (display-on-read-all)
[275.054110] Starting subtest: display-on-read-all
[275.218628] Subtest display-on-read-all: SUCCESS (0.167s)
[275.342269] [041/133] (743s left) dumb_buffer (create-valid-dumb)
[275.398085] Starting subtest: create-valid-dumb
[275.400164] Subtest create-valid-dumb: SUCCESS (0.000s)
[275.505407] [042/133] (743s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[275.605078] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[275.609157] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[275.705269] [043/133] (743s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[275.807065] Starting subtest: 4-tiled-16bpp-rotate-0
[277.190553] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.383s)
[277.311784] [044/133] (741s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[277.414284] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[284.012254] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.600s)
[284.135850] [045/133] (735s left) perf_pmu (busy-check-all)
[284.182751] Starting subtest: busy-check-all
[284.185068] Starting dynamic subtest: rcs0
[284.730904] Dynamic subtest rcs0: SUCCESS (0.550s)
[284.742311] Starting dynamic subtest: bcs0
[285.280807] Dynamic subtest bcs0: SUCCESS (0.548s)
[285.292874] Starting dynamic subtest: vcs0
[286.868120] Dynamic subtest vcs0: SUCCESS (1.584s)
[286.879816] Starting dynamic subtest: vcs1
[288.916661] Dynamic subtest vcs1: SUCCESS (2.045s)
[288.928318] Starting dynamic subtest: vecs0
[290.900685] Dynamic subtest vecs0: SUCCESS (1.981s)
[290.912354] Starting dynamic subtest: ccs0
[291.455210] Dynamic subtest ccs0: SUCCESS (0.554s)
[291.457741] Subtest busy-check-all: SUCCESS (7.276s)
[291.550807] [046/133] (727s left) gem_lmem_swapping (heavy-random)
[291.597469] Subtest heavy-random: SKIP (0.000s)
[291.648835] [047/133] (727s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[291.777446] Starting subtest: cursorA-vs-flipB-toggle
[291.782190] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[291.927760] [048/133] (727s left) api_intel_allocator (reserve-simple)
[291.993878] Starting subtest: reserve-simple
[291.995774] Subtest reserve-simple: SUCCESS (0.003s)
[292.098696] [049/133] (727s left) perf (mi-rpc)
[292.224696] Starting subtest: mi-rpc
[292.229209] Subtest mi-rpc: SKIP (0.000s)
[292.275980] [050/133] (727s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[292.369951] Starting subtest: bad-pixel-format-y-tiled-ccs
[292.372164] Starting dynamic subtest: pipe-A-eDP-1
[292.394618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.405933] Starting dynamic subtest: pipe-B-eDP-1
[292.427103] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[292.436353] Starting dynamic subtest: pipe-C-eDP-1
[292.462066] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[292.472446] Starting dynamic subtest: pipe-D-eDP-1
[292.490294] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[292.493647] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[294.693467] [051/133] (724s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[294.799082] Starting subtest: yf-tiled-64bpp-rotate-180
[294.803626] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[294.893768] [052/133] (724s left) gem_ctx_param (get-priority-new-ctx)
[294.946752] Starting subtest: get-priority-new-ctx
[294.949067] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[295.037597] [053/133] (724s left) vgem_slow (nohang)
[295.080404] Starting subtest: nohang
[305.265837] Subtest nohang: SUCCESS (10.186s)
[305.333382] [054/133] (714s left) gem_exec_balancer (full-pulse)
[305.393032] Starting subtest: full-pulse
[309.782690] Subtest full-pulse: SUCCESS (4.392s)
[310.099325] [055/133] (709s left) gem_ctx_bad_destroy (double-destroy)
[310.152112] Starting subtest: double-destroy
[310.154451] Subtest double-destroy: SUCCESS (0.000s)
[310.228975] [056/133] (709s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[310.335425] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[314.030516] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.698s)
[315.193078] [057/133] (704s left) vgem_basic (second-client)
[315.238894] Starting subtest: second-client
[315.262217] Subtest second-client: SUCCESS (0.022s)
[315.333813] [058/133] (704s left) kms_psr (pr-primary-render)
[315.433404] Starting subtest: pr-primary-render
[315.437847] Subtest pr-primary-render: SKIP (0.000s)
[315.505843] [059/133] (704s left) kms_vblank (ts-continuation-modeset-hang)
[315.598088] Starting subtest: ts-continuation-modeset-hang
[315.600257] Starting dynamic subtest: pipe-A-eDP-1
[341.652470] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.054s)
[341.670069] Starting dynamic subtest: pipe-D-eDP-1
[366.669391] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.013s)
[366.671790] Subtest ts-continuation-modeset-hang: SUCCESS (51.072s)
[367.496815] [060/133] (652s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[367.588899] Starting subtest: flip-primary-invalidate-overlay
[379.262227] Subtest flip-primary-invalidate-overlay: SUCCESS (11.676s)
[379.425088] [061/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[379.519607] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[379.523290] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[379.619889] [062/133] (640s left) gem_pxp (verify-pxp-stale-ctx-execution)
[379.741199] Starting subtest: verify-pxp-stale-ctx-execution
[380.801721] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[380.933121] [063/133] (639s left) gen9_exec_parse (secure-batches)
[380.996865] Subtest secure-batches: SKIP (0.000s)
[381.079940] [064/133] (638s left) perf (per-context-mode-unprivileged)
[381.170717] Starting subtest: per-context-mode-unprivileged
[381.175425] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[381.215319] [065/133] (638s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[381.317178] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[381.321545] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[381.401023] [066/133] (638s left) gem_mmap (bad-offset)
[381.461448] Subtest bad-offset: SKIP (0.000s)
[381.515557] [067/133] (638s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[381.612762] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[388.626867] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.018s)
[388.739519] [068/133] (631s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[388.845789] Starting subtest: y-tiled-32bpp-rotate-270
[388.850148] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[388.941183] [069/133] (631s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[389.037503] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[389.041670] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[389.132945] [070/133] (631s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[389.237193] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[389.241118] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[389.307733] [071/133] (631s left) sysfs_preempt_timeout (timeout)
[389.364575] Starting subtest: timeout
[389.366930] Starting dynamic subtest: vecs0
[398.864988] Dynamic subtest vecs0: SUCCESS (9.496s)
[398.877982] Starting dynamic subtest: ccs0
[400.175596] Dynamic subtest ccs0: SUCCESS (1.309s)
[400.189073] Starting dynamic subtest: vcs0
[409.874301] Dynamic subtest vcs0: SUCCESS (9.696s)
[409.885981] Starting dynamic subtest: bcs0
[411.156834] Dynamic subtest bcs0: SUCCESS (1.282s)
[411.166887] Starting dynamic subtest: rcs0
[412.407866] Dynamic subtest rcs0: SUCCESS (1.248s)
[412.420231] Starting dynamic subtest: vcs1
[421.900943] Dynamic subtest vcs1: SUCCESS (9.491s)
[421.903491] Subtest timeout: SUCCESS (32.534s)
[421.976787] [072/133] (598s left) i915_pm_rpm (gem-evict-pwrite)
[424.009022] Starting subtest: gem-evict-pwrite
[424.013845] Subtest gem-evict-pwrite: SKIP (0.000s)
[424.390566] [073/133] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[424.488479] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[424.492803] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[424.578580] [074/133] (595s left) syncobj_basic (bad-pad-handle-to-fd)
[424.636577] Starting subtest: bad-pad-handle-to-fd
[424.638876] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[424.733350] [075/133] (595s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[424.790561] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[424.792965] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[424.887380] [076/133] (595s left) syncobj_timeline (single-wait-available-submitted)
[424.942822] Starting subtest: single-wait-available-submitted
[424.945086] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[425.046981] [077/133] (595s left) gem_vm_create (create-ext)
[425.110608] Starting subtest: create-ext
[425.115800] Subtest create-ext: SUCCESS (0.005s)
[425.235879] [078/133] (595s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[425.327525] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[425.329369] Starting dynamic subtest: pipe-A-eDP-1
[425.350219] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[425.361104] Starting dynamic subtest: pipe-B-eDP-1
[425.380475] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[425.389477] Starting dynamic subtest: pipe-C-eDP-1
[425.408767] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[425.420198] Starting dynamic subtest: pipe-D-eDP-1
[425.440405] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[425.443815] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[427.564038] [079/133] (593s left) gem_exec_params (no-vebox)
[427.623630] Starting subtest: no-vebox
[427.626038] Subtest no-vebox: SUCCESS (0.002s)
[428.951970] [080/133] (591s left) kms_flip (2x-flip-vs-fences-interruptible)
[429.049292] Starting subtest: 2x-flip-vs-fences-interruptible
[429.053538] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[429.157415] [081/133] (591s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[429.240389] Starting subtest: async-flip-with-page-flip-events-tiled
[429.611898] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[432.342186] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.729s)
[432.351736] Starting dynamic subtest: pipe-A-eDP-1-4
[434.516689] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[434.530398] Starting dynamic subtest: pipe-A-eDP-1-4
[436.527110] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s)
[436.539479] Starting dynamic subtest: pipe-A-eDP-1-x
[438.717358] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[439.084523] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[441.876668] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[441.888475] Starting dynamic subtest: pipe-B-eDP-1-4
[444.062366] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[444.071808] Starting dynamic subtest: pipe-B-eDP-1-4
[446.072873] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[446.084704] Starting dynamic subtest: pipe-B-eDP-1-x
[448.273749] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[448.647543] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[451.404572] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.763s)
[451.414385] Starting dynamic subtest: pipe-C-eDP-1-4
[453.579198] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[453.588673] Starting dynamic subtest: pipe-C-eDP-1-4
[455.589549] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[455.599135] Starting dynamic subtest: pipe-C-eDP-1-x
[457.768237] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[458.129924] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[460.933777] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.809s)
[460.943261] Starting dynamic subtest: pipe-D-eDP-1-4
[463.107524] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[463.119565] Starting dynamic subtest: pipe-D-eDP-1-4
[465.117543] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[465.129584] Starting dynamic subtest: pipe-D-eDP-1-x
[467.295753] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[467.298094] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.057s)
[468.534815] [082/133] (552s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[468.646989] Starting subtest: 4-tiled-64bpp-rotate-90
[468.666940] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[468.793089] [083/133] (552s left) kms_psr (psr2-cursor-render)
[468.878337] Starting subtest: psr2-cursor-render
[468.880607] Starting dynamic subtest: eDP-1
[470.610773] Dynamic subtest eDP-1: SUCCESS (1.733s)
[470.613231] Subtest psr2-cursor-render: SUCCESS (1.734s)
[471.406814] [084/133] (549s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[471.495314] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[471.497324] Starting dynamic subtest: pipe-A-eDP-1
[472.240319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[472.249589] Starting dynamic subtest: pipe-B-eDP-1
[474.027520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.785s)
[474.036564] Starting dynamic subtest: pipe-C-eDP-1
[475.951956] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.924s)
[475.962908] Starting dynamic subtest: pipe-D-eDP-1
[477.779644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.827s)
[477.782032] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.278s)
[478.918439] [085/133] (542s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[479.037631] Starting subtest: basic-busy-flip-before-cursor-varying-size
[479.042285] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[479.189312] [086/133] (541s left) syncobj_timeline (invalid-wait-illegal-handle)
[479.249234] Starting subtest: invalid-wait-illegal-handle
[479.251534] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[479.351662] [087/133] (541s left) gem_reg_read (bad-register)
[479.405967] Starting subtest: bad-register
[479.408180] Subtest bad-register: SUCCESS (0.000s)
[479.541456] [088/133] (541s left) kms_big_fb (linear-16bpp-rotate-90)
[479.656155] Starting subtest: linear-16bpp-rotate-90
[479.675713] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[479.782791] [089/133] (541s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[479.830673] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[479.887042] [090/133] (541s left) gem_mmap_gtt (medium-copy-xy)
[479.944157] Subtest medium-copy-XY: SKIP (0.000s)
[480.004804] [091/133] (541s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[480.090331] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[480.092369] Starting dynamic subtest: pipe-A
[481.215916] Dynamic subtest pipe-A: SUCCESS (1.129s)
[481.231316] Starting dynamic subtest: pipe-B
[483.419935] Dynamic subtest pipe-B: SUCCESS (2.202s)
[483.429307] Starting dynamic subtest: pipe-C
[484.617972] Dynamic subtest pipe-C: SUCCESS (1.196s)
[484.627196] Starting dynamic subtest: pipe-D
[485.763064] Dynamic subtest pipe-D: SUCCESS (1.144s)
[485.765334] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.677s)
[486.956288] [092/133] (534s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[487.068369] Starting subtest: flip-vs-cursor-busy-crc-atomic
[487.881089] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.811s)
[488.692461] [093/133] (532s left) gem_spin_batch (resubmit-all)
[488.767943] Starting subtest: resubmit-all
[488.770366] Starting dynamic subtest: rcs0
[488.777980] Dynamic subtest rcs0: SUCCESS (0.010s)
[488.788932] Starting dynamic subtest: bcs0
[488.791257] Dynamic subtest bcs0: SUCCESS (0.002s)
[488.800839] Starting dynamic subtest: vcs0
[488.803088] Dynamic subtest vcs0: SUCCESS (0.002s)
[488.812128] Starting dynamic subtest: vcs1
[488.814309] Dynamic subtest vcs1: SUCCESS (0.002s)
[488.823249] Starting dynamic subtest: vecs0
[488.825435] Dynamic subtest vecs0: SUCCESS (0.002s)
[488.834307] Starting dynamic subtest: ccs0
[488.836518] Dynamic subtest ccs0: SUCCESS (0.002s)
[488.838754] Subtest resubmit-all: SUCCESS (0.024s)
[489.917307] [094/133] (531s left) syncobj_basic (bad-pad-fd-to-handle)
[489.964315] Starting subtest: bad-pad-fd-to-handle
[489.966229] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[490.046914] [095/133] (531s left) kms_psr (fbc-pr-cursor-plane-onoff)
[490.147075] Starting subtest: fbc-pr-cursor-plane-onoff
[490.151496] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[490.218019] [096/133] (531s left) gem_exec_fence (syncobj-timeline-repeat)
[490.782945] Starting subtest: syncobj-timeline-repeat
[491.031624] Subtest syncobj-timeline-repeat: SUCCESS (0.249s)
[492.006054] [097/133] (529s left) kms_frontbuffer_tracking (fbc-1p-rte)
[492.111689] Starting subtest: fbc-1p-rte
[497.564596] Subtest fbc-1p-rte: SUCCESS (5.456s)
[498.721430] [098/133] (522s left) vgem_basic (debugfs)
[498.768339] Starting subtest: debugfs
[498.770733] Subtest debugfs: SUCCESS (0.000s)
[498.826179] [099/133] (522s left) perf (low-oa-exponent-permissions)
[498.926078] Starting subtest: low-oa-exponent-permissions
[498.962034] Subtest low-oa-exponent-permissions: SUCCESS (0.040s)
[499.006238] [100/133] (522s left) gem_softpin (softpin)
[499.060766] Starting subtest: softpin
[531.361574] Subtest softpin: SUCCESS (32.295s)
[531.498112] [101/133] (490s left) i915_getparams_basic (basic-subslice-total)
[531.556173] Starting subtest: basic-subslice-total
[531.560612] Subtest basic-subslice-total: SUCCESS (0.000s)
[531.639537] [102/133] (490s left) kms_cursor_crc (cursor-offscreen-512x170)
[531.932835] Starting subtest: cursor-offscreen-512x170
[531.936529] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[532.091666] [103/133] (489s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[532.143143] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[532.145386] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[532.242772] [104/133] (489s left) kms_vblank (crtc-id)
[532.330348] Starting subtest: crtc-id
[532.332254] Starting dynamic subtest: pipe-A-eDP-1
[532.774257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[532.789362] Starting dynamic subtest: pipe-D-eDP-1
[533.931234] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.155s)
[533.933516] Subtest crtc-id: SUCCESS (1.603s)
[534.775817] [105/133] (487s left) kms_content_protection (dp-mst-type-0)
[534.911214] Starting subtest: dp-mst-type-0
[534.915920] Subtest dp-mst-type-0: SKIP (0.000s)
[535.021603] [106/133] (486s left) perf_pmu (busy-start)
[535.063603] Starting subtest: busy-start
[535.065503] Starting dynamic subtest: rcs0
[537.611708] Dynamic subtest rcs0: SUCCESS (2.548s)
[537.623987] Starting dynamic subtest: bcs0
[540.162200] Dynamic subtest bcs0: SUCCESS (2.549s)
[540.174278] Starting dynamic subtest: vcs0
[543.892361] Dynamic subtest vcs0: SUCCESS (3.726s)
[543.904889] Starting dynamic subtest: vcs1
[547.925373] Dynamic subtest vcs1: SUCCESS (4.030s)
[547.935356] Starting dynamic subtest: vecs0
[551.892075] Dynamic subtest vecs0: SUCCESS (3.964s)
[551.904525] Starting dynamic subtest: ccs0
[554.441034] Dynamic subtest ccs0: SUCCESS (2.547s)
[554.443830] Subtest busy-start: SUCCESS (19.379s)
[554.534821] [107/133] (467s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[554.637546] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[562.023145] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.389s)
[562.170130] [108/133] (459s left) gem_exec_schedule (in-order)
[562.249957] Starting subtest: in-order
[562.252067] Starting dynamic subtest: rcs0
[562.342741] Dynamic subtest rcs0: SUCCESS (0.100s)
[562.355811] Starting dynamic subtest: vcs0
[562.425229] Dynamic subtest vcs0: SUCCESS (0.082s)
[562.440141] Starting dynamic subtest: vcs1
[562.521594] Dynamic subtest vcs1: SUCCESS (0.094s)
[562.534863] Starting dynamic subtest: vecs0
[562.609043] Dynamic subtest vecs0: SUCCESS (0.088s)
[562.621800] Starting dynamic subtest: ccs0
[562.713111] Dynamic subtest ccs0: SUCCESS (0.102s)
[562.715559] Subtest in-order: SUCCESS (0.472s)
[564.020105] [109/133] (457s left) sriov_basic (enable-vfs-bind-unbind-each)
[564.077968] Starting subtest: enable-vfs-bind-unbind-each
[564.079910] Starting dynamic subtest: numvfs-1
[564.154612] Dynamic subtest numvfs-1: FAIL (0.013s)
[564.166270] Starting dynamic subtest: numvfs-2
[564.240072] Dynamic subtest numvfs-2: FAIL (0.004s)
[564.253599] Starting dynamic subtest: numvfs-3
[564.327318] Dynamic subtest numvfs-3: FAIL (0.003s)
[564.337835] Starting dynamic subtest: numvfs-4
[564.410408] Dynamic subtest numvfs-4: FAIL (0.006s)
[564.421460] Starting dynamic subtest: numvfs-5
[564.494617] Dynamic subtest numvfs-5: FAIL (0.004s)
[564.504760] Starting dynamic subtest: numvfs-6
[564.577430] Dynamic subtest numvfs-6: FAIL (0.004s)
[564.589121] Starting dynamic subtest: numvfs-7
[564.662815] Dynamic subtest numvfs-7: FAIL (0.004s)
[564.672523] Starting dynamic subtest: numvfs-random
[564.743594] Dynamic subtest numvfs-random: FAIL (0.005s)
[564.745871] Subtest enable-vfs-bind-unbind-each: FAIL (0.048s)
[564.785103] [110/133] (457s left) kms_psr (fbc-psr2-cursor-render)
[564.871895] Starting subtest: fbc-psr2-cursor-render
[564.874079] Starting dynamic subtest: eDP-1
[564.878067] Dynamic subtest eDP-1: SKIP (0.000s)
[564.882032] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[564.954237] [111/133] (457s left) syncobj_basic (bad-fd-to-handle)
[565.015422] Starting subtest: bad-fd-to-handle
[565.017392] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[565.152491] [112/133] (456s left) syncobj_eventfd (invalid-illegal-handle)
[565.209271] Starting subtest: invalid-illegal-handle
[565.211108] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[565.291277] [113/133] (456s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[565.393527] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[565.397281] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[565.491890] [114/133] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[565.592225] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[565.595646] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[565.693635] [115/133] (456s left) kms_vblank (invalid)
[565.800464] Starting subtest: invalid
[565.802146] Starting dynamic subtest: pipe-A-eDP-1
[566.202104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[566.204048] Subtest invalid: SUCCESS (0.402s)
[567.022399] [116/133] (455s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[567.311698] Starting subtest: cursor-rapid-movement-512x512
[567.316338] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[567.471702] [117/133] (454s left) kms_getfb (getfb-handle-protection)
[567.571064] Starting subtest: getfb-handle-protection
[567.585158] Subtest getfb-handle-protection: SUCCESS (0.015s)
[567.708382] [118/133] (454s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[567.766775] Starting subtest: invalid-bsd1-flag-on-vebox
[567.769208] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[567.870743] [119/133] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[567.965116] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[567.968896] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[568.060501] [120/133] (454s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[568.161467] Starting subtest: fbc-psr-cursor-mmap-gtt
[568.163363] Starting dynamic subtest: eDP-1
[568.166858] Dynamic subtest eDP-1: SKIP (0.000s)
[568.170276] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[568.240561] [121/133] (454s left) kms_pm_rpm (legacy-planes-dpms)
[569.988766] Starting subtest: legacy-planes-dpms
[569.990830] Starting dynamic subtest: plane-65
[578.298866] Dynamic subtest plane-65: SUCCESS (8.311s)
[578.311786] Starting dynamic subtest: plane-95
[587.031464] Dynamic subtest plane-95: SUCCESS (8.730s)
[587.043719] Starting dynamic subtest: plane-125
[595.389461] Dynamic subtest plane-125: SUCCESS (8.355s)
[595.401857] Starting dynamic subtest: plane-135
[603.734050] Dynamic subtest plane-135: SUCCESS (8.342s)
[603.736689] Subtest legacy-planes-dpms: SUCCESS (33.749s)
[604.126301] [122/133] (418s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[604.249048] Starting subtest: cursorA-vs-flipA-legacy
[615.364230] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.114s)
[616.232523] [123/133] (406s left) gem_exec_alignment (many)
[616.286746] Starting subtest: many
[640.257430] Subtest many: SUCCESS (23.969s)
[642.881586] [124/133] (379s left) perf (enable-disable)
[643.046578] Starting subtest: enable-disable
[643.048579] Starting dynamic subtest: 0-rcs0
[645.348304] Dynamic subtest 0-rcs0: SUCCESS (2.303s)
[645.357900] Starting dynamic subtest: 1-vcs1
[649.840949] Dynamic subtest 1-vcs1: SUCCESS (4.492s)
[649.843536] Subtest enable-disable: SUCCESS (6.797s)
[649.891692] [125/133] (372s left) gem_softpin (noreloc)
[649.954164] Starting subtest: noreloc
[655.350963] Subtest noreloc: SUCCESS (5.395s)
[655.475949] [126/133] (367s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[655.578843] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[655.582859] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[655.668843] [127/133] (367s left) kms_prop_blob (invalid-set-prop-any)
[655.719450] Starting subtest: invalid-set-prop-any
[655.721686] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[655.838798] [128/133] (366s left) gem_exec_whisper (basic-contexts-forked)
[655.905596] Starting subtest: basic-contexts-forked
[679.566240] Subtest basic-contexts-forked: SUCCESS (23.658s)
[679.751399] [129/133] (343s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[679.844761] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[679.847063] Starting dynamic subtest: pipe-A-eDP-1
[679.869196] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[679.880113] Starting dynamic subtest: pipe-B-eDP-1
[679.900286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[679.909503] Starting dynamic subtest: pipe-C-eDP-1
[679.930618] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[679.939332] Starting dynamic subtest: pipe-D-eDP-1
[679.960581] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[679.964795] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[682.019782] [130/133] (340s left) gem_mmap_gtt (zero-extend)
[682.077243] Subtest zero-extend: SKIP (0.000s)
[682.140895] [131/133] (340s left) kms_pm_dc (dc6-dpms)
[683.254288] Starting subtest: dc6-dpms
[685.295291] Subtest dc6-dpms: SUCCESS (2.041s)
[685.374380] [132/133] (337s left) kms_chamelium_color (degamma)
[685.478040] Subtest degamma: SKIP (0.000s)
[685.523220] [133/133] (337s left) api_intel_bb (intel-bb-blit-none)
[685.588538] Starting subtest: intel-bb-blit-none
[689.623253] Subtest intel-bb-blit-none: SUCCESS (4.034s)
[689.737418] Closing watchdogs
results: parsing output: 0/ for test: gem_bad_reloc
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: kms_setmode
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_fence_thrash
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_pread
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_hdr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_basic
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_color_pipeline
results: parsing output: 20/ for test: gem_ccs
results: parsing output: 21/ for test: gem_exec_parallel
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_fence_thrash
results: parsing output: 25/ for test: kms_pipe_crc_basic
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: gem_compute
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_dsc
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: gem_close
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: i915_query
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_debugfs
results: parsing output: 40/ for test: dumb_buffer
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: api_intel_allocator
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: vgem_slow
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: gem_ctx_bad_destroy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: kms_psr_stress_test
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_pxp
results: parsing output: 62/ for test: gen9_exec_parse
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_mmap
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: sysfs_preempt_timeout
results: parsing output: 71/ for test: i915_pm_rpm
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_basic
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_vm_create
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_async_flips
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_reg_read
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_pipe_b_c_ivb
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: syncobj_basic
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: gem_softpin
results: parsing output: 100/ for test: i915_getparams_basic
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: kms_content_protection
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: sriov_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_basic
results: parsing output: 111/ for test: syncobj_eventfd
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_pm_rpm
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: gem_exec_alignment
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_prop_blob
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_pm_dc
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: api_intel_bb
Done.