[63.335586] Initializing watchdogs
[63.335633]   /dev/watchdog0
[63.350318] [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]
[63.354928] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.357081] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.360234] [001/133] (960s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[63.487455] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[63.490352] Starting dynamic subtest: pipe-A-eDP-1
[63.516167] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[63.525243] Starting dynamic subtest: pipe-B-eDP-1
[63.547381] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[63.554830] Starting dynamic subtest: pipe-C-eDP-1
[63.576857] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[63.583521] Starting dynamic subtest: pipe-D-eDP-1
[63.606321] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[63.610708] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[65.782696] [002/133] (958s left) sw_sync (sync_expired_merge)
[65.821325] Starting subtest: sync_expired_merge
[66.897304] Subtest sync_expired_merge: SUCCESS (1.074s)
[66.984318] [003/133] (956s left) gem_pwrite_snooped
[67.391665] [004/133] (956s left) kms_sequence (get-forked-busy)
[67.635057] Starting subtest: get-forked-busy
[67.637606] Starting dynamic subtest: pipe-A-eDP-1
[69.612343] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.975s)
[69.621724] Starting dynamic subtest: pipe-B-eDP-1
[72.194379] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[72.203499] Starting dynamic subtest: pipe-C-eDP-1
[74.804877] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[74.813659] Starting dynamic subtest: pipe-D-eDP-1
[77.348556] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[77.350526] Subtest get-forked-busy: SUCCESS (9.710s)
[78.139991] [005/133] (945s left) gem_mmap (basic-small-bo)
[78.210957] Subtest basic-small-bo: SKIP (0.000s)
[78.268151] [006/133] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[78.358833] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[85.224870] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.868s)
[85.348723] [007/133] (938s left) gem_basic (create-close)
[85.415079] Starting subtest: create-close
[85.419807] Subtest create-close: SUCCESS (0.000s)
[85.520190] [008/133] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[85.620300] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[85.624401] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[85.710995] [009/133] (938s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[85.808596] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[85.812835] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[85.870497] [010/133] (938s left) gem_exec_whisper (basic-normal-all)
[85.945674] Starting subtest: basic-normal-all
[88.225386] Subtest basic-normal-all: SUCCESS (2.279s)
[88.419703] [011/133] (935s left) gem_exec_balancer (full-late-pulse)
[88.496411] Starting subtest: full-late-pulse
[92.830689] Subtest full-late-pulse: SUCCESS (4.334s)
[93.164727] [012/133] (931s left) kms_feature_discovery (chamelium)
[93.272733] Starting subtest: chamelium
[93.277184] Subtest chamelium: SKIP (0.000s)
[93.340939] [013/133] (931s left) prime_busy (before)
[93.399179] Starting subtest: before
[93.403780] Starting dynamic subtest: rcs0
[93.431854] Dynamic subtest rcs0: SUCCESS (0.029s)
[93.446844] Starting dynamic subtest: bcs0
[93.471205] Dynamic subtest bcs0: SUCCESS (0.039s)
[93.480684] Starting dynamic subtest: vcs0
[93.512721] Dynamic subtest vcs0: SUCCESS (0.041s)
[93.521748] Starting dynamic subtest: vcs1
[93.553560] Dynamic subtest vcs1: SUCCESS (0.041s)
[93.563164] Starting dynamic subtest: vecs0
[93.594693] Dynamic subtest vecs0: SUCCESS (0.041s)
[93.603458] Starting dynamic subtest: ccs0
[93.635292] Dynamic subtest ccs0: SUCCESS (0.040s)
[93.743046] Subtest before: SUCCESS (0.342s)
[93.827800] [014/133] (930s left) gem_ctx_isolation (preservation-s3)
[93.904068] Starting subtest: preservation-S3
[93.906866] Starting dynamic subtest: rcs0
[110.280477] Dynamic subtest rcs0: SUCCESS (2.179s)
[110.289605] Starting dynamic subtest: bcs0
[126.291595] Dynamic subtest bcs0: SUCCESS (1.381s)
[126.301759] Starting dynamic subtest: vcs0
[142.295907] Dynamic subtest vcs0: SUCCESS (2.504s)
[142.306484] Starting dynamic subtest: vcs1
[160.282240] Dynamic subtest vcs1: SUCCESS (4.953s)
[160.291569] Starting dynamic subtest: vecs0
[178.271979] Dynamic subtest vecs0: SUCCESS (4.945s)
[178.281085] Starting dynamic subtest: ccs0
[196.288209] Dynamic subtest ccs0: SUCCESS (3.171s)
[196.290804] Subtest preservation-S3: SUCCESS (19.135s)
[196.524107] [015/133] (827s left) kms_vrr (flip-suspend)
[196.625867] Starting subtest: flip-suspend
[196.632693] Subtest flip-suspend: SKIP (0.000s)
[196.699129] [016/133] (827s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[196.790003] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[196.794193] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[196.873008] [017/133] (827s left) kms_content_protection (lic-type-0)
[197.010030] Starting subtest: lic-type-0
[197.014697] Subtest lic-type-0: SKIP (0.000s)
[197.115027] [018/133] (827s left) gem_busy (busy)
[197.186364] Starting subtest: busy
[197.188721] Starting dynamic subtest: all-engines
[197.243120] Dynamic subtest all-engines: SUCCESS (0.057s)
[197.253619] Starting dynamic subtest: rcs0
[199.077890] Dynamic subtest rcs0: SUCCESS (1.819s)
[199.088190] Starting dynamic subtest: bcs0
[199.128682] Dynamic subtest bcs0: SUCCESS (0.048s)
[199.138200] Starting dynamic subtest: vcs0
[199.165955] Dynamic subtest vcs0: SUCCESS (0.038s)
[199.174970] Starting dynamic subtest: vcs1
[201.060972] Dynamic subtest vcs1: SUCCESS (1.881s)
[201.071598] Starting dynamic subtest: vecs0
[203.045227] Dynamic subtest vecs0: SUCCESS (1.975s)
[203.055683] Starting dynamic subtest: ccs0
[205.028898] Dynamic subtest ccs0: SUCCESS (1.975s)
[205.031387] Subtest busy: SUCCESS (7.798s)
[205.376824] [019/133] (819s left) api_intel_bb (render)
[205.433965] Starting subtest: render
[205.435902] Starting dynamic subtest: render-none-512
[205.538736] Dynamic subtest render-none-512: SUCCESS (0.108s)
[205.550744] Starting dynamic subtest: render-none-1024
[206.062517] Dynamic subtest render-none-1024: SUCCESS (0.521s)
[206.073117] Starting dynamic subtest: render-x-512
[206.150751] Dynamic subtest render-x-512: SUCCESS (0.089s)
[206.161386] Starting dynamic subtest: render-x-1024
[206.495261] Dynamic subtest render-x-1024: SUCCESS (0.342s)
[206.506948] Starting dynamic subtest: render-y-512
[206.581134] Dynamic subtest render-y-512: SUCCESS (0.086s)
[206.592633] Starting dynamic subtest: render-y-1024
[206.928228] Dynamic subtest render-y-1024: SUCCESS (0.344s)
[206.931023] Subtest render: SUCCESS (1.493s)
[207.047566] [020/133] (817s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[207.141025] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[207.145594] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[207.211048] [021/133] (817s left) gem_ctx_sseu (invalid-sseu)
[207.272999] Subtest invalid-sseu: SKIP (0.000s)
[207.348897] [022/133] (817s left) gem_exec_gttfill (multigpu-basic)
[207.516256] Starting subtest: multigpu-basic
[221.200114] Subtest multigpu-basic: SUCCESS (13.665s)
[221.290859] [023/133] (803s left) gem_lmem_swapping (verify-random-ccs)
[221.396199] Subtest verify-random-ccs: SKIP (0.000s)
[221.440485] [024/133] (803s left) kms_addfb_basic (bad-pitch-32)
[221.496143] Starting subtest: bad-pitch-32
[221.498708] Subtest bad-pitch-32: SUCCESS (0.000s)
[221.627953] [025/133] (803s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[221.732706] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[222.402006] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[222.588486] [026/133] (802s left) kms_atomic_interruptible (legacy-cursor)
[222.687151] Starting subtest: legacy-cursor
[222.689438] Starting dynamic subtest: pipe-A-eDP-1
[230.089486] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.397s)
[230.091753] Subtest legacy-cursor: SUCCESS (7.399s)
[230.936933] [027/133] (794s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[231.001022] Starting subtest: invalid-multi-wait-all-unsubmitted
[231.003338] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[231.104140] [028/133] (793s left) gem_partial_pwrite_pread (write)
[231.163206] Subtest write: SKIP (0.000s)
[231.234960] [029/133] (793s left) kms_atomic_transition (plane-toggle-modeset-transition)
[231.319584] Starting subtest: plane-toggle-modeset-transition
[231.322083] Starting dynamic subtest: pipe-A-eDP-1
[244.076224] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.753s)
[244.087976] Starting dynamic subtest: pipe-B-eDP-1
[256.512765] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.428s)
[256.515308] Subtest plane-toggle-modeset-transition: SUCCESS (25.186s)
[257.334440] [030/133] (767s left) kms_prop_blob (invalid-set-prop-any)
[257.388945] Starting subtest: invalid-set-prop-any
[257.390990] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[257.484572] [031/133] (767s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[257.581515] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[257.585885] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[257.709470] [032/133] (767s left) syncobj_timeline (wait-any-interrupted)
[257.772659] Starting subtest: wait-any-interrupted
[257.877346] Subtest wait-any-interrupted: SUCCESS (0.103s)
[257.952534] [033/133] (767s left) i915_pm_rpm (gem-mmap-type)
[260.191072] Starting subtest: gem-mmap-type
[260.193584] Starting dynamic subtest: wb-smem0
[263.690077] Dynamic subtest wb-smem0: SUCCESS (3.497s)
[263.702161] Starting dynamic subtest: wc-smem0
[266.851857] Dynamic subtest wc-smem0: SUCCESS (3.159s)
[266.862843] Starting dynamic subtest: uc-smem0
[269.735623] Dynamic subtest uc-smem0: SUCCESS (2.880s)
[269.737759] Subtest gem-mmap-type: SUCCESS (9.539s)
[269.820675] [034/133] (755s left) kms_flip (wf_vblank-ts-check)
[269.915626] Starting subtest: wf_vblank-ts-check
[269.918034] Starting dynamic subtest: A-eDP1
[278.848862] Dynamic subtest A-eDP1: SUCCESS (8.929s)
[278.861483] Starting dynamic subtest: B-eDP1
[287.787548] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[287.796718] Starting dynamic subtest: C-eDP1
[296.717106] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[296.726422] Starting dynamic subtest: D-eDP1
[305.643263] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[305.648103] Subtest wf_vblank-ts-check: SUCCESS (35.728s)
[306.887362] [035/133] (718s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[307.001447] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[314.364063] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.370s)
[314.478860] [036/133] (710s left) i915_drm_fdinfo (most-busy-idle-check-all)
[314.521536] Starting subtest: most-busy-idle-check-all
[314.524005] Starting dynamic subtest: rcs0
[314.528901] Dynamic subtest rcs0: SKIP (0.004s)
[314.538418] Starting dynamic subtest: bcs0
[314.542875] Dynamic subtest bcs0: SKIP (0.000s)
[314.554547] Starting dynamic subtest: vcs0
[314.558519] Dynamic subtest vcs0: SKIP (0.000s)
[314.566994] Starting dynamic subtest: vcs1
[314.570984] Dynamic subtest vcs1: SKIP (0.000s)
[314.579409] Starting dynamic subtest: vecs0
[314.583536] Dynamic subtest vecs0: SKIP (0.001s)
[314.592365] Starting dynamic subtest: ccs0
[314.596510] Dynamic subtest ccs0: SKIP (0.000s)
[314.600607] Subtest most-busy-idle-check-all: SKIP (0.008s)
[314.638316] [037/133] (710s left) gem_exec_schedule (reorder-wide)
[314.828594] Subtest reorder-wide: SKIP (0.000s)
[315.012402] [038/133] (710s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[315.107164] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[315.109452] Starting dynamic subtest: pipe-A-eDP-1
[315.132792] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.144487] Starting dynamic subtest: pipe-B-eDP-1
[315.166672] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.175726] Starting dynamic subtest: pipe-C-eDP-1
[315.197315] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.206243] Starting dynamic subtest: pipe-D-eDP-1
[315.228472] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.232556] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[317.386883] [039/133] (708s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[317.490017] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[321.779228] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.294s)
[322.887839] [040/133] (702s left) gem_exec_reloc (basic-cpu-read-noreloc)
[322.949386] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[323.020149] [041/133] (702s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[323.118592] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[323.122821] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[323.215504] [042/133] (702s left) kms_psr (pr-sprite-render)
[323.309051] Starting subtest: pr-sprite-render
[323.313637] Subtest pr-sprite-render: SKIP (0.000s)
[323.394690] [043/133] (702s left) kms_cursor_crc (cursor-offscreen-256x256)
[323.645385] Starting subtest: cursor-offscreen-256x256
[323.650257] Starting dynamic subtest: pipe-A-eDP-1
[325.652049] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.002s)
[325.684581] Starting dynamic subtest: pipe-D-eDP-1
[328.289045] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s)
[328.291369] Subtest cursor-offscreen-256x256: SUCCESS (4.641s)
[329.158990] [044/133] (696s left) gem_pxp (create-regular-buffer)
[329.288744] Starting subtest: create-regular-buffer
[329.291233] Subtest create-regular-buffer: SUCCESS (0.000s)
[329.403917] [045/133] (696s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[329.495971] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[329.584892] [046/133] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[329.688013] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[329.691985] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[329.781397] [047/133] (695s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[329.874258] Starting subtest: read-crc-frame-sequence
[329.876411] Starting dynamic subtest: pipe-A-eDP-1
[330.595799] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[330.606099] Starting dynamic subtest: pipe-B-eDP-1
[331.946742] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[331.957451] Starting dynamic subtest: pipe-C-eDP-1
[333.342807] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[333.352726] Starting dynamic subtest: pipe-D-eDP-1
[334.653707] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s)
[334.656867] Subtest read-crc-frame-sequence: SUCCESS (4.778s)
[335.487418] [048/133] (690s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[335.615319] Starting subtest: cursorB-vs-flipB-varying-size
[335.619836] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[335.765435] [049/133] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[335.864487] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[335.868883] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[335.965801] [050/133] (689s left) perf_pmu (enable-race)
[336.010328] Starting subtest: enable-race
[336.012655] Starting dynamic subtest: rcs0
[348.784993] Dynamic subtest rcs0: SUCCESS (12.773s)
[348.794783] Starting dynamic subtest: bcs0
[361.527017] Dynamic subtest bcs0: SUCCESS (12.737s)
[361.536784] Starting dynamic subtest: vcs0
[377.056766] Dynamic subtest vcs0: SUCCESS (15.522s)
[377.068396] Starting dynamic subtest: vcs1
[393.056805] Dynamic subtest vcs1: SUCCESS (15.992s)
[393.066696] Starting dynamic subtest: vecs0
[409.056656] Dynamic subtest vecs0: SUCCESS (15.993s)
[409.066957] Starting dynamic subtest: ccs0
[421.792951] Dynamic subtest ccs0: SUCCESS (12.731s)
[421.795493] Subtest enable-race: SUCCESS (85.761s)
[421.897302] [051/133] (604s left) sysfs_timeslice_duration (timeout)
[421.960375] Starting subtest: timeout
[421.962712] Starting dynamic subtest: vecs0
[432.026963] Dynamic subtest vecs0: SUCCESS (10.065s)
[432.037611] Starting dynamic subtest: ccs0
[433.283737] Dynamic subtest ccs0: SUCCESS (1.256s)
[433.300354] Starting dynamic subtest: vcs0
[443.039481] Dynamic subtest vcs0: SUCCESS (9.756s)
[443.050732] Starting dynamic subtest: bcs0
[443.682091] Dynamic subtest bcs0: SUCCESS (0.642s)
[443.692600] Starting dynamic subtest: rcs0
[444.928907] Dynamic subtest rcs0: SUCCESS (1.245s)
[444.941659] Starting dynamic subtest: vcs1
[454.047373] Dynamic subtest vcs1: SUCCESS (9.115s)
[454.049974] Subtest timeout: SUCCESS (32.090s)
[454.120576] [052/133] (571s left) gem_exec_reloc (basic-wc)
[454.191141] Subtest basic-wc: SKIP (0.000s)
[454.258005] [053/133] (571s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[454.378286] Starting subtest: y-tiled-16bpp-rotate-0
[454.382592] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[454.471685] [054/133] (571s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[454.589299] Starting subtest: cursorB-vs-flipA-varying-size
[454.593857] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[454.735085] [055/133] (571s left) gem_ctx_persistence (legacy-engines-mixed-process)
[454.793735] Starting subtest: legacy-engines-mixed-process
[454.796193] Starting dynamic subtest: render
[456.102969] Dynamic subtest render: SUCCESS (1.309s)
[456.114690] Starting dynamic subtest: bsd1
[458.106632] Dynamic subtest bsd1: SUCCESS (2.002s)
[458.120788] Starting dynamic subtest: bsd2
[460.046353] Dynamic subtest bsd2: SUCCESS (1.937s)
[460.056751] Starting dynamic subtest: blt
[462.033192] Dynamic subtest blt: SUCCESS (1.985s)
[462.044249] Starting dynamic subtest: vebox
[464.032566] Dynamic subtest vebox: SUCCESS (2.000s)
[464.034998] Subtest legacy-engines-mixed-process: SUCCESS (9.241s)
[464.119928] [056/133] (561s left) gen9_exec_parse (allowed-all)
[464.178195] Subtest allowed-all: SKIP (0.000s)
[464.241391] [057/133] (561s left) kms_pm_rpm (i2c)
[466.180350] Starting subtest: i2c
[471.531750] Subtest i2c: SUCCESS (5.355s)
[471.637629] [058/133] (554s left) gem_compute (compute-square)
[471.702606] Starting subtest: compute-square
[471.707857] Subtest compute-square: SUCCESS (0.006s)
[471.823874] [059/133] (554s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[471.940489] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[472.908809] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.968s)
[473.044071] [060/133] (553s left) kms_addfb_basic (small-bo)
[473.138896] Starting subtest: small-bo
[473.141201] Subtest small-bo: SUCCESS (0.000s)
[473.238893] [061/133] (553s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[473.352171] Starting subtest: x-tiled-64bpp-rotate-90
[473.371518] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[473.511917] [062/133] (552s left) kms_cursor_edge_walk (128x128-top-edge)
[473.610355] Starting subtest: 128x128-top-edge
[473.612375] Starting dynamic subtest: pipe-A-eDP-1
[477.079893] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[477.090577] Starting dynamic subtest: pipe-D-eDP-1
[480.211934] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[480.213895] Subtest 128x128-top-edge: SUCCESS (6.600s)
[481.020086] [063/133] (545s left) kms_chamelium_edid (hdmi-edid-read)
[481.419513] Subtest hdmi-edid-read: SKIP (0.000s)
[482.215359] [064/133] (544s left) kms_psr (fbc-psr-primary-render)
[482.318212] Starting subtest: fbc-psr-primary-render
[482.320152] Starting dynamic subtest: eDP-1
[482.324292] Dynamic subtest eDP-1: SKIP (0.000s)
[482.328651] Subtest fbc-psr-primary-render: SKIP (0.001s)
[482.388815] [065/133] (544s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[482.497451] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[487.835662] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.340s)
[489.057649] [066/133] (537s left) gem_linear_blits (normal)
[489.262677] Starting subtest: normal
[492.814234] Subtest normal: SUCCESS (3.550s)
[493.014905] [067/133] (533s left) kms_lease (cursor-implicit-plane)
[493.151637] Starting subtest: cursor-implicit-plane
[493.153966] Starting dynamic subtest: pipe-A-eDP-1
[493.620537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.468s)
[493.630752] Starting dynamic subtest: pipe-B-eDP-1
[494.765909] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[494.779787] Starting dynamic subtest: pipe-C-eDP-1
[495.878544] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[495.889029] Starting dynamic subtest: pipe-D-eDP-1
[496.998747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[497.001194] Subtest cursor-implicit-plane: SUCCESS (3.847s)
[497.860448] [068/133] (528s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[497.933832] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[497.936144] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[498.030939] [069/133] (528s left) kms_hdmi_inject (inject-4k)
[498.376618] Starting subtest: inject-4k
[498.701572] Subtest inject-4k: SUCCESS (0.322s)
[499.223057] [070/133] (527s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[499.314660] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[499.317358] Starting dynamic subtest: pipe-A-eDP-1
[499.340563] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.352197] Starting dynamic subtest: pipe-B-eDP-1
[499.373716] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.382770] Starting dynamic subtest: pipe-C-eDP-1
[499.403908] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.412846] Starting dynamic subtest: pipe-D-eDP-1
[499.434022] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.438239] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[501.597485] [071/133] (525s left) kms_pm_dc (dc5-dpms-negative)
[502.698158] Starting subtest: dc5-dpms-negative
[502.702676] Subtest dc5-dpms-negative: SKIP (0.000s)
[502.770240] [072/133] (524s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[502.870356] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[502.874444] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[502.960367] [073/133] (523s left) prime_vgem (fence-read-hang)
[503.109157] Subtest fence-read-hang: SKIP (0.000s)
[503.194577] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[503.198304] [074/133] (523s left) kms_hdr (static-toggle-dpms)
[503.297348] Starting subtest: static-toggle-dpms
[503.304189] Subtest static-toggle-dpms: SKIP (0.000s)
[503.379150] [075/133] (523s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[503.473738] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[503.478103] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[503.572943] [076/133] (523s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[503.679794] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[503.683499] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[503.772932] [077/133] (523s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[503.836745] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[503.941487] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[504.035079] [078/133] (523s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[504.131317] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[504.157600] Starting dynamic subtest: pipe-A-plane-0
[504.446981] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[504.457966] Starting dynamic subtest: pipe-A-plane-3
[504.680872] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[504.691178] Starting dynamic subtest: pipe-A-plane-5
[504.696106] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[505.751796] Starting dynamic subtest: pipe-B-plane-0
[506.043114] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[506.052774] Starting dynamic subtest: pipe-B-plane-3
[506.287392] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[506.297555] Starting dynamic subtest: pipe-B-plane-5
[506.302233] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[506.615573] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.485s)
[507.423568] [079/133] (519s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[507.478913] Starting subtest: mixed-tiled-to-y-tiled-ccs
[507.483309] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[507.663321] [080/133] (519s left) gem_exec_reloc (basic-gtt)
[507.720908] Subtest basic-gtt: SKIP (0.000s)
[507.800932] [081/133] (519s left) kms_psr (psr2-sprite-plane-move)
[507.901109] Starting subtest: psr2-sprite-plane-move
[507.903286] Starting dynamic subtest: eDP-1
[509.678089] Dynamic subtest eDP-1: SUCCESS (1.775s)
[509.680216] Subtest psr2-sprite-plane-move: SUCCESS (1.776s)
[510.495333] [082/133] (516s left) kms_atomic (test-only)
[510.588031] Starting subtest: test-only
[510.662355] Starting dynamic subtest: pipe-A-eDP-1
[513.129314] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.468s)
[513.131810] Subtest test-only: SUCCESS (2.543s)
[513.993446] [083/133] (513s left) sw_sync (sync_multi_producer_single_consumer)
[514.039085] Starting subtest: sync_multi_producer_single_consumer
[515.113442] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[515.179868] [084/133] (512s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[515.271249] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[522.001393] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.732s)
[522.126440] [085/133] (505s left) i915_suspend (fence-restore-untiled)
[522.181998] Starting subtest: fence-restore-untiled
[522.186400] Subtest fence-restore-untiled: SKIP (0.000s)
[522.281553] [086/133] (505s left) kms_vblank (ts-continuation-idle)
[522.370995] Starting subtest: ts-continuation-idle
[522.373150] Starting dynamic subtest: pipe-A-eDP-1
[522.773356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[522.788712] Starting dynamic subtest: pipe-D-eDP-1
[523.853866] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.077s)
[523.856281] Subtest ts-continuation-idle: SUCCESS (1.484s)
[524.689615] [087/133] (502s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[524.791517] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[524.795666] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[524.902686] [088/133] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[524.999831] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[525.004207] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[525.112212] [089/133] (502s left) kms_tv_load_detect (load-detect)
[525.172345] Subtest load-detect: SKIP (0.000s)
[525.235186] [090/133] (502s left) kms_dp_linktrain_fallback (dp-fallback)
[525.338535] Starting subtest: dp-fallback
[525.345357] Subtest dp-fallback: SKIP (0.000s)
[525.414630] [091/133] (502s left) gem_exec_schedule (pi-userfault)
[525.604918] Starting subtest: pi-userfault
[525.607320] Starting dynamic subtest: rcs0
[525.616096] Dynamic subtest rcs0: SUCCESS (0.013s)
[525.626626] Starting dynamic subtest: bcs0
[525.628919] Dynamic subtest bcs0: SUCCESS (0.009s)
[525.639228] Starting dynamic subtest: vcs0
[525.641192] Dynamic subtest vcs0: SUCCESS (0.011s)
[525.652209] Starting dynamic subtest: vcs1
[525.654353] Dynamic subtest vcs1: SUCCESS (0.007s)
[525.664808] Starting dynamic subtest: vecs0
[525.667185] Dynamic subtest vecs0: SUCCESS (0.009s)
[525.676607] Starting dynamic subtest: ccs0
[525.678895] Dynamic subtest ccs0: SUCCESS (0.009s)
[525.681154] Subtest pi-userfault: SUCCESS (0.063s)
[525.849093] [092/133] (501s left) perf (sysctl-defaults)
[525.944435] Starting subtest: sysctl-defaults
[525.946775] Subtest sysctl-defaults: SUCCESS (0.000s)
[526.040855] [093/133] (501s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[526.133697] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[526.136425] Starting dynamic subtest: pipe-A
[526.161377] Dynamic subtest pipe-A: SKIP (0.024s)
[526.172542] Starting dynamic subtest: pipe-B
[526.196267] Dynamic subtest pipe-B: SKIP (0.035s)
[526.208362] Starting dynamic subtest: pipe-C
[526.229344] Dynamic subtest pipe-C: SKIP (0.034s)
[526.239494] Starting dynamic subtest: pipe-D
[526.262993] Dynamic subtest pipe-D: SKIP (0.032s)
[526.266611] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.127s)
[526.381745] [094/133] (501s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[526.454189] Starting subtest: etime-multi-wait-for-submit-submitted
[526.555725] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[526.635083] [095/133] (501s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[526.934419] Starting subtest: cursor-rapid-movement-512x512
[526.938156] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[527.099001] [096/133] (500s left) syncobj_wait (single-wait-for-submit-submitted)
[527.146124] Starting subtest: single-wait-for-submit-submitted
[527.253255] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[527.331980] [097/133] (500s left) kms_flip (2x-flip-vs-dpms-on-nop)
[527.422385] Starting subtest: 2x-flip-vs-dpms-on-nop
[527.433719] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[527.512623] [098/133] (500s left) gem_exec_whisper (basic-queues-forked)
[527.575661] Starting subtest: basic-queues-forked
[551.991246] Subtest basic-queues-forked: SUCCESS (24.409s)
[552.180341] [099/133] (475s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[552.241558] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[552.244267] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[552.348887] [100/133] (475s left) syncobj_timeline (invalid-query-zero-handles)
[552.401263] Starting subtest: invalid-query-zero-handles
[552.403719] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[552.509290] [101/133] (475s left) sw_sync (alloc_fence)
[552.546732] Starting subtest: alloc_fence
[552.548869] Subtest alloc_fence: SUCCESS (0.000s)
[552.603670] [102/133] (475s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[552.695729] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[552.698053] Starting dynamic subtest: pipe-A-default-mode
[555.408737] Dynamic subtest pipe-A-default-mode: SUCCESS (2.714s)
[555.411097] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.716s)
[556.237567] [103/133] (471s left) kms_getfb (getfb2-accept-nv12)
[556.329266] Starting subtest: getfb2-accept-nv12
[556.331531] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[556.429058] [104/133] (471s left) dumb_buffer (create-clear)
[556.485997] Starting subtest: create-clear
[590.826557] Subtest create-clear: SUCCESS (34.331s)
[590.936456] [105/133] (437s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[591.048652] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[591.728501] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[591.896376] [106/133] (436s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[591.956497] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[591.958476] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[592.052724] [107/133] (436s left) kms_chamelium_audio (dp-audio-edid)
[592.427649] Subtest dp-audio-edid: SKIP (0.000s)
[593.272547] [108/133] (435s left) kms_psr (fbc-pr-sprite-plane-move)
[593.376246] Starting subtest: fbc-pr-sprite-plane-move
[593.380596] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[593.449577] [109/133] (434s left) kms_color (ctm-max)
[593.563414] Starting subtest: ctm-max
[593.565624] Starting dynamic subtest: pipe-A-eDP-1
[594.281267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[594.291689] Starting dynamic subtest: pipe-B-eDP-1
[595.717497] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[595.728350] Starting dynamic subtest: pipe-C-eDP-1
[597.054431] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.337s)
[597.065028] Starting dynamic subtest: pipe-D-eDP-1
[598.430667] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.376s)
[598.433100] Subtest ctm-max: SUCCESS (4.868s)
[599.308248] [110/133] (429s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[599.697384] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[600.481725] [111/133] (428s left) gem_exec_fence (syncobj-repeat)
[600.929125] Starting subtest: syncobj-repeat
[601.117915] Subtest syncobj-repeat: SUCCESS (0.187s)
[602.088503] [112/133] (426s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[602.191427] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[602.195568] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[602.293750] [113/133] (426s left) gem_spin_batch (legacy-resubmit)
[602.360303] Starting subtest: legacy-resubmit
[602.362678] Starting dynamic subtest: default
[602.368506] Dynamic subtest default: SUCCESS (0.007s)
[602.381510] Starting dynamic subtest: render
[602.383808] Dynamic subtest render: SUCCESS (0.001s)
[602.394036] Starting dynamic subtest: bsd
[602.395980] Dynamic subtest bsd: SUCCESS (0.003s)
[602.405576] Starting dynamic subtest: bsd1
[602.407503] Dynamic subtest bsd1: SUCCESS (0.003s)
[602.417004] Starting dynamic subtest: bsd2
[602.418876] Dynamic subtest bsd2: SUCCESS (0.001s)
[602.428365] Starting dynamic subtest: blt
[602.430252] Dynamic subtest blt: SUCCESS (0.002s)
[602.441973] Starting dynamic subtest: vebox
[602.443852] Dynamic subtest vebox: SUCCESS (0.003s)
[602.445708] Subtest legacy-resubmit: SUCCESS (0.025s)
[602.618753] [114/133] (425s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[602.686838] Starting subtest: yf-tiled-ccs-to-y-tiled
[602.691384] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[602.871657] [115/133] (425s left) gem_ctx_param (non-root-set)
[602.929217] Starting subtest: non-root-set
[602.953880] Subtest non-root-set: SUCCESS (0.025s)
[603.062464] [116/133] (425s left) i915_drm_fdinfo (virtual-busy-hang-all)
[603.107662] Starting subtest: virtual-busy-hang-all
[603.111742] Subtest virtual-busy-hang-all: SKIP (0.000s)
[603.184232] [117/133] (425s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[603.280215] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[603.282512] Starting dynamic subtest: pipe-A-eDP-1
[603.306513] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[603.319426] Starting dynamic subtest: pipe-B-eDP-1
[603.341304] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[603.352367] Starting dynamic subtest: pipe-C-eDP-1
[603.374328] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[603.384210] Starting dynamic subtest: pipe-D-eDP-1
[603.406053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[603.410432] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[605.499858] [118/133] (423s left) gem_fenced_exec_thrash (2-spare-fences)
[605.559959] Subtest 2-spare-fences: SKIP (0.000s)
[605.642169] [119/133] (423s left) syncobj_basic (bad-fd-to-handle)
[605.690065] Starting subtest: bad-fd-to-handle
[605.692305] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[605.813071] [120/133] (423s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[605.911362] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[605.915764] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[606.017156] [121/133] (422s left) kms_setmode (invalid-clone-exclusive-crtc)
[606.073106] Starting subtest: invalid-clone-exclusive-crtc
[606.079560] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[606.177354] [122/133] (422s left) gem_wait (busy)
[606.238344] Starting subtest: busy
[606.240601] Starting dynamic subtest: all-engines
[608.032236] Dynamic subtest all-engines: SUCCESS (1.792s)
[608.046500] Starting dynamic subtest: rcs0
[608.575711] Dynamic subtest rcs0: SUCCESS (0.542s)
[608.588512] Starting dynamic subtest: bcs0
[609.116767] Dynamic subtest bcs0: SUCCESS (0.540s)
[609.129112] Starting dynamic subtest: vcs0
[611.040303] Dynamic subtest vcs0: SUCCESS (1.921s)
[611.053196] Starting dynamic subtest: vcs1
[613.088664] Dynamic subtest vcs1: SUCCESS (2.045s)
[613.101465] Starting dynamic subtest: vecs0
[615.072544] Dynamic subtest vecs0: SUCCESS (1.981s)
[615.086227] Starting dynamic subtest: ccs0
[615.613559] Dynamic subtest ccs0: SUCCESS (0.540s)
[615.616209] Subtest busy: SUCCESS (9.373s)
[615.814197] [123/133] (413s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[615.910174] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[615.912550] Starting dynamic subtest: pipe-A
[617.104836] Dynamic subtest pipe-A: SUCCESS (1.196s)
[617.115314] Starting dynamic subtest: pipe-B
[619.313744] Dynamic subtest pipe-B: SUCCESS (2.207s)
[619.323733] Starting dynamic subtest: pipe-C
[620.531192] Dynamic subtest pipe-C: SUCCESS (1.216s)
[620.541483] Starting dynamic subtest: pipe-D
[621.742158] Dynamic subtest pipe-D: SUCCESS (1.210s)
[621.744385] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.833s)
[622.906842] [124/133] (406s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[623.008562] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[623.013008] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[623.110581] [125/133] (406s left) kms_psr (psr-sprite-plane-move)
[623.192979] Starting subtest: psr-sprite-plane-move
[623.195226] Starting dynamic subtest: eDP-1
[624.937878] Dynamic subtest eDP-1: SUCCESS (1.744s)
[624.940184] Subtest psr-sprite-plane-move: SUCCESS (1.746s)
[625.808444] [126/133] (403s left) gem_eio (in-flight-immediate)
[626.004928] Starting subtest: in-flight-immediate
[634.394635] Subtest in-flight-immediate: SUCCESS (8.385s)
[634.512037] [127/133] (394s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[634.605660] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[634.610001] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[634.707637] [128/133] (394s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[634.810504] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[634.823502] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.012s)
[634.916316] [129/133] (394s left) gem_mmap_offset (oob-read)
[634.978168] Starting subtest: oob-read
[634.980063] Subtest oob-read: SUCCESS (0.000s)
[635.074746] [130/133] (394s left) prime_mmap (test_userptr)
[635.132445] Starting subtest: test_userptr
[635.134822] Starting dynamic subtest: test_userptr-smem
[635.137055] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[635.139343] Subtest test_userptr: SUCCESS (0.003s)
[635.249865] [131/133] (394s left) gem_exec_balancer (smoke)
[635.317271] Starting subtest: smoke
[657.902902] Subtest smoke: SUCCESS (22.581s)
[658.846538] [132/133] (370s left) kms_psr2_su (page_flip-xrgb8888)
[658.927711] Subtest page_flip-XRGB8888: SKIP (0.000s)
[658.998494] [133/133] (370s left) kms_flip (flip-vs-rmfb)
[659.086875] Starting subtest: flip-vs-rmfb
[659.089224] Starting dynamic subtest: A-eDP1
[667.770374] Dynamic subtest A-eDP1: SUCCESS (8.683s)
[667.783980] Starting dynamic subtest: B-eDP1
[676.465071] Dynamic subtest B-eDP1: SUCCESS (8.689s)
[676.478453] Starting dynamic subtest: C-eDP1
[685.187844] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[685.201900] Starting dynamic subtest: D-eDP1
[693.872886] Dynamic subtest D-eDP1: SUCCESS (8.688s)
[693.877448] Subtest flip-vs-rmfb: SUCCESS (34.799s)
[695.092443] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: sw_sync
results: parsing output: 2/ for test: gem_pwrite_snooped
results: parsing output: 3/ for test: kms_sequence
results: parsing output: 4/ for test: gem_mmap
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: kms_feature_discovery
results: parsing output: 12/ for test: prime_busy
results: parsing output: 13/ for test: gem_ctx_isolation
results: parsing output: 14/ for test: kms_vrr
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: gem_busy
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: gem_ctx_sseu
results: parsing output: 21/ for test: gem_exec_gttfill
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_atomic_interruptible
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: gem_partial_pwrite_pread
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: kms_prop_blob
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_pipe_crc_basic
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: sysfs_timeslice_duration
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_compute
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_cursor_edge_walk
results: parsing output: 62/ for test: kms_chamelium_edid
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_linear_blits
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_hdmi_inject
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_pm_dc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: kms_hdr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_suspend
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_tv_load_detect
results: parsing output: 89/ for test: kms_dp_linktrain_fallback
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_getfb
results: parsing output: 103/ for test: dumb_buffer
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_chamelium_audio
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_color
results: parsing output: 109/ for test: kms_chamelium_hpd
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_spin_batch
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_fenced_exec_thrash
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_setmode
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_mmap_offset
results: parsing output: 129/ for test: prime_mmap
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_psr2_su
results: parsing output: 132/ for test: kms_flip
Done.