[58.718399] Initializing watchdogs
[58.718450]   /dev/watchdog0
[58.733136] [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.737644] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.739922] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.744218] [001/132] (960s left) gem_exec_balancer (parallel-balancer)
[59.028809] Starting subtest: parallel-balancer
[59.922064] Subtest parallel-balancer: SUCCESS (0.896s)
[60.050334] [002/132] (959s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[60.105643] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[60.108037] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[60.208510] [003/132] (959s left) kms_addfb_basic (size-max)
[60.306103] Starting subtest: size-max
[60.308260] Subtest size-max: SUCCESS (0.000s)
[60.409546] [004/132] (958s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[60.650982] Starting subtest: cursor-rapid-movement-256x256
[60.664035] Starting dynamic subtest: pipe-A-eDP-1
[61.249962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[61.279501] Starting dynamic subtest: pipe-D-eDP-1
[62.500114] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[62.502510] Subtest cursor-rapid-movement-256x256: SUCCESS (1.855s)
[63.338324] [005/132] (956s left) gem_exec_params (dr1-dirt)
[63.396804] Starting subtest: DR1-dirt
[63.399436] Subtest DR1-dirt: SUCCESS (0.000s)
[63.501136] [006/132] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[63.590373] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[63.594747] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[63.712144] [007/132] (955s left) vgem_basic (dmabuf-fence-before)
[63.788273] Starting subtest: dmabuf-fence-before
[63.790575] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[63.838912] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[63.842377] [008/132] (955s left) kms_flip (plain-flip-fb-recreate-interruptible)
[63.928802] Starting subtest: plain-flip-fb-recreate-interruptible
[63.931123] Starting dynamic subtest: A-eDP1
[72.748515] Dynamic subtest A-eDP1: SUCCESS (8.829s)
[72.760815] Starting dynamic subtest: B-eDP1
[81.571334] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[81.580077] Starting dynamic subtest: C-eDP1
[90.376341] Dynamic subtest C-eDP1: SUCCESS (8.803s)
[90.384119] Starting dynamic subtest: D-eDP1
[99.209670] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[99.213848] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.296s)
[100.388582] [009/132] (919s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[100.491046] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[100.495497] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[100.604692] [010/132] (918s left) gem_mmap_gtt (zero-extend)
[100.660259] Subtest zero-extend: SKIP (0.000s)
[100.722081] [011/132] (918s left) kms_properties (colorop-properties-atomic)
[100.806482] Starting subtest: colorop-properties-atomic
[100.808933] Starting dynamic subtest: pipe-A-eDP-1
[101.169491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[101.179346] Starting dynamic subtest: pipe-B-eDP-1
[102.287547] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s)
[102.296781] Starting dynamic subtest: pipe-C-eDP-1
[103.393068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[103.402515] Starting dynamic subtest: pipe-D-eDP-1
[104.429851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.033s)
[104.432170] Subtest colorop-properties-atomic: SUCCESS (3.623s)
[105.230220] [012/132] (914s left) kms_draw_crc (draw-method-pwrite)
[105.324129] Starting subtest: draw-method-pwrite
[105.326413] Starting dynamic subtest: xrgb8888-untiled
[105.899329] Dynamic subtest xrgb8888-untiled: SUCCESS (0.577s)
[105.909078] Starting dynamic subtest: rgb565-untiled
[106.343676] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[106.353208] Starting dynamic subtest: xrgb2101010-untiled
[106.899287] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[106.908597] Starting dynamic subtest: xbgr16161616f-untiled
[107.668352] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s)
[107.680288] Starting dynamic subtest: xrgb8888-xtiled
[109.454998] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.789s)
[109.463234] Starting dynamic subtest: rgb565-xtiled
[110.521775] Dynamic subtest rgb565-xtiled: SUCCESS (1.065s)
[110.531536] Starting dynamic subtest: xrgb2101010-xtiled
[112.310622] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.789s)
[112.322582] Starting dynamic subtest: xbgr16161616f-xtiled
[115.588522] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.277s)
[115.597074] Starting dynamic subtest: xrgb8888-4tiled
[116.688855] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[116.697089] Starting dynamic subtest: rgb565-4tiled
[117.246054] Dynamic subtest rgb565-4tiled: SUCCESS (0.554s)
[117.260045] Starting dynamic subtest: xrgb2101010-4tiled
[118.333326] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.089s)
[118.345293] Starting dynamic subtest: xbgr16161616f-4tiled
[121.311343] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.977s)
[121.313725] Subtest draw-method-pwrite: SUCCESS (15.988s)
[121.407327] [013/132] (898s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[121.792507] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[122.637807] [014/132] (897s left) kms_joiner (invalid-modeset-ultra-joiner)
[122.732913] Starting subtest: invalid-modeset-ultra-joiner
[122.737566] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[122.805374] [015/132] (896s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[122.863056] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[122.938220] [016/132] (896s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[123.026700] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[123.028871] Starting dynamic subtest: pipe-A-eDP-1
[123.051126] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.060580] Starting dynamic subtest: pipe-B-eDP-1
[123.081312] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.088630] Starting dynamic subtest: pipe-C-eDP-1
[123.109597] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.116963] Starting dynamic subtest: pipe-D-eDP-1
[123.139042] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.143400] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[125.318366] [017/132] (894s left) gem_exec_gttfill (multigpu-basic)
[125.490184] Starting subtest: multigpu-basic
[139.376746] Subtest multigpu-basic: SUCCESS (13.888s)
[139.467880] [018/132] (880s left) drm_read (short-buffer-nonblock)
[139.685958] Starting subtest: short-buffer-nonblock
[139.688512] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[139.811768] [019/132] (880s left) kms_addfb_basic (unused-pitches)
[139.863221] Starting subtest: unused-pitches
[139.865539] Subtest unused-pitches: SUCCESS (0.000s)
[139.998759] [020/132] (880s left) kms_content_protection (lic-type-0)
[140.148069] Starting subtest: lic-type-0
[140.152820] Subtest lic-type-0: SKIP (0.000s)
[140.287225] [021/132] (879s left) kms_chamelium_frames (hdmi-crc-fast)
[140.672134] Subtest hdmi-crc-fast: SKIP (0.000s)
[141.528292] [022/132] (878s left) gem_mmap_gtt (basic-small-bo)
[141.598456] Subtest basic-small-bo: SKIP (0.000s)
[141.654305] [023/132] (878s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[141.753968] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[141.758054] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[141.850813] [024/132] (878s left) gem_mmap_gtt (cpuset-big-copy-odd)
[141.903844] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[141.964372] [025/132] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[142.074736] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[142.079247] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[142.166756] [026/132] (878s left) device_reset (cold-reset-bound)
[142.224182] Starting subtest: cold-reset-bound
[142.228390] Subtest cold-reset-bound: SKIP (0.000s)
[142.296829] [027/132] (877s left) i915_drm_fdinfo (most-busy-check-all)
[142.335686] Starting subtest: most-busy-check-all
[142.338017] Starting dynamic subtest: rcs0
[142.342597] Dynamic subtest rcs0: SKIP (0.003s)
[142.351742] Starting dynamic subtest: bcs0
[142.356161] Dynamic subtest bcs0: SKIP (0.000s)
[142.364198] Starting dynamic subtest: vcs0
[142.367907] Dynamic subtest vcs0: SKIP (0.000s)
[142.375537] Starting dynamic subtest: vcs1
[142.379672] Dynamic subtest vcs1: SKIP (0.000s)
[142.387232] Starting dynamic subtest: vecs0
[142.391229] Dynamic subtest vecs0: SKIP (0.000s)
[142.398626] Starting dynamic subtest: ccs0
[142.402707] Dynamic subtest ccs0: SKIP (0.000s)
[142.406825] Subtest most-busy-check-all: SKIP (0.007s)
[142.441633] [028/132] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[142.554928] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[149.634476] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.081s)
[149.770782] [029/132] (870s left) gem_exec_schedule (smoketest-all)
[149.862240] Starting subtest: smoketest-all
[182.225249] Subtest smoketest-all: SUCCESS (32.322s)
[183.356109] [030/132] (837s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[183.467194] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[183.471642] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[183.561459] [031/132] (836s left) core_getversion (all-cards)
[183.599907] Starting subtest: all-cards
[183.607220] Subtest all-cards: SUCCESS (0.011s)
[183.651989] [032/132] (836s left) gem_ringfill (engines-basic)
[189.309880] Starting subtest: engines-basic
[189.312513] Starting dynamic subtest: rcs0
[189.377805] Dynamic subtest rcs0: SUCCESS (0.068s)
[189.389173] Starting dynamic subtest: bcs0
[189.423231] Dynamic subtest bcs0: SUCCESS (0.044s)
[189.437733] Starting dynamic subtest: vcs0
[189.466042] Dynamic subtest vcs0: SUCCESS (0.041s)
[189.476438] Starting dynamic subtest: vcs1
[189.509521] Dynamic subtest vcs1: SUCCESS (0.042s)
[189.520353] Starting dynamic subtest: vecs0
[189.553140] Dynamic subtest vecs0: SUCCESS (0.042s)
[189.565061] Starting dynamic subtest: ccs0
[189.596205] Dynamic subtest ccs0: SUCCESS (0.042s)
[189.598551] Subtest engines-basic: SUCCESS (0.288s)
[189.676498] [033/132] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[189.779537] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[189.783735] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[189.893323] [034/132] (830s left) kms_frontbuffer_tracking (psr-2p-rte)
[189.990883] Starting subtest: psr-2p-rte
[189.995445] Subtest psr-2p-rte: SKIP (0.000s)
[190.093321] [035/132] (830s left) gem_exec_whisper (basic-fds-priority)
[190.159643] Starting subtest: basic-fds-priority
[213.940802] Subtest basic-fds-priority: SUCCESS (23.778s)
[214.139961] [036/132] (806s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[214.236464] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[218.573619] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.341s)
[219.682870] [037/132] (800s left) gem_mmap_gtt (big-copy-odd)
[219.732404] Subtest big-copy-odd: SKIP (0.000s)
[219.790385] [038/132] (800s left) kms_dirtyfb (default-dirtyfb-ioctl)
[219.885828] Starting subtest: default-dirtyfb-ioctl
[219.887749] Starting dynamic subtest: A-eDP-1
[221.463769] Dynamic subtest A-eDP-1: SUCCESS (1.577s)
[221.465698] Subtest default-dirtyfb-ioctl: SUCCESS (1.578s)
[222.310876] [039/132] (798s left) perf_pmu (semaphore-busy)
[222.356951] Starting subtest: semaphore-busy
[222.359087] Starting dynamic subtest: rcs0
[223.991106] Dynamic subtest rcs0: SUCCESS (1.632s)
[224.003316] Starting dynamic subtest: bcs0
[225.623934] Dynamic subtest bcs0: SUCCESS (1.628s)
[225.636388] Starting dynamic subtest: vcs0
[229.866383] Dynamic subtest vcs0: SUCCESS (4.188s)
[229.878791] Starting dynamic subtest: vcs1
[234.806198] Dynamic subtest vcs1: SUCCESS (4.991s)
[234.817796] Starting dynamic subtest: vecs0
[240.757962] Dynamic subtest vecs0: SUCCESS (5.949s)
[240.769063] Starting dynamic subtest: ccs0
[243.896219] Dynamic subtest ccs0: SUCCESS (3.136s)
[243.898718] Subtest semaphore-busy: SUCCESS (21.538s)
[244.025212] [040/132] (776s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[244.130670] Starting subtest: fbcpsr-modesetfrombusy
[250.299039] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.172s)
[250.439299] [041/132] (770s left) kms_chamelium_color (ctm-green-to-red)
[250.529151] Subtest ctm-green-to-red: SKIP (0.000s)
[250.572131] [042/132] (770s left) gem_userptr_blits (nohangcheck)
[250.650591] Starting subtest: nohangcheck
[250.887065] Subtest nohangcheck: SUCCESS (0.236s)
[251.004886] [043/132] (769s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[251.098507] Starting subtest: plane-ctm3x4-lut1d
[251.233993] Starting dynamic subtest: pipe-A-plane-0
[251.400356] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[251.410730] Starting dynamic subtest: pipe-A-plane-1
[251.577410] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[251.588177] Starting dynamic subtest: pipe-A-plane-2
[251.723456] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[252.971574] Starting dynamic subtest: pipe-B-plane-0
[253.142898] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[253.153501] Starting dynamic subtest: pipe-B-plane-1
[253.285138] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[253.300665] Starting dynamic subtest: pipe-B-plane-2
[253.429610] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[254.585484] Starting dynamic subtest: pipe-C-plane-0
[254.721599] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[254.731993] Starting dynamic subtest: pipe-C-plane-1
[254.877876] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[254.889131] Starting dynamic subtest: pipe-C-plane-2
[255.033203] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[256.215811] Starting dynamic subtest: pipe-D-plane-0
[256.362747] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[256.372482] Starting dynamic subtest: pipe-D-plane-1
[256.496423] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[256.506288] Starting dynamic subtest: pipe-D-plane-2
[256.651487] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[256.948575] Subtest plane-ctm3x4-lut1d: SUCCESS (5.852s)
[257.802518] [044/132] (763s left) kms_atomic_transition (plane-all-modeset-transition)
[257.896607] Starting subtest: plane-all-modeset-transition
[257.901365] Subtest plane-all-modeset-transition: SKIP (0.000s)
[257.967605] [045/132] (763s left) gem_lmem_swapping (heavy-random)
[258.015761] Subtest heavy-random: SKIP (0.000s)
[258.057128] [046/132] (762s left) kms_plane_alpha_blend (coverage-7efc)
[258.139819] Starting subtest: coverage-7efc
[258.418045] Starting dynamic subtest: pipe-A-eDP-1
[259.016250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[259.042977] Starting dynamic subtest: pipe-D-eDP-1
[260.324568] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[260.326764] Subtest coverage-7efc: SUCCESS (2.184s)
[261.159303] [047/132] (759s left) gen7_exec_parse (basic-rejected)
[261.228539] Subtest basic-rejected: SKIP (0.000s)
[261.295293] [048/132] (759s left) kms_cursor_crc (cursor-sliding-64x64)
[261.476517] Starting subtest: cursor-sliding-64x64
[261.478901] Starting dynamic subtest: pipe-A-eDP-1
[264.711762] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.230s)
[264.741844] Starting dynamic subtest: pipe-D-eDP-1
[268.659498] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.924s)
[268.661979] Subtest cursor-sliding-64x64: SUCCESS (7.182s)
[269.529414] [049/132] (751s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[269.629303] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[269.631575] Starting dynamic subtest: pipe-A-eDP-1
[269.689772] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[269.700937] Starting dynamic subtest: pipe-B-eDP-1
[269.757194] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[269.768661] Starting dynamic subtest: pipe-C-eDP-1
[269.826273] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[269.836394] Starting dynamic subtest: pipe-D-eDP-1
[269.891612] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[269.895865] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[271.881842] [050/132] (749s left) gem_exec_fence (syncobj-invalid-flags)
[272.344236] Starting subtest: syncobj-invalid-flags
[272.346913] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[274.411370] [051/132] (746s left) i915_hangman (engine-engine-error)
[274.475099] Starting subtest: engine-engine-error
[274.477600] Starting dynamic subtest: rcs0
[276.249946] Dynamic subtest rcs0: SUCCESS (1.772s)
[276.263139] Starting dynamic subtest: bcs0
[278.232757] Dynamic subtest bcs0: SUCCESS (1.980s)
[278.245136] Starting dynamic subtest: vcs0
[280.282062] Dynamic subtest vcs0: SUCCESS (2.046s)
[280.294788] Starting dynamic subtest: vcs1
[282.265701] Dynamic subtest vcs1: SUCCESS (1.981s)
[282.276836] Starting dynamic subtest: vecs0
[284.249614] Dynamic subtest vecs0: SUCCESS (1.981s)
[284.261043] Starting dynamic subtest: ccs0
[286.232484] Dynamic subtest ccs0: SUCCESS (1.979s)
[286.235202] Subtest engine-engine-error: SUCCESS (11.757s)
[286.329216] [052/132] (734s left) gem_ctx_persistence (engines-queued)
[286.386365] Starting subtest: engines-queued
[286.388915] Starting dynamic subtest: rcs0
[286.463330] Dynamic subtest rcs0: SUCCESS (0.077s)
[286.475219] Starting dynamic subtest: bcs0
[286.497063] Dynamic subtest bcs0: SUCCESS (0.032s)
[286.509927] Starting dynamic subtest: vcs0
[288.283698] Dynamic subtest vcs0: SUCCESS (1.783s)
[288.295156] Starting dynamic subtest: vcs1
[290.200974] Dynamic subtest vcs1: SUCCESS (1.914s)
[290.212900] Starting dynamic subtest: vecs0
[291.224208] Dynamic subtest vecs0: SUCCESS (1.020s)
[291.238540] Starting dynamic subtest: ccs0
[291.414599] Dynamic subtest ccs0: SUCCESS (0.189s)
[291.417098] Subtest engines-queued: SUCCESS (5.028s)
[291.533882] [053/132] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[291.630835] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[291.634844] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.726760] [054/132] (729s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[291.819336] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[291.823683] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[291.931380] [055/132] (729s left) gem_ctx_param (set-priority-range)
[291.984335] Starting subtest: set-priority-range
[291.997200] Subtest set-priority-range: SUCCESS (0.013s)
[292.111237] [056/132] (729s left) gem_softpin (full)
[292.161517] Starting subtest: full
[292.175079] Subtest full: SUCCESS (0.013s)
[292.290297] [057/132] (729s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[292.337507] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[292.437797] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[292.517619] [058/132] (729s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[292.606239] Starting subtest: psr-indfb-scaledprimary
[298.286828] Subtest psr-indfb-scaledprimary: SUCCESS (5.681s)
[298.413327] [059/132] (723s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[298.541530] Starting subtest: cursorB-vs-flipA-toggle
[298.546172] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[298.689096] [060/132] (722s left) kms_big_fb (linear-16bpp-rotate-180)
[298.787349] Starting subtest: linear-16bpp-rotate-180
[300.223470] Subtest linear-16bpp-rotate-180: SUCCESS (1.435s)
[300.350918] [061/132] (721s left) gem_pwrite (basic-random)
[300.398568] Subtest basic-random: SKIP (0.000s)
[300.461373] [062/132] (721s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[300.510757] Starting subtest: yf-tiled-ccs-to-yf-tiled
[300.514516] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[300.689984] [063/132] (721s left) i915_suspend (forcewake)
[300.745789] Starting subtest: forcewake
[332.618305] Subtest forcewake: SUCCESS (3.118s)
[332.688562] [064/132] (689s left) i915_pm_rps (engine-order)
[332.757899] Starting subtest: engine-order
[337.626184] Subtest engine-order: SUCCESS (4.900s)
[337.772761] [065/132] (684s left) api_intel_allocator (reopen)
[337.837107] Starting subtest: reopen
[337.842814] Subtest reopen: SUCCESS (0.008s)
[337.978003] [066/132] (683s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[338.086535] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[338.090507] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[338.169669] [067/132] (683s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[338.259184] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[338.263590] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[339.345297] [068/132] (682s left) kms_atomic (plane-invalid-params-fence)
[339.452773] Starting subtest: plane-invalid-params-fence
[339.455109] Starting dynamic subtest: pipe-A-eDP-1
[339.806010] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[339.807986] Subtest plane-invalid-params-fence: SUCCESS (0.355s)
[340.655692] [069/132] (681s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[340.756451] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[340.758905] Starting dynamic subtest: pipe-A-eDP-1
[352.039929] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.309s)
[352.051055] Starting dynamic subtest: pipe-B-eDP-1
[364.052793] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.023s)
[364.055033] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.335s)
[364.889494] [070/132] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[364.997286] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[365.001684] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[365.105222] [071/132] (656s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[365.198510] Starting subtest: y-tiled-64bpp-rotate-90
[365.203074] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[365.298079] [072/132] (656s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[365.389819] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[369.427549] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.043s)
[370.625606] [073/132] (651s left) kms_properties (connector-properties-atomic)
[370.724156] Starting subtest: connector-properties-atomic
[370.726759] Starting dynamic subtest: pipe-A-eDP-1
[378.518980] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.799s)
[378.529200] Starting dynamic subtest: pipe-None-DP-1
[378.533418] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[378.543064] Starting dynamic subtest: pipe-None-HDMI-A-1
[378.547194] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[378.556971] Starting dynamic subtest: pipe-None-DP-2
[378.561250] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[378.571365] Starting dynamic subtest: pipe-None-HDMI-A-2
[378.575639] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[378.585733] Starting dynamic subtest: pipe-None-DP-3
[378.590103] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[378.600026] Starting dynamic subtest: pipe-None-DP-4
[378.604435] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[378.606529] Subtest connector-properties-atomic: SUCCESS (7.811s)
[379.395277] [074/132] (642s left) kms_cursor_crc (cursor-offscreen-64x64)
[379.563789] Starting subtest: cursor-offscreen-64x64
[379.568601] Starting dynamic subtest: pipe-A-eDP-1
[381.488872] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[381.519034] Starting dynamic subtest: pipe-D-eDP-1
[384.118026] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.606s)
[384.120182] Subtest cursor-offscreen-64x64: SUCCESS (4.554s)
[384.969808] [075/132] (637s left) syncobj_timeline (invalid-transfer-non-existent-point)
[385.028441] Starting subtest: invalid-transfer-non-existent-point
[385.030978] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[385.143416] [076/132] (637s left) kms_vrr (seamless-rr-switch-virtual)
[385.236732] Starting subtest: seamless-rr-switch-virtual
[385.243335] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[385.314419] [077/132] (637s left) kms_vblank (wait-busy-hang)
[385.399568] Starting subtest: wait-busy-hang
[385.401825] Starting dynamic subtest: pipe-A-eDP-1
[411.842794] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.455s)
[411.857813] Starting dynamic subtest: pipe-D-eDP-1
[426.808881] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.972s)
[426.811207] Subtest wait-busy-hang: SUCCESS (41.432s)
[427.683267] [078/132] (594s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[427.809875] Starting subtest: flip-vs-cursor-busy-crc-atomic
[428.534083] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.722s)
[429.330148] [079/132] (593s left) gem_exec_flush (basic-wb-set-default)
[429.396321] Starting subtest: basic-wb-set-default
[434.885459] Subtest basic-wb-set-default: SUCCESS (5.453s)
[435.046872] [080/132] (587s left) syncobj_wait (wait-all-interrupted)
[435.106921] Starting subtest: wait-all-interrupted
[435.213808] Subtest wait-all-interrupted: SUCCESS (0.106s)
[435.316319] [081/132] (587s left) gem_eio (in-flight-internal-10ms)
[435.558377] Starting subtest: in-flight-internal-10ms
[437.132128] Subtest in-flight-internal-10ms: SUCCESS (1.576s)
[437.255798] [082/132] (585s left) kms_busy (extended-modeset-hang-oldfb)
[437.355461] Starting subtest: extended-modeset-hang-oldfb
[437.357781] Starting dynamic subtest: pipe-A
[449.198966] Dynamic subtest pipe-A: SUCCESS (11.834s)
[449.210552] Starting dynamic subtest: pipe-D
[461.675930] Dynamic subtest pipe-D: SUCCESS (12.470s)
[461.678399] Subtest extended-modeset-hang-oldfb: SUCCESS (24.308s)
[462.490166] [083/132] (560s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[462.596887] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[462.622004] Starting dynamic subtest: pipe-A-plane-0
[462.910999] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[462.921962] Starting dynamic subtest: pipe-A-plane-3
[463.144305] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[464.261397] Starting dynamic subtest: pipe-B-plane-0
[464.561750] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[464.572477] Starting dynamic subtest: pipe-B-plane-3
[464.795868] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[465.106448] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.509s)
[465.929827] [084/132] (556s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[466.025577] Starting subtest: flip-vs-dpms-on-nop-interruptible
[466.027798] Starting dynamic subtest: A-eDP1
[467.919485] Dynamic subtest A-eDP1: SUCCESS (1.892s)
[467.932702] Starting dynamic subtest: B-eDP1
[469.750796] Dynamic subtest B-eDP1: SUCCESS (1.829s)
[469.765116] Starting dynamic subtest: C-eDP1
[471.576940] Dynamic subtest C-eDP1: SUCCESS (1.825s)
[471.590467] Starting dynamic subtest: D-eDP1
[473.412181] Dynamic subtest D-eDP1: SUCCESS (1.834s)
[473.414625] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.389s)
[474.604879] [085/132] (548s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[474.666983] Starting subtest: invalid-bsd2-flag-on-blt
[474.669093] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[474.796991] [086/132] (547s left) kms_big_fb (4-tiled-addfb)
[474.900175] Starting subtest: 4-tiled-addfb
[474.902494] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[475.012905] [087/132] (547s left) gem_exec_schedule (promotion)
[475.082950] Starting subtest: promotion
[475.084966] Starting dynamic subtest: rcs0
[475.189570] Dynamic subtest rcs0: SUCCESS (0.114s)
[475.202853] Starting dynamic subtest: vcs0
[475.283037] Dynamic subtest vcs0: SUCCESS (0.091s)
[475.295108] Starting dynamic subtest: vcs1
[475.375796] Dynamic subtest vcs1: SUCCESS (0.091s)
[475.389636] Starting dynamic subtest: vecs0
[475.465893] Dynamic subtest vecs0: SUCCESS (0.089s)
[475.480421] Starting dynamic subtest: ccs0
[475.571856] Dynamic subtest ccs0: SUCCESS (0.106s)
[475.573904] Subtest promotion: SUCCESS (0.497s)
[477.156160] [088/132] (545s left) prime_vgem (basic-gtt)
[477.240122] Starting subtest: basic-gtt
[477.244622] Subtest basic-gtt: SKIP (0.000s)
[477.357565] [089/132] (545s left) gem_render_copy (y-tiled)
[477.410662] Starting subtest: y-tiled
[477.415241] Subtest y-tiled: SKIP (0.000s)
[477.615195] [090/132] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[477.729066] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[481.868905] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.143s)
[483.020862] [091/132] (539s left) gem_exec_reloc (basic-wc-read)
[483.079933] Subtest basic-wc-read: SKIP (0.000s)
[483.146078] [092/132] (539s left) kms_psr (fbc-pr-sprite-blt)
[483.239756] Starting subtest: fbc-pr-sprite-blt
[483.244174] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[483.316165] [093/132] (539s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[483.404785] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[483.407145] Starting dynamic subtest: pipe-A-eDP-1
[483.430122] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.443197] Starting dynamic subtest: pipe-B-eDP-1
[483.465096] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[483.475391] Starting dynamic subtest: pipe-C-eDP-1
[483.496693] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.507287] Starting dynamic subtest: pipe-D-eDP-1
[483.529163] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[483.533556] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[485.666683] [094/132] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[485.768217] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[492.309910] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.546s)
[492.435242] [095/132] (530s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[492.554714] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[492.559278] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[492.717643] [096/132] (530s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[492.809153] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[499.336794] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.532s)
[499.464336] [097/132] (523s left) vgem_basic (bad-pad)
[499.513377] Starting subtest: bad-pad
[499.515298] Subtest bad-pad: SUCCESS (0.000s)
[499.569994] [098/132] (523s left) kms_selftest (drm_dp_mst_helper)
[499.615075] Starting subtest: drm_dp_mst_helper
[499.651167] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[499.764775] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.111s)
[499.775423] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[499.867748] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.103s)
[499.878131] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[499.988544] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.121s)
[499.990812] Subtest drm_dp_mst_helper: SUCCESS (0.373s)
[500.150272] [099/132] (523s left) gem_userptr_blits (map-fixed-invalidate-busy)
[500.213388] Starting subtest: map-fixed-invalidate-busy
[500.217710] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[500.339426] [100/132] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[500.433579] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[500.437613] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[500.538637] [101/132] (522s left) gem_ctx_persistence (heartbeat-close)
[500.595853] Starting subtest: heartbeat-close
[500.600400] Subtest heartbeat-close: SKIP (0.000s)
[500.717881] [102/132] (522s left) kms_pm_rpm (pm-tiling)
[502.247693] Starting subtest: pm-tiling
[502.252994] Subtest pm-tiling: SKIP (0.000s)
[502.960089] [103/132] (520s left) kms_plane_cursor (viewport)
[503.055353] Starting subtest: viewport
[503.059425] Starting dynamic subtest: pipe-A-eDP-1-size-64
[505.609418] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.554s)
[505.671954] Starting dynamic subtest: pipe-A-eDP-1-size-128
[508.188053] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[508.247519] Starting dynamic subtest: pipe-A-eDP-1-size-256
[510.754066] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[511.120737] Starting dynamic subtest: pipe-B-eDP-1-size-64
[514.321474] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.213s)
[514.383398] Starting dynamic subtest: pipe-B-eDP-1-size-128
[516.844355] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s)
[516.907109] Starting dynamic subtest: pipe-B-eDP-1-size-256
[519.365785] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.471s)
[519.719020] Starting dynamic subtest: pipe-C-eDP-1-size-64
[522.539711] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.837s)
[522.583416] Starting dynamic subtest: pipe-C-eDP-1-size-128
[524.716883] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[524.756669] Starting dynamic subtest: pipe-C-eDP-1-size-256
[526.916710] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.170s)
[527.252321] Starting dynamic subtest: pipe-D-eDP-1-size-64
[530.109630] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.870s)
[530.150585] Starting dynamic subtest: pipe-D-eDP-1-size-128
[532.309378] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.170s)
[532.351944] Starting dynamic subtest: pipe-D-eDP-1-size-256
[534.520204] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[534.844325] Subtest viewport: SUCCESS (31.796s)
[535.714169] [104/132] (487s left) gem_exec_await (wide-all)
[535.931613] Starting subtest: wide-all
[558.864556] Subtest wide-all: SUCCESS (22.918s)
[559.046996] [105/132] (464s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[559.209489] Starting subtest: x-tiled-64bpp-rotate-0
[560.824403] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.614s)
[561.018197] [106/132] (462s left) kms_frontbuffer_tracking (psr-suspend)
[561.111027] Starting subtest: psr-suspend
[599.311041] Subtest psr-suspend: SUCCESS (8.162s)
[599.457530] [107/132] (424s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[599.575780] Starting subtest: fbc-psr-cursor-mmap-cpu
[599.578137] Starting dynamic subtest: eDP-1
[599.582362] Dynamic subtest eDP-1: SKIP (0.000s)
[599.586489] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[599.650415] [108/132] (424s left) gem_exec_params (secure-non-master)
[599.716003] Starting subtest: secure-non-master
[599.720519] Subtest secure-non-master: SKIP (0.000s)
[599.824050] [109/132] (423s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[599.915598] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[599.919689] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[600.022855] [110/132] (423s left) kms_rotation_crc (sprite-rotation-270)
[600.119485] Starting subtest: sprite-rotation-270
[600.123143] Subtest sprite-rotation-270: SKIP (0.001s)
[600.193017] [111/132] (423s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[600.289818] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[600.293383] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[600.378987] [112/132] (423s left) gem_ctx_engines (execute-allforone)
[600.447222] Starting subtest: execute-allforone
[600.462217] Subtest execute-allforone: SUCCESS (0.015s)
[602.162580] [113/132] (421s left) gen3_render_linear_blits
[602.284073] [114/132] (421s left) perf_pmu (render-node-busy)
[602.361672] Starting subtest: render-node-busy
[602.364197] Starting dynamic subtest: rcs0
[602.946513] Dynamic subtest rcs0: SUCCESS (0.587s)
[602.961300] Starting dynamic subtest: bcs0
[603.519326] Dynamic subtest bcs0: SUCCESS (0.573s)
[603.536761] Starting dynamic subtest: vcs0
[605.095260] Dynamic subtest vcs0: SUCCESS (1.580s)
[605.106712] Starting dynamic subtest: vcs1
[607.080574] Dynamic subtest vcs1: SUCCESS (1.988s)
[607.093937] Starting dynamic subtest: vecs0
[609.064053] Dynamic subtest vecs0: SUCCESS (1.986s)
[609.078020] Starting dynamic subtest: ccs0
[609.635560] Dynamic subtest ccs0: SUCCESS (0.571s)
[609.638870] Subtest render-node-busy: SUCCESS (7.301s)
[609.731623] [115/132] (414s left) kms_async_flips (async-flip-hang)
[609.836157] Starting subtest: async-flip-hang
[610.208730] Starting dynamic subtest: pipe-A-eDP-1
[636.557081] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.355s)
[636.925212] Starting dynamic subtest: pipe-B-eDP-1
[652.551815] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.627s)
[652.925757] Starting dynamic subtest: pipe-C-eDP-1
[668.552102] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.623s)
[668.923210] Starting dynamic subtest: pipe-D-eDP-1
[684.616226] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.697s)
[684.620354] Subtest async-flip-hang: SUCCESS (74.793s)
[685.797744] [116/132] (338s left) gem_eio (in-flight-contexts-1us)
[685.984368] Starting subtest: in-flight-contexts-1us
[700.085569] Subtest in-flight-contexts-1us: SUCCESS (14.102s)
[700.249254] [117/132] (323s left) kms_pm_backlight (brightness-with-dpms)
[700.339484] Starting subtest: brightness-with-dpms
[700.391811] Starting dynamic subtest: eDP-1
[702.832573] Dynamic subtest eDP-1: SUCCESS (2.444s)
[702.834892] Subtest brightness-with-dpms: SUCCESS (2.495s)
[703.704092] [118/132] (320s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[703.793382] Starting subtest: invalidate-primary-flip-overlay
[714.569035] Subtest invalidate-primary-flip-overlay: SUCCESS (10.775s)
[714.696673] [119/132] (309s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[714.762755] Starting subtest: single-wait-for-submit-available-signaled
[714.764802] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[714.872274] [120/132] (309s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[714.920486] Starting subtest: multi-wait-available-submitted-signaled
[714.922417] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[715.044353] [121/132] (309s left) gem_exec_fence (basic-busy)
[715.235406] Starting subtest: basic-busy
[715.238224] Starting dynamic subtest: rcs0
[715.339331] Dynamic subtest rcs0: SUCCESS (0.102s)
[715.353946] Starting dynamic subtest: bcs0
[715.403859] Dynamic subtest bcs0: SUCCESS (0.063s)
[715.417892] Starting dynamic subtest: vcs0
[715.455263] Dynamic subtest vcs0: SUCCESS (0.050s)
[715.471010] Starting dynamic subtest: vcs1
[715.512066] Dynamic subtest vcs1: SUCCESS (0.054s)
[715.528928] Starting dynamic subtest: vecs0
[715.577054] Dynamic subtest vecs0: SUCCESS (0.062s)
[715.588264] Starting dynamic subtest: ccs0
[715.629753] Dynamic subtest ccs0: SUCCESS (0.051s)
[715.632402] Subtest basic-busy: SUCCESS (0.395s)
[717.179568] [122/132] (307s left) kms_big_fb (x-tiled-addfb-size-overflow)
[717.285545] Starting subtest: x-tiled-addfb-size-overflow
[717.287808] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[717.399081] [123/132] (306s left) gem_exec_reloc (basic-gtt-cpu-active)
[717.457045] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[717.524016] [124/132] (306s left) kms_psr (psr2-cursor-render)
[717.609232] Starting subtest: psr2-cursor-render
[717.611543] Starting dynamic subtest: eDP-1
[719.276749] Dynamic subtest eDP-1: SUCCESS (1.668s)
[719.278989] Subtest psr2-cursor-render: SUCCESS (1.669s)
[720.069692] [125/132] (304s left) kms_lease (lease-uevent)
[720.156294] Starting subtest: lease-uevent
[721.173017] Subtest lease-uevent: SUCCESS (1.018s)
[721.307852] [126/132] (303s left) kms_getfb (getfb2-handle-not-fb)
[721.400559] Starting subtest: getfb2-handle-not-fb
[721.402873] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[721.503652] [127/132] (303s left) gem_ccs (ctrl-surf-copy-new-ctx)
[721.559889] Starting subtest: ctrl-surf-copy-new-ctx
[721.564372] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[721.659978] [128/132] (302s left) kms_plane_scaling (invalid-parameters)
[721.751286] Starting subtest: invalid-parameters
[721.753601] Starting dynamic subtest: less-than-1-height-src
[721.764595] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[721.777247] Starting dynamic subtest: less-than-1-width-src
[721.779594] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[721.781757] Subtest invalid-parameters: SUCCESS (0.028s)
[721.894781] [129/132] (302s left) gem_exec_schedule (pi-common)
[722.077735] Starting subtest: pi-common
[722.079891] Starting dynamic subtest: rcs0
[722.101191] Dynamic subtest rcs0: SUCCESS (0.027s)
[722.117360] Starting dynamic subtest: bcs0
[722.127954] Dynamic subtest bcs0: SUCCESS (0.026s)
[722.143913] Starting dynamic subtest: vcs0
[722.154367] Dynamic subtest vcs0: SUCCESS (0.026s)
[722.171036] Starting dynamic subtest: vcs1
[722.179549] Dynamic subtest vcs1: SUCCESS (0.025s)
[722.195983] Starting dynamic subtest: vecs0
[722.206183] Dynamic subtest vecs0: SUCCESS (0.026s)
[722.223221] Starting dynamic subtest: ccs0
[722.233100] Dynamic subtest ccs0: SUCCESS (0.026s)
[722.235282] Subtest pi-common: SUCCESS (0.159s)
[722.474353] [130/132] (302s left) syncobj_eventfd (invalid-illegal-handle)
[722.535936] Starting subtest: invalid-illegal-handle
[722.538396] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[722.626602] [131/132] (302s left) kms_psr (pr-dpms)
[722.719920] Starting subtest: pr-dpms
[722.724463] Subtest pr-dpms: SKIP (0.000s)
[722.792900] [132/132] (301s left) kms_pm_backlight (basic-brightness)
[722.881786] Starting subtest: basic-brightness
[722.937690] Starting dynamic subtest: eDP-1
[723.438122] Dynamic subtest eDP-1: SUCCESS (0.503s)
[723.440595] Subtest basic-brightness: SUCCESS (0.559s)
[724.304115] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_addfb_basic
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_properties
results: parsing output: 11/ for test: kms_draw_crc
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_joiner
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_exec_gttfill
results: parsing output: 17/ for test: drm_read
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_content_protection
results: parsing output: 20/ for test: kms_chamelium_frames
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: device_reset
results: parsing output: 26/ for test: i915_drm_fdinfo
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: core_getversion
results: parsing output: 31/ for test: gem_ringfill
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_whisper
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_dirtyfb
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_chamelium_color
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: gen7_exec_parse
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_pwrite
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: i915_suspend
results: parsing output: 63/ for test: i915_pm_rps
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_atomic
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_properties
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_exec_flush
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: kms_busy
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: prime_vgem
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: vgem_basic
results: parsing output: 97/ for test: kms_selftest
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: kms_plane_cursor
results: parsing output: 103/ for test: gem_exec_await
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: gem_ctx_engines
results: parsing output: 112/ for test: gen3_render_linear_blits
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_async_flips
results: parsing output: 115/ for test: gem_eio
results: parsing output: 116/ for test: kms_pm_backlight
results: parsing output: 117/ for test: kms_psr_stress_test
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: kms_getfb
results: parsing output: 126/ for test: gem_ccs
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: syncobj_eventfd
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_pm_backlight
Done.