[58.031350] Initializing watchdogs
[58.031419]   /dev/watchdog0
[58.047691] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.052261] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.054521] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.057876] [001/132] (960s left) perf_pmu (busy-accuracy-2)
[58.123518] Starting subtest: busy-accuracy-2
[58.125799] Starting dynamic subtest: rcs0
[61.176240] Dynamic subtest rcs0: SUCCESS (3.050s)
[61.186564] Starting dynamic subtest: bcs0
[64.233256] Dynamic subtest bcs0: SUCCESS (3.056s)
[64.242766] Starting dynamic subtest: vcs0
[67.274335] Dynamic subtest vcs0: SUCCESS (3.040s)
[67.281937] Starting dynamic subtest: vcs1
[70.322527] Dynamic subtest vcs1: SUCCESS (3.047s)
[70.330243] Starting dynamic subtest: vecs0
[73.367446] Dynamic subtest vecs0: SUCCESS (3.044s)
[73.377251] Starting dynamic subtest: ccs0
[76.427686] Dynamic subtest ccs0: SUCCESS (3.058s)
[76.430071] Subtest busy-accuracy-2: SUCCESS (18.301s)
[76.562323] [002/132] (942s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[76.670614] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[76.672837] Starting dynamic subtest: pipe-A-eDP-1
[76.695099] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.702610] Starting dynamic subtest: pipe-B-eDP-1
[76.723170] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.730111] Starting dynamic subtest: pipe-C-eDP-1
[76.750446] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.757903] Starting dynamic subtest: pipe-D-eDP-1
[76.778885] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.782909] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[78.982617] [003/132] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[79.092935] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[79.097632] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[79.204984] [004/132] (939s left) gem_userptr_blits (process-exit-busy)
[79.278789] Starting subtest: process-exit-busy
[79.294900] Subtest process-exit-busy: SUCCESS (0.019s)
[79.454716] [005/132] (939s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[79.565358] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[79.577757] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[79.711366] [006/132] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[79.794091] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[79.798123] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[79.928306] [007/132] (938s left) gem_close_race (multigpu-basic-threads)
[79.992618] Starting subtest: multigpu-basic-threads
[79.996624] Subtest multigpu-basic-threads: SKIP (0.000s)
[80.250871] [008/132] (938s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[80.307471] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[80.418496] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[80.515548] [009/132] (938s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[80.602858] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[80.605180] Starting dynamic subtest: pipe-A-eDP-1
[80.636759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[80.645447] Starting dynamic subtest: pipe-B-eDP-1
[80.664727] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[80.671793] Starting dynamic subtest: pipe-C-eDP-1
[80.690826] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[80.698861] Starting dynamic subtest: pipe-D-eDP-1
[80.718196] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[80.720394] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[82.852194] [010/132] (936s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[82.949477] Starting subtest: plane-primary-overlay-mutable-zpos
[86.371685] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.421s)
[87.580218] [011/132] (931s left) gem_userptr_blits (forbidden-operations)
[87.655180] Starting subtest: forbidden-operations
[87.659506] Subtest forbidden-operations: SKIP (0.000s)
[87.821309] [012/132] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[87.922401] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[87.926556] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.060056] [013/132] (930s left) kms_flip (flip-vs-expired-vblank-interruptible)
[88.163590] Starting subtest: flip-vs-expired-vblank-interruptible
[88.165990] Starting dynamic subtest: A-eDP1
[96.861741] Dynamic subtest A-eDP1: SUCCESS (8.696s)
[96.869418] Starting dynamic subtest: B-eDP1
[105.494355] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[105.502491] Starting dynamic subtest: C-eDP1
[114.109339] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[114.116867] Starting dynamic subtest: D-eDP1
[122.741361] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[122.746491] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.582s)
[123.941564] [014/132] (895s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[124.042675] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[124.047239] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[124.153706] [015/132] (894s left) gem_eio (unwedge-stress)
[124.347730] Starting subtest: unwedge-stress
[124.349750] Starting dynamic subtest: render
[128.767605] Dynamic subtest render: SUCCESS (4.418s)
[128.781668] Starting dynamic subtest: bsd1
[146.383523] Dynamic subtest bsd1: SUCCESS (17.616s)
[146.398106] Starting dynamic subtest: bsd2
[164.356866] Dynamic subtest bsd2: SUCCESS (17.971s)
[164.370897] Starting dynamic subtest: blt
[164.374821] Dynamic subtest blt: SKIP (0.000s)
[164.382558] Starting dynamic subtest: vebox
[182.327642] Dynamic subtest vebox: SUCCESS (17.970s)
[182.329905] Subtest unwedge-stress: SUCCESS (57.977s)
[183.952205] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[183.955368] [016/132] (835s left) dumb_buffer (map-invalid-size)
[184.017062] Starting subtest: map-invalid-size
[184.019319] Subtest map-invalid-size: SUCCESS (0.000s)
[184.158888] [017/132] (834s left) perf (missing-sample-flags)
[184.298670] Starting subtest: missing-sample-flags
[184.301052] Subtest missing-sample-flags: SUCCESS (0.000s)
[184.342212] [018/132] (834s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[184.447208] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[184.449617] Starting dynamic subtest: pipe-A
[184.806984] Dynamic subtest pipe-A: SUCCESS (0.362s)
[184.815920] Starting dynamic subtest: pipe-B
[186.241551] Dynamic subtest pipe-B: SUCCESS (1.435s)
[186.251564] Starting dynamic subtest: pipe-C
[187.652942] Dynamic subtest pipe-C: SUCCESS (1.411s)
[187.661921] Starting dynamic subtest: pipe-D
[189.120566] Dynamic subtest pipe-D: SUCCESS (1.467s)
[189.122913] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.676s)
[190.360054] [019/132] (828s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[190.462446] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[190.464851] Starting dynamic subtest: pipe-A-eDP-1
[190.490931] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[190.500729] Starting dynamic subtest: pipe-B-eDP-1
[190.524888] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[190.533056] Starting dynamic subtest: pipe-C-eDP-1
[190.556979] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[190.567415] Starting dynamic subtest: pipe-D-eDP-1
[190.592090] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[190.596153] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[192.769291] [020/132] (826s left) kms_dsc (dsc-with-formats)
[192.866023] Starting subtest: dsc-with-formats
[192.904835] Subtest dsc-with-formats: SKIP (0.001s)
[192.962266] [021/132] (826s left) syncobj_timeline (invalid-signal-illegal-point)
[193.028319] Starting subtest: invalid-signal-illegal-point
[193.030658] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[193.159553] [022/132] (826s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[193.221086] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[193.223458] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[193.358068] [023/132] (826s left) kms_addfb_basic (unused-offsets)
[193.401746] Starting subtest: unused-offsets
[193.403982] Subtest unused-offsets: SUCCESS (0.000s)
[193.589565] [024/132] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[193.705917] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[200.813989] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.109s)
[200.988712] [025/132] (818s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[201.101505] Starting subtest: 4-tiled-64bpp-rotate-0
[202.603380] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.501s)
[202.826577] [026/132] (816s left) gem_exec_balancer (parallel-contexts)
[203.092468] Starting subtest: parallel-contexts
[206.066944] Subtest parallel-contexts: SUCCESS (2.974s)
[207.081330] [027/132] (812s left) gem_softpin (reverse)
[207.150632] Starting subtest: reverse
[207.158608] Subtest reverse: SUCCESS (0.011s)
[207.308591] [028/132] (812s left) perf_pmu (init-wait)
[207.344441] Starting subtest: init-wait
[207.346703] Starting dynamic subtest: rcs0
[207.349167] Dynamic subtest rcs0: SUCCESS (0.001s)
[207.358435] Starting dynamic subtest: bcs0
[207.360445] Dynamic subtest bcs0: SUCCESS (0.000s)
[207.369808] Starting dynamic subtest: vcs0
[207.371933] Dynamic subtest vcs0: SUCCESS (0.001s)
[207.379780] Starting dynamic subtest: vcs1
[207.381929] Dynamic subtest vcs1: SUCCESS (0.001s)
[207.389405] Starting dynamic subtest: vecs0
[207.391225] Dynamic subtest vecs0: SUCCESS (0.001s)
[207.399099] Starting dynamic subtest: ccs0
[207.401392] Dynamic subtest ccs0: SUCCESS (0.000s)
[207.403517] Subtest init-wait: SUCCESS (0.006s)
[207.474554] [029/132] (812s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[207.590660] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[207.594883] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[207.724852] [030/132] (812s left) kms_color (ctm-0-75)
[207.831158] Starting subtest: ctm-0-75
[207.833354] Starting dynamic subtest: pipe-A-eDP-1
[212.645248] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.814s)
[212.654479] Starting dynamic subtest: pipe-B-eDP-1
[218.264726] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.621s)
[218.276307] Starting dynamic subtest: pipe-C-eDP-1
[223.633809] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.367s)
[223.642615] Starting dynamic subtest: pipe-D-eDP-1
[228.956349] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.322s)
[228.958567] Subtest ctm-0-75: SUCCESS (21.125s)
[229.813768] [031/132] (789s left) sysfs_heartbeat_interval (idempotent)
[229.885738] Starting subtest: idempotent
[229.888116] Starting dynamic subtest: vecs0
[229.890483] Dynamic subtest vecs0: SUCCESS (0.001s)
[229.899623] Starting dynamic subtest: ccs0
[229.901514] Dynamic subtest ccs0: SUCCESS (0.001s)
[229.909205] Starting dynamic subtest: vcs0
[229.911075] Dynamic subtest vcs0: SUCCESS (0.000s)
[229.918787] Starting dynamic subtest: bcs0
[229.920687] Dynamic subtest bcs0: SUCCESS (0.001s)
[229.928283] Starting dynamic subtest: rcs0
[229.930195] Dynamic subtest rcs0: SUCCESS (0.000s)
[229.937896] Starting dynamic subtest: vcs1
[229.939825] Dynamic subtest vcs1: SUCCESS (0.000s)
[229.941746] Subtest idempotent: SUCCESS (0.007s)
[230.029118] [032/132] (789s left) gem_ctx_shared (q-in-order)
[230.094649] Starting subtest: Q-in-order
[230.097129] Starting dynamic subtest: rcs0
[230.211284] Dynamic subtest rcs0: SUCCESS (0.115s)
[230.221453] Starting dynamic subtest: vcs0
[230.307337] Dynamic subtest vcs0: SUCCESS (0.096s)
[230.323482] Starting dynamic subtest: vcs1
[230.389327] Dynamic subtest vcs1: SUCCESS (0.081s)
[230.405458] Starting dynamic subtest: vecs0
[230.464280] Dynamic subtest vecs0: SUCCESS (0.075s)
[230.479891] Starting dynamic subtest: ccs0
[230.553377] Dynamic subtest ccs0: SUCCESS (0.088s)
[230.556107] Subtest Q-in-order: SUCCESS (0.458s)
[232.049862] [033/132] (787s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[232.161445] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[233.139823] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.978s)
[233.308260] [034/132] (786s left) gen9_exec_parse (batch-invalid-length)
[233.373285] Subtest batch-invalid-length: SKIP (0.000s)
[233.440817] [035/132] (786s left) gem_workarounds (suspend-resume-fd)
[233.494301] Starting subtest: suspend-resume-fd
[249.741970] Subtest suspend-resume-fd: SUCCESS (5.675s)
[249.912248] [036/132] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[250.032871] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[250.037325] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[250.173043] [037/132] (769s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[250.291332] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[250.915970] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[251.136035] [038/132] (768s left) gem_lmem_swapping (parallel-multi)
[251.176174] Subtest parallel-multi: SKIP (0.000s)
[251.220031] [039/132] (768s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[251.315536] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[251.317841] Starting dynamic subtest: pipe-A-eDP-1
[251.326948] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[251.337207] Starting dynamic subtest: pipe-B-eDP-1
[251.346454] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[251.355241] Starting dynamic subtest: pipe-C-eDP-1
[251.363835] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[251.372052] Starting dynamic subtest: pipe-D-eDP-1
[251.380530] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[251.384673] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[253.596816] [040/132] (766s left) gem_eio (wait-1us)
[253.843168] Starting subtest: wait-1us
[254.207138] Subtest wait-1us: SUCCESS (0.365s)
[254.392402] [041/132] (765s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[254.518656] Starting subtest: cursorA-vs-flipB-atomic
[254.522492] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[254.693258] [042/132] (765s left) gem_userptr_blits (access-control)
[254.769603] Starting subtest: access-control
[254.773104] Subtest access-control: SKIP (0.000s)
[254.932996] [043/132] (765s left) prime_vgem (basic-fence-blt)
[255.017763] Starting subtest: basic-fence-blt
[255.097874] Subtest basic-fence-blt: SUCCESS (0.080s)
[255.262439] [044/132] (765s left) gem_exec_fence (submit-chain)
[255.457108] Starting subtest: submit-chain
[255.472639] Subtest submit-chain: SUCCESS (0.018s)
[257.611718] [045/132] (762s left) kms_pm_dc (dc6-psr)
[258.725472] Starting subtest: dc6-psr
[261.713557] Subtest dc6-psr: SUCCESS (2.986s)
[262.546770] [046/132] (757s left) i915_suspend (debugfs-reader)
[262.612044] Starting subtest: debugfs-reader
[280.732112] Subtest debugfs-reader: SUCCESS (3.143s)
[280.811032] [047/132] (739s left) gem_ctx_persistence (legacy-engines-cleanup)
[280.888416] Starting subtest: legacy-engines-cleanup
[280.890674] Starting dynamic subtest: render
[280.962939] Dynamic subtest render: SUCCESS (0.073s)
[280.975531] Starting dynamic subtest: bsd1
[280.997677] Dynamic subtest bsd1: SUCCESS (0.033s)
[281.007311] Starting dynamic subtest: bsd2
[281.085106] Dynamic subtest bsd2: SUCCESS (0.084s)
[281.097098] Starting dynamic subtest: blt
[281.106390] Dynamic subtest blt: SUCCESS (0.019s)
[281.115155] Starting dynamic subtest: vebox
[281.187125] Dynamic subtest vebox: SUCCESS (0.079s)
[281.189665] Subtest legacy-engines-cleanup: SUCCESS (0.299s)
[281.291176] [048/132] (739s left) core_getclient (basic)
[281.351099] Starting subtest: basic
[281.353146] Subtest basic: SUCCESS (0.000s)
[281.474773] [049/132] (739s left) gem_exec_whisper (basic-fds-priority-all)
[281.525452] Starting subtest: basic-fds-priority-all
[303.796265] Subtest basic-fds-priority-all: SUCCESS (22.253s)
[304.007015] [050/132] (716s left) gem_exec_schedule (preempt-queue-chain)
[304.088343] Subtest preempt-queue-chain: SKIP (0.000s)
[304.400403] [051/132] (716s left) kms_invalid_mode (zero-vdisplay)
[304.501431] Starting subtest: zero-vdisplay
[304.503746] Starting dynamic subtest: pipe-A-eDP-1
[304.802601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[304.812426] Starting dynamic subtest: pipe-B-eDP-1
[304.814622] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[304.823662] Starting dynamic subtest: pipe-C-eDP-1
[304.826018] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[304.837963] Starting dynamic subtest: pipe-D-eDP-1
[304.840388] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[304.842705] Subtest zero-vdisplay: SUCCESS (0.308s)
[305.678400] [052/132] (715s left) gem_ctx_param (invalid-get-ringsize)
[305.727006] Starting subtest: invalid-get-ringsize
[305.729408] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[305.874462] [053/132] (714s left) kms_cursor_crc (cursor-onscreen-128x42)
[306.096136] Starting subtest: cursor-onscreen-128x42
[306.143990] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[306.377517] [054/132] (714s left) gem_exec_async (forked-writes)
[306.434011] Starting subtest: forked-writes
[306.436393] Starting dynamic subtest: rcs0
[306.464068] Dynamic subtest rcs0: SUCCESS (0.030s)
[306.474495] Starting dynamic subtest: bcs0
[306.486739] Dynamic subtest bcs0: SUCCESS (0.022s)
[306.496362] Starting dynamic subtest: vcs0
[306.507947] Dynamic subtest vcs0: SUCCESS (0.020s)
[306.517465] Starting dynamic subtest: vcs1
[306.530171] Dynamic subtest vcs1: SUCCESS (0.021s)
[306.543519] Starting dynamic subtest: vecs0
[306.555767] Dynamic subtest vecs0: SUCCESS (0.025s)
[306.568997] Starting dynamic subtest: ccs0
[306.578600] Dynamic subtest ccs0: SUCCESS (0.022s)
[306.580383] Subtest forked-writes: SUCCESS (0.146s)
[306.851749] [055/132] (713s left) kms_pm_rpm (universal-planes)
[308.570607] Starting subtest: universal-planes
[308.573123] Starting dynamic subtest: plane-33
[317.058080] Dynamic subtest plane-33: SUCCESS (8.485s)
[317.069088] Starting dynamic subtest: plane-63
[325.358462] Dynamic subtest plane-63: SUCCESS (8.300s)
[325.370799] Starting dynamic subtest: plane-93
[333.643422] Dynamic subtest plane-93: SUCCESS (8.282s)
[333.655889] Starting dynamic subtest: plane-123
[341.933905] Dynamic subtest plane-123: SUCCESS (8.288s)
[341.947702] Starting dynamic subtest: plane-133
[350.550397] Dynamic subtest plane-133: SUCCESS (8.612s)
[350.564083] Starting dynamic subtest: plane-143
[358.924654] Dynamic subtest plane-143: SUCCESS (8.370s)
[358.927549] Subtest universal-planes: SUCCESS (50.353s)
[359.321881] [056/132] (661s left) kms_lease (lease-unleased-crtc)
[359.427516] Starting subtest: lease-unleased-crtc
[359.429829] Starting dynamic subtest: pipe-A-eDP-1
[359.728139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[359.738250] Starting dynamic subtest: pipe-B-eDP-1
[360.447977] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.714s)
[360.458754] Starting dynamic subtest: pipe-C-eDP-1
[360.460674] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[360.472263] Starting dynamic subtest: pipe-D-eDP-1
[360.474545] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[360.476481] Subtest lease-unleased-crtc: SUCCESS (1.042s)
[360.872430] [057/132] (660s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[360.981637] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[361.761568] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[361.961651] [058/132] (659s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[362.013590] Starting subtest: wait-all-for-submit-delayed-submit
[362.115092] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[362.219801] [059/132] (658s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[367.217486] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[367.219714] Starting dynamic subtest: pipe-A-eDP-1
[368.024828] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s)
[368.039487] Starting dynamic subtest: pipe-B-eDP-1
[369.156826] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[369.161180] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.938s)
[370.381672] [060/132] (650s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[370.485531] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[370.489668] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[370.620461] [061/132] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[370.728545] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[370.732652] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[370.854867] [062/132] (650s left) gem_mmap (bad-offset)
[370.922650] Subtest bad-offset: SKIP (0.000s)
[370.980072] [063/132] (650s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[371.079646] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[371.084075] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[371.219564] [064/132] (650s left) kms_chamelium_color (ctm-0-25)
[371.310124] Subtest ctm-0-25: SKIP (0.000s)
[371.356791] [065/132] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[371.452948] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[371.456872] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.587443] [066/132] (649s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[371.687144] Starting subtest: psr-2p-primscrn-cur-indfb-move
[371.690563] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[371.816878] [067/132] (649s left) gem_softpin (noreloc-s3)
[371.870666] Starting subtest: noreloc-S3
[391.832330] Subtest noreloc-S3: SUCCESS (5.386s)
[392.062210] [068/132] (629s left) gem_exec_schedule (thriceslice)
[392.139554] Starting subtest: thriceslice
[392.142254] Starting dynamic subtest: rcs0
[392.166678] Dynamic subtest rcs0: SUCCESS (0.037s)
[392.178112] Starting dynamic subtest: bcs0
[392.226440] Dynamic subtest bcs0: SUCCESS (0.059s)
[392.239009] Starting dynamic subtest: vcs0
[392.282555] Dynamic subtest vcs0: SUCCESS (0.055s)
[392.293987] Starting dynamic subtest: vcs1
[392.319664] Dynamic subtest vcs1: SUCCESS (0.035s)
[392.329969] Starting dynamic subtest: vecs0
[392.351488] Dynamic subtest vecs0: SUCCESS (0.031s)
[392.361641] Starting dynamic subtest: ccs0
[392.412517] Dynamic subtest ccs0: SUCCESS (0.060s)
[392.415380] Subtest thriceslice: SUCCESS (0.285s)
[394.122667] [069/132] (627s left) sriov_basic (enable-vfs-autoprobe-on)
[394.182332] Starting subtest: enable-vfs-autoprobe-on
[394.185301] Starting dynamic subtest: numvfs-1
[394.269924] Dynamic subtest numvfs-1: FAIL (0.037s)
[394.280031] Starting dynamic subtest: numvfs-2
[394.367439] Dynamic subtest numvfs-2: FAIL (0.004s)
[394.379044] Starting dynamic subtest: numvfs-3
[394.465419] Dynamic subtest numvfs-3: FAIL (0.003s)
[394.475296] Starting dynamic subtest: numvfs-4
[394.561061] Dynamic subtest numvfs-4: FAIL (0.004s)
[394.571185] Starting dynamic subtest: numvfs-5
[394.657492] Dynamic subtest numvfs-5: FAIL (0.003s)
[394.667759] Starting dynamic subtest: numvfs-6
[394.754662] Dynamic subtest numvfs-6: FAIL (0.004s)
[394.765363] Starting dynamic subtest: numvfs-7
[394.852426] Dynamic subtest numvfs-7: FAIL (0.003s)
[394.862653] Starting dynamic subtest: numvfs-random
[394.945279] Dynamic subtest numvfs-random: FAIL (0.003s)
[394.955489] Starting dynamic subtest: numvfs-all
[395.041837] Dynamic subtest numvfs-all: FAIL (0.003s)
[395.044264] Subtest enable-vfs-autoprobe-on: FAIL (0.667s)
[395.084071] [070/132] (626s left) api_intel_bb (blit-noreloc-purge-cache)
[395.138311] Starting subtest: blit-noreloc-purge-cache
[395.148025] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[395.271963] [071/132] (626s left) kms_hdr (bpc-switch-dpms)
[395.371182] Starting subtest: bpc-switch-dpms
[396.476484] Starting dynamic subtest: pipe-A-eDP-1
[400.897528] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.416s)
[400.900374] Subtest bpc-switch-dpms: SUCCESS (5.522s)
[401.042391] [072/132] (620s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[401.157328] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[401.163260] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[401.281364] [073/132] (620s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[401.336761] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[401.419215] [074/132] (620s left) perf_pmu (rc6)
[401.461118] Starting subtest: rc6
[401.463554] Starting dynamic subtest: gt0
[407.846324] Dynamic subtest gt0: SUCCESS (6.383s)
[407.858630] Starting dynamic subtest: runtime-pm-gt0
[415.576011] Dynamic subtest runtime-pm-gt0: SUCCESS (7.724s)
[415.588504] Starting dynamic subtest: runtime-pm-long-gt0
[428.001171] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.428s)
[428.012335] Starting dynamic subtest: other-idle-gt0
[434.342797] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[434.354663] Starting dynamic subtest: gt1
[440.686054] Dynamic subtest gt1: SUCCESS (6.341s)
[440.698495] Starting dynamic subtest: runtime-pm-gt1
[448.176896] Dynamic subtest runtime-pm-gt1: SUCCESS (7.487s)
[448.187501] Starting dynamic subtest: runtime-pm-long-gt1
[460.615372] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.434s)
[460.629034] Starting dynamic subtest: other-idle-gt1
[466.959560] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[466.962820] Subtest rc6: SUCCESS (65.497s)
[468.226267] [075/132] (553s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[468.322776] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[468.324671] Starting dynamic subtest: pipe-A-default-mode
[468.611300] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[468.616204] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s)
[469.458667] [076/132] (552s left) intel_hwmon (hwmon-read)
[469.516281] Subtest hwmon-read: SKIP (0.000s)
[469.593024] [077/132] (552s left) gem_sync (basic-many-each)
[469.670934] Starting subtest: basic-many-each
[471.938108] Subtest basic-many-each: SUCCESS (2.281s)
[472.100111] [078/132] (549s left) gen9_exec_parse (unaligned-access)
[472.171440] Subtest unaligned-access: SKIP (0.000s)
[472.251189] [079/132] (549s left) kms_flip (bo-too-big-interruptible)
[472.353409] Starting subtest: bo-too-big-interruptible
[472.356199] Starting dynamic subtest: A-eDP1
[473.626402] Dynamic subtest A-eDP1: SUCCESS (1.273s)
[473.638089] Starting dynamic subtest: B-eDP1
[474.863055] Dynamic subtest B-eDP1: SUCCESS (1.235s)
[474.876279] Starting dynamic subtest: C-eDP1
[476.193897] Dynamic subtest C-eDP1: SUCCESS (1.330s)
[476.208503] Starting dynamic subtest: D-eDP1
[477.512705] Dynamic subtest D-eDP1: SUCCESS (1.315s)
[477.518664] Subtest bo-too-big-interruptible: SUCCESS (5.165s)
[478.691990] [080/132] (543s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[478.798294] Starting subtest: stress-xrgb8888-yftiled
[478.803137] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[478.895322] [081/132] (543s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[478.945343] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[479.045762] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[479.102626] [082/132] (542s left) syncobj_wait (wait-for-submit-delayed-submit)
[479.161303] Starting subtest: wait-for-submit-delayed-submit
[479.262771] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[479.321819] [083/132] (542s left) i915_pm_rc6_residency (rc6-accuracy)
[479.387729] Starting subtest: rc6-accuracy
[479.390419] Starting dynamic subtest: gt0
[482.562495] Dynamic subtest gt0: SUCCESS (3.169s)
[482.573767] Starting dynamic subtest: gt1
[485.733499] Dynamic subtest gt1: SUCCESS (3.169s)
[485.736488] Subtest rc6-accuracy: SUCCESS (6.344s)
[485.786885] [084/132] (536s left) kms_properties (connector-properties-legacy)
[485.888279] Starting subtest: connector-properties-legacy
[485.891019] Starting dynamic subtest: pipe-A-eDP-1
[493.704424] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.815s)
[493.714523] Starting dynamic subtest: pipe-None-DP-1
[493.720176] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[493.729073] Starting dynamic subtest: pipe-None-HDMI-A-1
[493.733872] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[493.744133] Starting dynamic subtest: pipe-None-DP-2
[493.750346] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[493.770501] Starting dynamic subtest: pipe-None-HDMI-A-2
[493.776021] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[493.796362] Starting dynamic subtest: pipe-None-DP-3
[493.801318] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[493.812535] Starting dynamic subtest: pipe-None-DP-4
[493.817330] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[493.819636] Subtest connector-properties-legacy: SUCCESS (7.827s)
[494.554063] [085/132] (527s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[494.673779] Starting subtest: cursorB-vs-flipB-toggle
[494.678611] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[494.794716] [086/132] (527s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[499.834548] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[499.840176] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[500.668503] [087/132] (521s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[505.674778] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[505.680360] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[506.506361] [088/132] (515s left) gem_mmap_gtt (basic-small-bo-tiledx)
[506.572287] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[506.641870] [089/132] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[506.739308] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[506.744144] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[506.814496] [090/132] (515s left) i915_hangman (gt-error-state-capture)
[506.879156] Starting subtest: gt-error-state-capture
[506.881705] Starting dynamic subtest: rcs0
[517.992136] Dynamic subtest rcs0: SUCCESS (11.113s)
[518.004159] Starting dynamic subtest: bcs0
[530.024771] Dynamic subtest bcs0: SUCCESS (12.030s)
[530.038893] Starting dynamic subtest: vcs0
[541.992443] Dynamic subtest vcs0: SUCCESS (11.963s)
[542.005331] Starting dynamic subtest: vcs1
[552.936970] Dynamic subtest vcs1: SUCCESS (10.939s)
[552.949519] Starting dynamic subtest: vecs0
[563.944062] Dynamic subtest vecs0: SUCCESS (11.003s)
[563.958647] Starting dynamic subtest: ccs0
[573.991951] Dynamic subtest ccs0: SUCCESS (10.043s)
[573.994436] Subtest gt-error-state-capture: SUCCESS (67.106s)
[574.055733] [091/132] (448s left) kms_psr (psr2-sprite-mmap-cpu)
[574.159035] Starting subtest: psr2-sprite-mmap-cpu
[574.161398] Starting dynamic subtest: eDP-1
[575.926822] Dynamic subtest eDP-1: SUCCESS (1.768s)
[575.929418] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.769s)
[576.774092] [092/132] (445s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[577.160609] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[578.000877] [093/132] (444s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[578.100285] Starting subtest: fbcpsr-slowdraw
[603.353299] Subtest fbcpsr-slowdraw: SUCCESS (25.249s)
[603.480271] [094/132] (418s left) kms_cursor_crc (cursor-sliding-128x128)
[603.706118] Starting subtest: cursor-sliding-128x128
[603.708937] Starting dynamic subtest: pipe-A-eDP-1
[606.940252] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.229s)
[606.966511] Starting dynamic subtest: pipe-D-eDP-1
[610.857346] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.895s)
[610.860226] Subtest cursor-sliding-128x128: SUCCESS (7.149s)
[611.701843] [095/132] (410s left) kms_content_protection (legacy)
[611.855386] Starting subtest: legacy
[611.861251] Subtest legacy: SKIP (0.000s)
[611.983307] [096/132] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[612.072759] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[612.077651] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[612.150953] [097/132] (410s left) kms_universal_plane (universal-plane-pageflip-windowed)
[612.239050] Starting subtest: universal-plane-pageflip-windowed
[612.241564] Starting dynamic subtest: pipe-A-eDP-1
[612.831359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[612.842501] Starting dynamic subtest: pipe-B-eDP-1
[614.046435] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.213s)
[614.056226] Starting dynamic subtest: pipe-C-eDP-1
[615.258556] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[615.270232] Starting dynamic subtest: pipe-D-eDP-1
[616.488612] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[616.491417] Subtest universal-plane-pageflip-windowed: SUCCESS (4.251s)
[617.319578] [098/132] (405s left) kms_psr (fbc-psr-primary-mmap-cpu)
[617.415436] Starting subtest: fbc-psr-primary-mmap-cpu
[617.417821] Starting dynamic subtest: eDP-1
[617.422491] Dynamic subtest eDP-1: SKIP (0.000s)
[617.427359] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[617.469680] [099/132] (405s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[617.570346] Starting subtest: fbc-pr-sprite-mmap-gtt
[617.576052] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[617.618833] [100/132] (405s left) gem_mmap (basic)
[617.678304] Subtest basic: SKIP (0.000s)
[617.750888] [101/132] (404s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[617.811305] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[617.897569] [102/132] (404s left) syncobj_wait (signal)
[617.963995] Starting subtest: signal
[617.966323] Subtest signal: SUCCESS (0.000s)
[618.047878] [103/132] (404s left) vgem_basic (bad-flag)
[618.086789] Starting subtest: bad-flag
[618.089350] Subtest bad-flag: SUCCESS (0.000s)
[618.129690] [104/132] (404s left) kms_plane (plane-position-hole)
[618.222347] Starting subtest: plane-position-hole
[618.726382] Starting dynamic subtest: pipe-A-plane-1
[620.047489] Dynamic subtest pipe-A-plane-1: SUCCESS (1.321s)
[620.058319] Starting dynamic subtest: pipe-A-plane-2
[621.411134] Dynamic subtest pipe-A-plane-2: SUCCESS (1.361s)
[621.422116] Starting dynamic subtest: pipe-A-plane-3
[622.684255] Dynamic subtest pipe-A-plane-3: SUCCESS (1.271s)
[622.695220] Starting dynamic subtest: pipe-A-plane-4
[623.915110] Dynamic subtest pipe-A-plane-4: SUCCESS (1.233s)
[623.925327] Starting dynamic subtest: pipe-A-plane-5
[623.942151] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[625.073334] Starting dynamic subtest: pipe-B-plane-1
[626.308447] Dynamic subtest pipe-B-plane-1: SUCCESS (1.245s)
[626.319499] Starting dynamic subtest: pipe-B-plane-2
[627.660470] Dynamic subtest pipe-B-plane-2: SUCCESS (1.350s)
[627.670469] Starting dynamic subtest: pipe-B-plane-3
[628.973151] Dynamic subtest pipe-B-plane-3: SUCCESS (1.312s)
[628.983484] Starting dynamic subtest: pipe-B-plane-4
[630.299384] Dynamic subtest pipe-B-plane-4: SUCCESS (1.324s)
[630.310181] Starting dynamic subtest: pipe-B-plane-5
[630.324818] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[630.327405] Subtest plane-position-hole: SUCCESS (12.105s)
[631.084133] [105/132] (391s left) kms_fbcon_fbt (psr)
[631.153129] Starting subtest: psr
[638.539660] Subtest psr: SUCCESS (7.383s)
[638.629804] [106/132] (384s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[638.733732] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[638.736270] Starting dynamic subtest: A-eDP1
[647.600743] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[647.614209] Starting dynamic subtest: B-eDP1
[656.532310] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[656.546365] Starting dynamic subtest: C-eDP1
[665.448144] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[665.458997] Starting dynamic subtest: D-eDP1
[674.383484] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[674.389567] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.656s)
[675.607504] [107/132] (347s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[675.704238] Starting subtest: fbcpsr-1p-rte
[682.767656] Subtest fbcpsr-1p-rte: SUCCESS (7.067s)
[682.890721] [108/132] (340s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[683.026476] Starting subtest: protected-encrypted-src-copy-not-readible
[683.137408] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s)
[683.254845] [109/132] (339s left) kms_psr (fbc-psr-suspend)
[683.370794] Starting subtest: fbc-psr-suspend
[683.373228] Starting dynamic subtest: eDP-1
[683.378240] Dynamic subtest eDP-1: SKIP (0.000s)
[683.382898] Subtest fbc-psr-suspend: SKIP (0.001s)
[683.424687] [110/132] (339s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[683.529850] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[690.458799] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.932s)
[690.590782] [111/132] (332s left) kms_flip (basic-flip-vs-dpms)
[690.693800] Starting subtest: basic-flip-vs-dpms
[690.696390] Starting dynamic subtest: A-eDP1
[693.333229] Dynamic subtest A-eDP1: SUCCESS (2.640s)
[693.344315] Starting dynamic subtest: B-eDP1
[695.563476] Dynamic subtest B-eDP1: SUCCESS (2.230s)
[695.574956] Starting dynamic subtest: C-eDP1
[697.630713] Dynamic subtest C-eDP1: SUCCESS (2.065s)
[697.641498] Starting dynamic subtest: D-eDP1
[699.724939] Dynamic subtest D-eDP1: SUCCESS (2.093s)
[699.727492] Subtest basic-flip-vs-dpms: SUCCESS (9.036s)
[700.504978] [112/132] (322s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[700.633497] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[700.638233] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[700.761135] [113/132] (322s left) perf (oa-formats)
[700.822097] Starting subtest: oa-formats
[700.824513] Starting dynamic subtest: 0-rcs0
[700.836693] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[700.847010] Starting dynamic subtest: 1-vcs1
[700.861133] Dynamic subtest 1-vcs1: SUCCESS (0.024s)
[700.863487] Subtest oa-formats: SUCCESS (0.040s)
[700.910659] [114/132] (322s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[701.006913] Starting subtest: plane-lut1d-ctm3x4
[701.019354] Starting dynamic subtest: pipe-A-eDP-1
[701.745225] Dynamic subtest pipe-A-eDP-1: FAIL (0.304s)
[702.393417] Starting dynamic subtest: pipe-B-eDP-1
[703.322247] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[703.817054] Starting dynamic subtest: pipe-C-eDP-1
[704.770517] Dynamic subtest pipe-C-eDP-1: FAIL (0.269s)
[705.144179] Starting dynamic subtest: pipe-D-eDP-1
[706.097287] Dynamic subtest pipe-D-eDP-1: FAIL (0.269s)
[706.099730] Subtest plane-lut1d-ctm3x4: FAIL (4.685s)
[706.505791] [115/132] (316s left) kms_psr (psr-cursor-mmap-gtt)
[706.603368] Starting subtest: psr-cursor-mmap-gtt
[706.606206] Starting dynamic subtest: eDP-1
[708.312919] Dynamic subtest eDP-1: SUCCESS (1.710s)
[708.315506] Subtest psr-cursor-mmap-gtt: SUCCESS (1.712s)
[709.169327] [116/132] (314s left) gem_ctx_param (invalid-size-set)
[709.228521] Starting subtest: invalid-size-set
[709.231173] Subtest invalid-size-set: SUCCESS (0.001s)
[709.306844] [117/132] (314s left) gem_mmap_offset (close-race)
[709.372240] Starting subtest: close-race
[729.473312] Subtest close-race: SUCCESS (20.100s)
[729.562713] [118/132] (293s left) kms_dirtyfb (default-dirtyfb-ioctl)
[729.664223] Starting subtest: default-dirtyfb-ioctl
[729.666425] Starting dynamic subtest: A-eDP-1
[731.252012] Dynamic subtest A-eDP-1: SUCCESS (1.589s)
[731.254833] Subtest default-dirtyfb-ioctl: SUCCESS (1.590s)
[732.102380] [119/132] (291s left) gem_wait (write-wait)
[732.175480] Starting subtest: write-wait
[732.178410] Starting dynamic subtest: all-engines
[733.320733] Dynamic subtest all-engines: SUCCESS (1.145s)
[733.336259] Starting dynamic subtest: rcs0
[734.383465] Dynamic subtest rcs0: SUCCESS (1.061s)
[734.395861] Starting dynamic subtest: bcs0
[735.458210] Dynamic subtest bcs0: SUCCESS (1.072s)
[735.474102] Starting dynamic subtest: vcs0
[736.517519] Dynamic subtest vcs0: SUCCESS (1.057s)
[736.535226] Starting dynamic subtest: vcs1
[737.576488] Dynamic subtest vcs1: SUCCESS (1.057s)
[737.594010] Starting dynamic subtest: vecs0
[738.634759] Dynamic subtest vecs0: SUCCESS (1.056s)
[738.651522] Starting dynamic subtest: ccs0
[739.694674] Dynamic subtest ccs0: SUCCESS (1.058s)
[739.697473] Subtest write-wait: SUCCESS (7.519s)
[739.871769] [120/132] (283s left) i915_query (query-topology-matches-eu-total)
[739.931016] Starting subtest: query-topology-matches-eu-total
[739.933906] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[740.014377] [121/132] (283s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[740.109172] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[740.111728] Starting dynamic subtest: pipe-A-default-mode
[740.401036] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[740.406159] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.289s)
[741.233178] [122/132] (282s left) gem_exec_params (invalid-bsd-ring)
[741.287754] Starting subtest: invalid-bsd-ring
[741.290421] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[741.377965] [123/132] (282s left) kms_frontbuffer_tracking (psr-slowdraw)
[741.482663] Starting subtest: psr-slowdraw
[766.642314] Subtest psr-slowdraw: SUCCESS (25.161s)
[766.770521] [124/132] (256s left) gem_caching (reads)
[766.847267] Subtest reads: SKIP (0.000s)
[766.934193] [125/132] (256s left) gem_userptr_blits (invalid-null-pointer)
[767.003121] Starting subtest: invalid-null-pointer
[767.005754] Subtest invalid-null-pointer: SUCCESS (0.001s)
[767.135979] [126/132] (256s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[767.256311] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[771.592175] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.340s)
[772.753973] [127/132] (251s left) gem_render_copy (yf-tiled-to-vebox-linear)
[772.822489] Starting subtest: yf-tiled-to-vebox-linear
[772.828501] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[772.985661] [128/132] (250s left) gem_exec_reloc (basic-scanout)
[773.048551] Subtest basic-scanout: SKIP (0.000s)
[773.127939] [129/132] (250s left) kms_vblank (ts-continuation-idle-hang)
[773.219771] Starting subtest: ts-continuation-idle-hang
[773.222184] Starting dynamic subtest: pipe-A-eDP-1
[799.760966] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.536s)
[799.775250] Starting dynamic subtest: pipe-D-eDP-1
[824.785502] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.016s)
[824.788307] Subtest ts-continuation-idle-hang: SUCCESS (51.557s)
[825.607361] [130/132] (198s left) syncobj_wait (invalid-wait-bad-flags)
[825.672332] Starting subtest: invalid-wait-bad-flags
[825.675333] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[825.747642] [131/132] (198s left) dmabuf_sync_file (export-basic)
[825.786539] Starting subtest: export-basic
[825.789282] Subtest export-basic: SUCCESS (0.001s)
[825.829547] [132/132] (198s left) gem_pread (bench)
[825.879504] Subtest bench: SKIP (0.000s)
[825.945590] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_close_race
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_atomic
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: dumb_buffer
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_dsc
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_color
results: parsing output: 30/ for test: sysfs_heartbeat_interval
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_workarounds
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_pm_dc
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: core_getclient
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_invalid_mode
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: gem_exec_async
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: sriov_basic
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_hdr
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: intel_hwmon
results: parsing output: 76/ for test: gem_sync
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_pipe_stress
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: i915_pm_rc6_residency
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_chamelium_edid
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_universal_plane
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_mmap
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: kms_fbcon_fbt
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: gem_mmap_offset
results: parsing output: 117/ for test: kms_dirtyfb
results: parsing output: 118/ for test: gem_wait
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: dmabuf_sync_file
results: parsing output: 131/ for test: gem_pread
Done.