[64.217232] Initializing watchdogs
[64.217338]   /dev/watchdog0
[64.231140] [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]
[64.235231] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.237363] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.240661] [001/129] (960s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[64.439113] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[71.866776] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.430s)
[72.084691] [002/129] (952s left) gem_ctx_persistence (process)
[72.150712] Starting subtest: process
[72.351817] Subtest process: SUCCESS (0.201s)
[72.422342] [003/129] (952s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[72.520479] Starting subtest: fbc-shrfb-scaledprimary
[76.568348] Subtest fbc-shrfb-scaledprimary: SUCCESS (4.053s)
[76.685805] [004/129] (948s left) gem_wait (busy)
[76.743580] Starting subtest: busy
[76.745871] Starting dynamic subtest: all-engines
[77.933638] Dynamic subtest all-engines: SUCCESS (1.188s)
[77.942932] Starting dynamic subtest: rcs0
[78.473400] Dynamic subtest rcs0: SUCCESS (0.541s)
[78.481130] Starting dynamic subtest: bcs0
[79.010410] Dynamic subtest bcs0: SUCCESS (0.537s)
[79.018504] Starting dynamic subtest: vcs0
[80.941989] Dynamic subtest vcs0: SUCCESS (1.930s)
[80.950988] Starting dynamic subtest: vcs1
[82.925201] Dynamic subtest vcs1: SUCCESS (1.982s)
[82.933928] Starting dynamic subtest: vecs0
[84.909311] Dynamic subtest vecs0: SUCCESS (1.984s)
[84.918916] Starting dynamic subtest: ccs0
[85.449272] Dynamic subtest ccs0: SUCCESS (0.541s)
[85.451799] Subtest busy: SUCCESS (8.706s)
[85.634639] [005/129] (939s left) drm_read (short-buffer-block)
[85.826519] Starting subtest: short-buffer-block
[85.828872] Subtest short-buffer-block: SUCCESS (0.000s)
[85.968197] [006/129] (938s left) gem_exec_fence (syncobj-timeline-repeat)
[86.515034] Starting subtest: syncobj-timeline-repeat
[86.736504] Subtest syncobj-timeline-repeat: SUCCESS (0.222s)
[88.026375] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[88.029485] [007/129] (936s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[88.129058] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[88.131547] Starting dynamic subtest: pipe-A-eDP-1
[88.153958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[88.163233] Starting dynamic subtest: pipe-B-eDP-1
[88.183041] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[88.189650] Starting dynamic subtest: pipe-C-eDP-1
[88.209919] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[88.217087] Starting dynamic subtest: pipe-D-eDP-1
[88.238386] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[88.240393] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[90.321497] [008/129] (934s left) kms_chamelium_frames (dp-crc-fast)
[90.712611] Subtest dp-crc-fast: SKIP (0.000s)
[91.524211] [009/129] (933s left) gem_exec_balancer (smoke)
[91.590211] Starting subtest: smoke
[114.131099] Subtest smoke: SUCCESS (22.432s)
[115.204453] [010/129] (909s left) syncobj_eventfd (timeline-wait)
[115.261661] Starting subtest: timeline-wait
[115.270246] Subtest timeline-wait: SUCCESS (0.011s)
[115.346069] [011/129] (909s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[115.480183] Starting subtest: cursorA-vs-flipB-legacy
[115.484239] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[115.606733] [012/129] (909s left) gem_exec_reloc (basic-cpu-read-active)
[115.676026] Subtest basic-cpu-read-active: SKIP (0.000s)
[115.739330] [013/129] (909s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[115.851642] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[116.686458] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.836s)
[116.862112] [014/129] (908s left) gem_ctx_isolation (preservation-s3)
[116.933414] Starting subtest: preservation-S3
[116.935927] Starting dynamic subtest: rcs0
[133.474488] Dynamic subtest rcs0: SUCCESS (1.567s)
[133.488187] Starting dynamic subtest: bcs0
[149.397101] Dynamic subtest bcs0: SUCCESS (1.378s)
[149.406276] Starting dynamic subtest: vcs0
[165.401020] Dynamic subtest vcs0: SUCCESS (3.030s)
[165.409988] Starting dynamic subtest: vcs1
[182.399185] Dynamic subtest vcs1: SUCCESS (3.976s)
[182.407017] Starting dynamic subtest: vecs0
[200.472441] Dynamic subtest vecs0: SUCCESS (5.006s)
[200.484430] Starting dynamic subtest: ccs0
[218.400225] Dynamic subtest ccs0: SUCCESS (3.218s)
[218.403781] Subtest preservation-S3: SUCCESS (18.175s)
[218.636563] [015/129] (889s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[218.705102] Starting subtest: multi-wait-all-for-submit-signaled
[218.707910] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[218.810196] [016/129] (889s left) kms_plane_scaling (planes-upscale-20x20)
[218.907596] Starting subtest: planes-upscale-20x20
[218.910340] Starting dynamic subtest: pipe-A
[218.971808] Dynamic subtest pipe-A: SUCCESS (0.063s)
[218.981946] Starting dynamic subtest: pipe-B
[220.074827] Dynamic subtest pipe-B: SUCCESS (1.087s)
[220.084913] Starting dynamic subtest: pipe-C
[221.195904] Dynamic subtest pipe-C: SUCCESS (1.107s)
[221.204823] Starting dynamic subtest: pipe-D
[222.338015] Dynamic subtest pipe-D: SUCCESS (1.129s)
[222.340975] Subtest planes-upscale-20x20: SUCCESS (3.388s)
[223.494479] [017/129] (885s left) gem_exec_schedule (preempt-other-chain)
[223.580321] Starting subtest: preempt-other-chain
[223.583076] Starting dynamic subtest: rcs0
[223.657228] Dynamic subtest rcs0: SUCCESS (0.088s)
[223.667692] Starting dynamic subtest: bcs0
[223.734619] Dynamic subtest bcs0: SUCCESS (0.077s)
[223.744171] Starting dynamic subtest: vcs0
[223.813110] Dynamic subtest vcs0: SUCCESS (0.078s)
[223.821686] Starting dynamic subtest: vcs1
[223.896233] Dynamic subtest vcs1: SUCCESS (0.082s)
[223.904969] Starting dynamic subtest: vecs0
[223.975675] Dynamic subtest vecs0: SUCCESS (0.079s)
[223.985185] Starting dynamic subtest: ccs0
[224.048523] Dynamic subtest ccs0: SUCCESS (0.072s)
[224.051094] Subtest preempt-other-chain: SUCCESS (0.476s)
[225.056759] [018/129] (883s left) gem_flink_basic (bad-flink)
[225.116929] Starting subtest: bad-flink
[225.119776] Subtest bad-flink: SUCCESS (0.000s)
[225.204524] [019/129] (883s left) perf_pmu (init-sema)
[225.246359] Starting subtest: init-sema
[225.249461] Starting dynamic subtest: rcs0
[225.252332] Dynamic subtest rcs0: SUCCESS (0.002s)
[225.260862] Starting dynamic subtest: bcs0
[225.263464] Dynamic subtest bcs0: SUCCESS (0.001s)
[225.272207] Starting dynamic subtest: vcs0
[225.274956] Dynamic subtest vcs0: SUCCESS (0.001s)
[225.283104] Starting dynamic subtest: vcs1
[225.285829] Dynamic subtest vcs1: SUCCESS (0.001s)
[225.294040] Starting dynamic subtest: vecs0
[225.296200] Dynamic subtest vecs0: SUCCESS (0.001s)
[225.303567] Starting dynamic subtest: ccs0
[225.305713] Dynamic subtest ccs0: SUCCESS (0.001s)
[225.308001] Subtest init-sema: SUCCESS (0.006s)
[225.341732] [020/129] (883s left) kms_psr (psr-basic)
[225.444750] Starting subtest: psr-basic
[225.447135] Starting dynamic subtest: eDP-1
[227.096073] Dynamic subtest eDP-1: SUCCESS (1.640s)
[227.099188] Subtest psr-basic: SUCCESS (1.641s)
[227.974562] [021/129] (880s left) kms_color (invalid-ctm-matrix-sizes)
[228.077325] Starting subtest: invalid-ctm-matrix-sizes
[228.079993] Starting dynamic subtest: pipe-A
[228.082506] Dynamic subtest pipe-A: SUCCESS (0.004s)
[228.090722] Starting dynamic subtest: pipe-B
[228.093206] Dynamic subtest pipe-B: SUCCESS (0.003s)
[228.101304] Starting dynamic subtest: pipe-C
[228.103738] Dynamic subtest pipe-C: SUCCESS (0.004s)
[228.111896] Starting dynamic subtest: pipe-D
[228.114421] Dynamic subtest pipe-D: SUCCESS (0.004s)
[228.116973] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[228.163241] [022/129] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[228.273844] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[228.279173] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[228.365676] [023/129] (880s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[228.479115] Starting subtest: x-tiled-8bpp-rotate-270
[228.500494] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[228.629070] [024/129] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[228.728964] Starting subtest: psr-2p-primscrn-cur-indfb-move
[228.734048] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[228.834360] [025/129] (880s left) gem_lmem_swapping (heavy-multi)
[228.878182] Subtest heavy-multi: SKIP (0.000s)
[228.919676] [026/129] (880s left) perf_pmu (busy-no-semaphores)
[228.959834] Starting subtest: busy-no-semaphores
[228.962009] Starting dynamic subtest: rcs0
[229.532789] Dynamic subtest rcs0: SUCCESS (0.569s)
[229.542776] Starting dynamic subtest: bcs0
[230.083113] Dynamic subtest bcs0: SUCCESS (0.547s)
[230.093427] Starting dynamic subtest: vcs0
[230.631661] Dynamic subtest vcs0: SUCCESS (0.545s)
[230.643360] Starting dynamic subtest: vcs1
[232.505836] Dynamic subtest vcs1: SUCCESS (1.867s)
[232.517434] Starting dynamic subtest: vecs0
[234.552213] Dynamic subtest vecs0: SUCCESS (2.040s)
[234.564109] Starting dynamic subtest: ccs0
[236.538813] Dynamic subtest ccs0: SUCCESS (1.982s)
[236.542063] Subtest busy-no-semaphores: SUCCESS (7.556s)
[236.666047] [027/129] (872s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[236.787777] Starting subtest: fbcpsr-1p-rte
[241.643012] Subtest fbcpsr-1p-rte: SUCCESS (4.851s)
[241.805009] [028/129] (867s left) kms_rotation_crc (primary-rotation-180)
[241.899951] Starting subtest: primary-rotation-180
[248.940781] Subtest primary-rotation-180: SUCCESS (7.032s)
[250.093635] [029/129] (859s left) gem_userptr_blits (sync-unmap)
[250.157043] Starting subtest: sync-unmap
[250.170706] Subtest sync-unmap: SUCCESS (0.014s)
[250.289318] [030/129] (858s left) drm_fdinfo (memory-info-idle)
[250.327934] Starting subtest: memory-info-idle
[250.331078] Starting dynamic subtest: smem0
[250.387112] Dynamic subtest smem0: SUCCESS (0.060s)
[250.390383] Subtest memory-info-idle: SUCCESS (0.060s)
[250.455471] [031/129] (858s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[250.586174] Starting subtest: cursorA-vs-flipB-varying-size
[250.591965] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[250.680678] [032/129] (858s left) kms_cursor_crc (cursor-onscreen-max-size)
[250.965185] Starting subtest: cursor-onscreen-max-size
[250.973767] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[251.110381] [033/129] (858s left) kms_cursor_crc (cursor-offscreen-32x10)
[251.273914] Starting subtest: cursor-offscreen-32x10
[251.313513] Subtest cursor-offscreen-32x10: SKIP (0.035s)
[251.566447] [034/129] (857s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[251.666322] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[251.668893] Starting dynamic subtest: pipe-A-eDP-1
[251.693803] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[251.702812] Starting dynamic subtest: pipe-B-eDP-1
[251.727291] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[251.734998] Starting dynamic subtest: pipe-C-eDP-1
[251.758997] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[251.766595] Starting dynamic subtest: pipe-D-eDP-1
[251.790059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[251.794535] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[253.845781] [035/129] (855s left) syncobj_wait (wait-all-snapshot)
[253.912502] Starting subtest: wait-all-snapshot
[253.993612] Subtest wait-all-snapshot: SUCCESS (0.082s)
[254.067558] [036/129] (855s left) kms_writeback (writeback-invalid-parameters)
[254.173032] Subtest writeback-invalid-parameters: SKIP (0.000s)
[254.213453] [037/129] (855s left) gem_mmap_gtt (zero-extend)
[254.277063] Subtest zero-extend: SKIP (0.000s)
[254.330823] [038/129] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[254.428214] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[254.433656] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[254.535166] [039/129] (855s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[254.630605] Starting subtest: fbcpsr-tiling-linear
[259.133665] Subtest fbcpsr-tiling-linear: SUCCESS (4.508s)
[259.283671] [040/129] (850s left) gem_create (create-invalid-size)
[259.347013] Starting subtest: create-invalid-size
[259.349015] Subtest create-invalid-size: SUCCESS (0.000s)
[259.529504] [041/129] (850s left) kms_flip (2x-flip-vs-dpms)
[259.626076] Starting subtest: 2x-flip-vs-dpms
[259.637476] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[259.709235] [042/129] (849s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[259.772707] Starting subtest: invalid-multi-wait-all-unsubmitted
[259.775182] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[259.853053] [043/129] (849s left) gem_mmap (short-mmap)
[259.914746] Subtest short-mmap: SKIP (0.000s)
[259.973902] [044/129] (849s left) gem_exec_balancer (semaphore)
[260.036070] Starting subtest: semaphore
[261.990195] Subtest semaphore: SUCCESS (1.952s)
[262.312553] [045/129] (847s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[262.418779] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[262.423455] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.526460] [046/129] (847s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[262.585639] Starting subtest: y-tiled-to-vebox-x-tiled
[262.591012] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[262.766914] [047/129] (847s left) kms_prop_blob (blob-prop-validate)
[262.826434] Starting subtest: blob-prop-validate
[262.829028] Subtest blob-prop-validate: SUCCESS (0.000s)
[262.931482] [048/129] (846s left) gem_exec_suspend (basic)
[262.997222] Starting subtest: basic
[263.000039] Starting dynamic subtest: smem
[265.012289] Dynamic subtest smem: SUCCESS (2.014s)
[265.015107] Subtest basic: SUCCESS (2.015s)
[265.193874] [049/129] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[265.307069] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[265.312626] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[265.386080] [050/129] (844s left) gem_mmap_wc (write-read)
[265.447924] Subtest write-read: SKIP (0.000s)
[265.510950] [051/129] (844s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[265.642680] Starting subtest: 2x-cursor-vs-flip-atomic
[265.647441] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[265.738534] [052/129] (844s left) kms_invalid_mode (bad-hsync-end)
[265.832720] Starting subtest: bad-hsync-end
[265.834964] Starting dynamic subtest: pipe-A-eDP-1
[266.117994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[266.127099] Starting dynamic subtest: pipe-B-eDP-1
[266.129337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[266.138039] Starting dynamic subtest: pipe-C-eDP-1
[266.140922] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[266.149219] Starting dynamic subtest: pipe-D-eDP-1
[266.152028] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[266.154926] Subtest bad-hsync-end: SUCCESS (0.288s)
[266.920034] [053/129] (843s left) kms_psr (fbc-pr-cursor-render)
[267.022058] Starting subtest: fbc-pr-cursor-render
[267.027409] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[267.090851] [054/129] (843s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[267.188757] Starting subtest: stress-xrgb8888-ytiled
[267.194007] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[267.249248] [055/129] (842s left) kms_vblank (query-busy-hang)
[267.340574] Starting subtest: query-busy-hang
[267.343638] Starting dynamic subtest: pipe-A-eDP-1
[294.767715] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.417s)
[294.782789] Starting dynamic subtest: pipe-D-eDP-1
[319.785763] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.011s)
[319.788071] Subtest query-busy-hang: SUCCESS (52.431s)
[320.568746] [056/129] (789s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[322.211409] Starting subtest: dpms-mode-unset-non-lpsp
[323.370203] Subtest dpms-mode-unset-non-lpsp: SKIP (1.157s)
[323.728996] [057/129] (786s left) gem_readwrite (read-write)
[323.787110] Subtest read-write: SKIP (0.000s)
[323.854394] [058/129] (786s left) kms_atomic_transition (modeset-transition-nonblocking)
[323.959942] Starting subtest: modeset-transition-nonblocking
[323.962670] Starting dynamic subtest: 1x-outputs
[334.435727] Dynamic subtest 1x-outputs: SUCCESS (10.476s)
[334.711965] Subtest modeset-transition-nonblocking: SUCCESS (10.752s)
[335.559424] [059/129] (774s left) syncobj_timeline (wait-any-interrupted)
[335.609015] Starting subtest: wait-any-interrupted
[335.709828] Subtest wait-any-interrupted: SUCCESS (0.102s)
[335.782609] [060/129] (774s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[335.881447] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[335.885873] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[335.980547] [061/129] (774s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[340.994110] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[340.999677] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[341.846443] [062/129] (768s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[341.947690] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[341.950171] Starting dynamic subtest: pipe-A
[342.022649] Dynamic subtest pipe-A: SUCCESS (0.075s)
[342.032899] Starting dynamic subtest: pipe-B
[343.170055] Dynamic subtest pipe-B: SUCCESS (1.146s)
[343.180937] Starting dynamic subtest: pipe-C
[344.275192] Dynamic subtest pipe-C: SUCCESS (1.105s)
[344.290400] Starting dynamic subtest: pipe-D
[345.397523] Dynamic subtest pipe-D: SUCCESS (1.121s)
[345.400194] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.450s)
[346.544900] [063/129] (763s left) gem_exec_schedule (u-submit-golden-slice)
[346.615062] Starting subtest: u-submit-golden-slice
[346.618035] Starting dynamic subtest: rcs0
[346.644458] Dynamic subtest rcs0: SUCCESS (0.039s)
[346.657819] Starting dynamic subtest: bcs0
[346.673642] Dynamic subtest bcs0: SUCCESS (0.029s)
[346.682680] Starting dynamic subtest: vcs0
[346.703025] Dynamic subtest vcs0: SUCCESS (0.029s)
[346.714723] Starting dynamic subtest: vcs1
[346.733104] Dynamic subtest vcs1: SUCCESS (0.029s)
[346.748090] Starting dynamic subtest: vecs0
[346.762200] Dynamic subtest vecs0: SUCCESS (0.028s)
[346.773486] Starting dynamic subtest: ccs0
[346.790450] Dynamic subtest ccs0: SUCCESS (0.028s)
[346.793179] Subtest u-submit-golden-slice: SUCCESS (0.185s)
[348.107611] [064/129] (762s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[348.219898] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[348.222751] Starting dynamic subtest: pipe-A-eDP-1
[348.248790] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[348.258227] Starting dynamic subtest: pipe-B-eDP-1
[348.284402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[348.293858] Starting dynamic subtest: pipe-C-eDP-1
[348.321186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.330922] Starting dynamic subtest: pipe-D-eDP-1
[348.357643] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.362856] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[350.403483] [065/129] (760s left) gem_eio (in-flight-internal-1us)
[350.640505] Starting subtest: in-flight-internal-1us
[352.069936] Subtest in-flight-internal-1us: SUCCESS (1.429s)
[352.218485] [066/129] (758s left) kms_cursor_crc (cursor-sliding-64x64)
[352.402330] Starting subtest: cursor-sliding-64x64
[352.407946] Starting dynamic subtest: pipe-A-eDP-1
[356.139899] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.731s)
[356.167750] Starting dynamic subtest: pipe-D-eDP-1
[360.448650] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.289s)
[360.451584] Subtest cursor-sliding-64x64: SUCCESS (8.044s)
[361.245049] [067/129] (749s left) kms_atomic_interruptible (universal-setplane-cursor)
[361.350973] Starting subtest: universal-setplane-cursor
[361.353648] Starting dynamic subtest: pipe-A-eDP-1
[368.762542] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.409s)
[368.764967] Subtest universal-setplane-cursor: SUCCESS (7.410s)
[369.595461] [068/129] (741s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[369.704174] Starting subtest: y-tiled-16bpp-rotate-180
[369.709778] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[369.807501] [069/129] (740s left) gem_mmap (basic)
[369.869657] Subtest basic: SKIP (0.000s)
[369.931368] [070/129] (740s left) kms_psr (psr2-cursor-plane-move)
[370.027880] Starting subtest: psr2-cursor-plane-move
[370.030394] Starting dynamic subtest: eDP-1
[371.670821] Dynamic subtest eDP-1: SUCCESS (1.641s)
[371.673190] Subtest psr2-cursor-plane-move: SUCCESS (1.642s)
[372.451637] [071/129] (738s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[372.558584] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[377.751152] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.195s)
[377.864799] [072/129] (732s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[377.980616] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[377.983067] Starting dynamic subtest: A-eDP1
[386.951200] Dynamic subtest A-eDP1: SUCCESS (8.968s)
[386.959817] Starting dynamic subtest: B-eDP1
[395.879839] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[395.889220] Starting dynamic subtest: C-eDP1
[404.794195] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[404.803435] Starting dynamic subtest: D-eDP1
[413.723180] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[413.726233] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.736s)
[414.944852] [073/129] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[415.050005] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[415.054379] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[415.157658] [074/129] (695s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[415.273090] Starting subtest: basic-busy-flip-before-cursor-varying-size
[415.277976] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[415.406480] [075/129] (695s left) drm_fdinfo (memory-info-shared)
[415.446488] Starting subtest: memory-info-shared
[415.448966] Starting dynamic subtest: smem0
[415.524202] Dynamic subtest smem0: SUCCESS (0.078s)
[415.527171] Subtest memory-info-shared: SUCCESS (0.078s)
[415.596989] [076/129] (695s left) kms_flip (2x-absolute-wf_vblank)
[415.696045] Starting subtest: 2x-absolute-wf_vblank
[415.707475] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[415.783571] [077/129] (695s left) gem_exec_reloc (basic-cpu-wc-active)
[415.842790] Subtest basic-cpu-wc-active: SKIP (0.000s)
[415.918254] [078/129] (695s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[415.972636] Starting subtest: single-wait-for-submit-unsubmitted
[416.081592] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.109s)
[416.152660] [079/129] (694s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[416.255344] Starting subtest: x-tiled-16bpp-rotate-90
[416.275568] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[416.394347] [080/129] (694s left) fbdev (write)
[416.439625] Starting subtest: write
[416.799911] Subtest write: SUCCESS (0.359s)
[416.862707] [081/129] (694s left) gem_exec_reloc (basic-scanout)
[416.923158] Subtest basic-scanout: SKIP (0.000s)
[416.982915] [082/129] (694s left) api_intel_allocator (execbuf-with-allocator)
[417.032974] Starting subtest: execbuf-with-allocator
[417.037729] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[417.149253] [083/129] (694s left) gem_close_race (basic-process)
[417.215815] Starting subtest: basic-process
[417.290877] Subtest basic-process: SUCCESS (0.075s)
[417.473421] [084/129] (693s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[417.594118] Starting subtest: cursorB-vs-flipA-atomic-transitions
[417.599119] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[417.721070] [085/129] (693s left) gem_exec_balancer (bonded-chain)
[417.775905] Starting subtest: bonded-chain
[424.624621] Subtest bonded-chain: SUCCESS (6.845s)
[424.946394] [086/129] (686s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[425.048946] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[425.051620] Starting dynamic subtest: pipe-A-default-mode
[425.367196] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[425.373039] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.316s)
[426.176528] [087/129] (685s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[426.289038] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[426.294089] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[426.388499] [088/129] (684s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[426.492202] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[426.494993] Starting dynamic subtest: pipe-A-eDP-1
[458.570193] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.800s)
[458.579305] Starting dynamic subtest: pipe-B-eDP-1
[491.445972] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.418s)
[491.455659] Starting dynamic subtest: pipe-C-eDP-1
[524.433842] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.359s)
[524.444876] Starting dynamic subtest: pipe-D-eDP-1
[557.433850] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.431s)
[557.436110] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.012s)
[558.661227] [089/129] (670s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[558.762643] Starting subtest: fbc-psr2-primary-mmap-cpu
[558.764989] Starting dynamic subtest: eDP-1
[558.769283] Dynamic subtest eDP-1: SKIP (0.000s)
[558.773619] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[558.837681] [090/129] (670s left) gen9_exec_parse (unaligned-access)
[558.900997] Subtest unaligned-access: SKIP (0.000s)
[558.972474] [091/129] (670s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[559.038059] Starting subtest: multi-wait-all-available-submitted-signaled
[559.040493] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[559.140568] [092/129] (670s left) kms_async_flips (async-flip-suspend-resume)
[559.236483] Starting subtest: async-flip-suspend-resume
[559.625813] Starting dynamic subtest: pipe-A-eDP-1
[577.372432] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.803s)
[577.743140] Starting dynamic subtest: pipe-B-eDP-1
[580.504600] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.729s)
[580.874402] Starting dynamic subtest: pipe-C-eDP-1
[583.666733] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s)
[584.036174] Starting dynamic subtest: pipe-D-eDP-1
[586.823763] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[586.826412] Subtest async-flip-suspend-resume: SUCCESS (12.545s)
[588.022188] [093/129] (656s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[588.127209] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[588.132225] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[588.211697] [094/129] (656s left) kms_psr (fbc-psr-primary-mmap-cpu)
[588.315856] Starting subtest: fbc-psr-primary-mmap-cpu
[588.318398] Starting dynamic subtest: eDP-1
[588.323971] Dynamic subtest eDP-1: SKIP (0.000s)
[588.329221] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[588.382576] [095/129] (656s left) kms_draw_crc (draw-method-pwrite)
[588.483908] Starting subtest: draw-method-pwrite
[588.486135] Starting dynamic subtest: xrgb8888-untiled
[589.082286] Dynamic subtest xrgb8888-untiled: SUCCESS (0.598s)
[589.091562] Starting dynamic subtest: rgb565-untiled
[589.528407] Dynamic subtest rgb565-untiled: SUCCESS (0.443s)
[589.537772] Starting dynamic subtest: xrgb2101010-untiled
[590.085980] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[590.095249] Starting dynamic subtest: xbgr16161616f-untiled
[590.888982] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s)
[590.898441] Starting dynamic subtest: xrgb8888-xtiled
[592.750130] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.855s)
[592.760431] Starting dynamic subtest: rgb565-xtiled
[593.887394] Dynamic subtest rgb565-xtiled: SUCCESS (1.133s)
[593.899018] Starting dynamic subtest: xrgb2101010-xtiled
[595.701779] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.811s)
[595.712399] Starting dynamic subtest: xbgr16161616f-xtiled
[599.142554] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.432s)
[599.152917] Starting dynamic subtest: xrgb8888-4tiled
[600.254275] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.111s)
[600.265394] Starting dynamic subtest: rgb565-4tiled
[600.843400] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s)
[600.854386] Starting dynamic subtest: xrgb2101010-4tiled
[601.956037] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.111s)
[601.965148] Starting dynamic subtest: xbgr16161616f-4tiled
[604.959121] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.999s)
[604.961414] Subtest draw-method-pwrite: SUCCESS (16.443s)
[605.084615] [096/129] (639s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[605.153006] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[605.155278] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[605.258789] [097/129] (639s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[605.308000] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[605.310125] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[605.398904] [098/129] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[605.519244] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[605.524413] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[605.602147] [099/129] (639s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[605.737262] Starting subtest: verify-pxp-key-change-after-suspend-resume
[612.768262] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.030s)
[612.896636] [100/129] (631s left) perf (non-system-wide-paranoid)
[613.015639] Starting subtest: non-system-wide-paranoid
[613.050233] Subtest non-system-wide-paranoid: SUCCESS (0.034s)
[613.094128] [101/129] (631s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers)
[613.198235] Starting subtest: plane-downscale-factor-0-25-with-modifiers
[613.201226] Starting dynamic subtest: pipe-A
[613.215134] Dynamic subtest pipe-A: SKIP (0.011s)
[613.225147] Starting dynamic subtest: pipe-B
[613.239329] Dynamic subtest pipe-B: SKIP (0.023s)
[613.248734] Starting dynamic subtest: pipe-C
[613.259315] Dynamic subtest pipe-C: SKIP (0.021s)
[613.268248] Starting dynamic subtest: pipe-D
[613.282765] Dynamic subtest pipe-D: SKIP (0.021s)
[613.287081] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.077s)
[613.389729] [102/129] (631s left) gem_tiled_partial_pwrite_pread (writes)
[613.458580] Subtest writes: SKIP (0.000s)
[613.536330] [103/129] (631s left) gem_workarounds (basic-read-fd)
[613.601338] Starting subtest: basic-read-fd
[613.612228] Subtest basic-read-fd: SUCCESS (0.010s)
[613.737093] [104/129] (631s left) kms_psr2_su (page_flip-p010)
[613.801285] Subtest page_flip-P010: SKIP (0.000s)
[613.861633] [105/129] (631s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[613.921659] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[614.026693] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[614.097771] [106/129] (630s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[614.207978] Starting subtest: psr-rgb565-draw-pwrite
[619.066132] Subtest psr-rgb565-draw-pwrite: SUCCESS (4.863s)
[619.176438] [107/129] (625s left) gem_ctx_isolation (nonpriv-switch)
[619.234215] Starting subtest: nonpriv-switch
[619.237139] Starting dynamic subtest: rcs0
[619.842707] Dynamic subtest rcs0: SUCCESS (0.607s)
[619.853201] Starting dynamic subtest: bcs0
[620.527247] Dynamic subtest bcs0: SUCCESS (0.684s)
[620.537789] Starting dynamic subtest: vcs0
[621.144347] Dynamic subtest vcs0: SUCCESS (0.616s)
[621.155738] Starting dynamic subtest: vcs1
[622.341919] Dynamic subtest vcs1: SUCCESS (1.197s)
[622.353157] Starting dynamic subtest: vecs0
[624.413300] Dynamic subtest vecs0: SUCCESS (2.070s)
[624.424898] Starting dynamic subtest: ccs0
[626.365310] Dynamic subtest ccs0: SUCCESS (1.951s)
[626.368435] Subtest nonpriv-switch: SUCCESS (7.130s)
[626.640384] [108/129] (618s left) drm_read (short-buffer-nonblock)
[626.804854] Starting subtest: short-buffer-nonblock
[626.807213] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[626.948270] [109/129] (618s left) api_intel_bb (lot-of-buffers)
[627.010848] Starting subtest: lot-of-buffers
[627.914821] Subtest lot-of-buffers: SUCCESS (0.904s)
[628.378460] [110/129] (616s left) gem_exec_whisper (basic-fds-forked)
[628.440939] Starting subtest: basic-fds-forked
[652.576331] Subtest basic-fds-forked: SUCCESS (24.126s)
[652.756492] [111/129] (592s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[652.860598] Starting subtest: addfb25-y-tiled-legacy
[652.863092] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[652.970260] [112/129] (592s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[653.069080] Starting subtest: basic-max-pipe-crc-check
[653.074004] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[653.112193] [113/129] (592s left) core_getversion (all-cards)
[653.152679] Starting subtest: all-cards
[655.476959] Subtest all-cards: SUCCESS (2.327s)
[655.518443] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.amdgpu: true
[655.519096] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.xe: true
[655.522857] [114/129] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[655.632591] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[660.298076] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.668s)
[660.431108] [115/129] (584s left) i915_power (sanity)
[660.492408] Starting subtest: sanity
[664.543386] Subtest sanity: SUCCESS (4.042s)
[665.786256] [116/129] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[665.892609] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[665.898017] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[665.980201] [117/129] (579s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[666.080728] Starting subtest: yf-tiled-8bpp-rotate-90
[666.086402] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[666.166621] [118/129] (579s left) gem_userptr_blits (input-checking)
[666.234984] Starting subtest: input-checking
[666.237203] Subtest input-checking: SUCCESS (0.000s)
[666.383322] [119/129] (579s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[666.479114] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[666.481559] Starting dynamic subtest: pipe-A-eDP-1
[666.548195] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[666.557877] Starting dynamic subtest: pipe-B-eDP-1
[666.625827] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[666.636061] Starting dynamic subtest: pipe-C-eDP-1
[666.704215] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[666.714851] Starting dynamic subtest: pipe-D-eDP-1
[666.771229] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[666.775303] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[668.662916] [120/129] (576s left) gem_mmap (pf-nonblock)
[668.726412] Subtest pf-nonblock: SKIP (0.000s)
[668.780974] [121/129] (576s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[668.884392] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[668.889889] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[669.000497] [122/129] (576s left) prime_vgem (basic-blt)
[669.090563] Starting subtest: basic-blt
[669.120402] Subtest basic-blt: SUCCESS (0.031s)
[669.243631] [123/129] (576s left) i915_pm_freq_api (freq-reset)
[669.308346] Starting subtest: freq-reset
[669.311427] Starting dynamic subtest: gt0
[669.478476] Dynamic subtest gt0: SUCCESS (0.169s)
[669.488075] Starting dynamic subtest: gt1
[669.628128] Dynamic subtest gt1: SUCCESS (0.149s)
[669.630909] Subtest freq-reset: SUCCESS (0.319s)
[669.700720] [124/129] (576s left) kms_scaling_modes (scaling-mode-center)
[669.792051] Starting subtest: scaling-mode-center
[669.794593] Starting dynamic subtest: pipe-A-eDP-1
[669.923026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.130s)
[669.933079] Starting dynamic subtest: pipe-B-eDP-1
[671.089345] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[671.101388] Starting dynamic subtest: pipe-C-eDP-1
[672.201050] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[672.210824] Starting dynamic subtest: pipe-D-eDP-1
[673.333226] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[673.336184] Subtest scaling-mode-center: SUCCESS (3.542s)
[674.486659] [125/129] (571s left) gem_spin_batch (resubmit-new)
[674.549270] Starting subtest: resubmit-new
[674.552218] Starting dynamic subtest: rcs0
[674.558452] Dynamic subtest rcs0: SUCCESS (0.009s)
[674.568235] Starting dynamic subtest: bcs0
[674.570904] Dynamic subtest bcs0: SUCCESS (0.003s)
[674.580865] Starting dynamic subtest: vcs0
[674.583419] Dynamic subtest vcs0: SUCCESS (0.007s)
[674.593394] Starting dynamic subtest: vcs1
[674.596189] Dynamic subtest vcs1: SUCCESS (0.003s)
[674.605838] Starting dynamic subtest: vecs0
[674.608334] Dynamic subtest vecs0: SUCCESS (0.003s)
[674.617451] Starting dynamic subtest: ccs0
[674.620183] Dynamic subtest ccs0: SUCCESS (0.003s)
[674.622908] Subtest resubmit-new: SUCCESS (0.033s)
[675.756545] [126/129] (570s left) kms_chamelium_frames (vga-frame-dump)
[676.150731] Subtest vga-frame-dump: SKIP (0.000s)
[676.998172] [127/129] (568s left) vgem_basic (second-client)
[677.049435] Starting subtest: second-client
[677.072248] Subtest second-client: SUCCESS (0.022s)
[677.124153] [128/129] (568s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area)
[677.182971] Subtest fbc-dirty-rectangle-out-visible-area: SKIP (0.000s)
[677.235131] [129/129] (568s left) gem_pxp (create-protected-buffer)
[677.296958] Starting subtest: create-protected-buffer
[677.299728] Subtest create-protected-buffer: SUCCESS (0.000s)
[677.407839] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: drm_read
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_chamelium_frames
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: syncobj_eventfd
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_ctx_isolation
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: gem_flink_basic
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_color
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_lmem_swapping
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: drm_fdinfo
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_writeback
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: gem_mmap
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_prop_blob
results: parsing output: 47/ for test: gem_exec_suspend
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_mmap_wc
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_pipe_stress
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: gem_readwrite
results: parsing output: 57/ for test: kms_atomic_transition
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_mmap
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: drm_fdinfo
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: fbdev
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: gem_close_race
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_draw_crc
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 102/ for test: gem_workarounds
results: parsing output: 103/ for test: kms_psr2_su
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_isolation
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_multipipe_modeset
results: parsing output: 112/ for test: core_getversion
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: i915_power
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_mmap
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: i915_pm_freq_api
results: parsing output: 123/ for test: kms_scaling_modes
results: parsing output: 124/ for test: gem_spin_batch
results: parsing output: 125/ for test: kms_chamelium_frames
results: parsing output: 126/ for test: vgem_basic
results: parsing output: 127/ for test: kms_fbc_dirty_rect
results: parsing output: 128/ for test: gem_pxp
Done.