[61.946730] Initializing watchdogs
[61.946777]   /dev/watchdog0
[61.960693] [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]
[61.965084] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.967364] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.969781] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[62.032681] Subtest write-snoop: SKIP (0.000s)
[62.089300] [002/133] (960s left) kms_content_protection (content-type-change)
[62.238429] Starting subtest: content-type-change
[62.240310] Subtest content-type-change: SKIP (0.000s)
[62.377245] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[62.473156] Starting subtest: multiplane-rotation
[79.903516] Subtest multiplane-rotation: SUCCESS (17.402s)
[80.043283] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[80.142697] Subtest ctm-red-to-blue: SKIP (0.000s)
[80.182796] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[80.228379] Starting subtest: invalid-reset-one-illegal-handle
[80.229501] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[80.338105] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[80.434062] Starting subtest: disable-crc-after-crtc
[80.434930] Starting dynamic subtest: pipe-A-eDP-1
[82.069888] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.634s)
[82.076329] Starting dynamic subtest: pipe-B-eDP-1
[84.336910] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.265s)
[84.347237] Starting dynamic subtest: pipe-C-eDP-1
[86.575797] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.236s)
[86.582328] Starting dynamic subtest: pipe-D-eDP-1
[88.849723] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.271s)
[88.850731] Subtest disable-crc-after-crtc: SUCCESS (8.412s)
[89.695859] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[89.759041] Subtest tiled-to-tiled: SKIP (0.000s)
[89.833887] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[89.893362] Starting subtest: wait-all-interrupted
[90.003533] Subtest wait-all-interrupted: SUCCESS (0.107s)
[90.092232] [009/133] (932s left) syncobj_wait (wait-all-complex)
[90.143040] Starting subtest: wait-all-complex
[90.358408] Subtest wait-all-complex: SUCCESS (0.212s)
[90.467109] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[90.603389] Starting subtest: reject-modify-context-protection-on
[90.604683] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[90.760878] [011/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[90.877557] Starting subtest: cursorA-vs-flipB-varying-size
[90.879365] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[91.036925] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[91.142069] Starting subtest: primary-rotation-90
[91.143726] Subtest primary-rotation-90: SKIP (0.001s)
[91.229276] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[91.284740] Starting subtest: reset-multiple-signaled
[91.285764] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[91.399826] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[91.496413] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[91.498290] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[92.652571] [015/133] (930s left) gem_softpin (noreloc-s3)
[92.708091] Starting subtest: noreloc-S3
[112.155565] Subtest noreloc-S3: SUCCESS (5.391s)
[115.307310] [016/133] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[115.408283] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[119.985073] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.455s)
[121.159581] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[121.207696] Starting subtest: invalid-ctx-set
[121.208777] Subtest invalid-ctx-set: SUCCESS (0.001s)
[121.339757] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[121.394370] Starting subtest: single-wait-all-for-submit-unsubmitted
[121.495124] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.099s)
[121.593466] [019/133] (904s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[121.707477] Starting subtest: x-tiled-64bpp-rotate-90
[121.729605] Subtest x-tiled-64bpp-rotate-90: SKIP (0.021s)
[121.885514] [020/133] (904s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[121.942891] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[122.005447] [021/133] (904s left) kms_psr (fbc-psr-cursor-plane-move)
[122.099871] Starting subtest: fbc-psr-cursor-plane-move
[122.100765] Starting dynamic subtest: eDP-1
[122.102507] Dynamic subtest eDP-1: SKIP (0.000s)
[122.104200] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[122.191970] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[122.314443] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[123.295413] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.967s)
[123.439412] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[123.534933] Starting subtest: 2x-flip-vs-rmfb
[123.547816] Subtest 2x-flip-vs-rmfb: SKIP (0.013s)
[123.646490] [024/133] (902s left) kms_plane_cursor (viewport)
[123.730127] Starting subtest: viewport
[123.732081] Starting dynamic subtest: pipe-A-eDP-1-size-64
[126.177239] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.420s)
[126.237294] Starting dynamic subtest: pipe-A-eDP-1-size-128
[128.676922] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.426s)
[128.738807] Starting dynamic subtest: pipe-A-eDP-1-size-256
[131.204884] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.459s)
[131.553819] Starting dynamic subtest: pipe-B-eDP-1-size-64
[134.642915] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.084s)
[134.703180] Starting dynamic subtest: pipe-B-eDP-1-size-128
[137.184236] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[137.246021] Starting dynamic subtest: pipe-B-eDP-1-size-256
[139.860296] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.617s)
[140.210103] Starting dynamic subtest: pipe-C-eDP-1-size-64
[143.118872] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.912s)
[143.157406] Starting dynamic subtest: pipe-C-eDP-1-size-128
[145.186912] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.036s)
[145.232055] Starting dynamic subtest: pipe-C-eDP-1-size-256
[147.243826] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.024s)
[147.568692] Starting dynamic subtest: pipe-D-eDP-1-size-64
[150.386473] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.824s)
[150.422351] Starting dynamic subtest: pipe-D-eDP-1-size-128
[152.530407] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[152.571030] Starting dynamic subtest: pipe-D-eDP-1-size-256
[154.664953] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[154.986676] Subtest viewport: SUCCESS (31.153s)
[155.813774] [025/133] (870s left) kms_cdclk (mode-transition)
[155.903731] Starting subtest: mode-transition
[155.904819] Starting dynamic subtest: pipe-A-eDP-1
[156.201764] Dynamic subtest pipe-A-eDP-1: SKIP (0.296s)
[156.208656] Starting dynamic subtest: pipe-B-eDP-1
[156.210593] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[156.217328] Starting dynamic subtest: pipe-C-eDP-1
[156.219206] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[156.225846] Starting dynamic subtest: pipe-D-eDP-1
[156.227831] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[156.229733] Subtest mode-transition: SKIP (0.303s)
[157.043091] [026/133] (869s left) gem_exec_balancer (fairslice)
[157.109630] Starting subtest: fairslice
[160.003682] Subtest fairslice: SUCCESS (2.890s)
[161.002408] [027/133] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[161.116879] Starting subtest: basic-flip-before-cursor-varying-size
[162.030882] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.913s)
[162.874828] [028/133] (863s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[162.979615] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[162.980626] Starting dynamic subtest: pipe-A-default-mode
[163.265269] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[163.267068] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.286s)
[164.111800] [029/133] (862s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[164.205533] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[164.206450] Starting dynamic subtest: pipe-A-default-mode
[166.942384] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s)
[166.943190] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.736s)
[167.806037] [030/133] (858s left) core_getstats (basic)
[167.866650] Starting subtest: basic
[167.867667] Subtest basic: SUCCESS (0.000s)
[167.977697] [031/133] (858s left) kms_rmfb (close-fd)
[168.066528] Starting subtest: close-fd
[168.067439] Starting dynamic subtest: pipe-A-eDP-1
[168.174103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[168.181501] Starting dynamic subtest: pipe-B-eDP-1
[169.365794] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[169.373870] Starting dynamic subtest: pipe-C-eDP-1
[170.488596] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[170.495979] Starting dynamic subtest: pipe-D-eDP-1
[171.623191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[171.624243] Subtest close-fd: SUCCESS (3.554s)
[172.861859] [032/133] (853s left) gem_exec_reloc (basic-gtt-wc)
[172.909567] Subtest basic-gtt-wc: SKIP (0.000s)
[172.974781] [033/133] (853s left) kms_properties (crtc-properties-legacy)
[173.072837] Starting subtest: crtc-properties-legacy
[173.073937] Starting dynamic subtest: pipe-A-eDP-1
[173.507899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[173.516118] Starting dynamic subtest: pipe-B-eDP-1
[174.696911] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.186s)
[174.705345] Starting dynamic subtest: pipe-C-eDP-1
[175.815635] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[175.823163] Starting dynamic subtest: pipe-D-eDP-1
[176.946841] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[176.947872] Subtest crtc-properties-legacy: SUCCESS (3.873s)
[177.777546] [034/133] (848s left) kms_invalid_mode (zero-hdisplay)
[177.875826] Starting subtest: zero-hdisplay
[177.876765] Starting dynamic subtest: pipe-A-eDP-1
[178.158584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[178.165576] Starting dynamic subtest: pipe-B-eDP-1
[178.166509] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[178.172842] Starting dynamic subtest: pipe-C-eDP-1
[178.173751] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[178.180436] Starting dynamic subtest: pipe-D-eDP-1
[178.181476] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[178.182405] Subtest zero-hdisplay: SUCCESS (0.288s)
[178.998869] [035/133] (847s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[179.096026] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[179.096949] Starting dynamic subtest: pipe-A
[180.168645] Dynamic subtest pipe-A: SUCCESS (1.073s)
[180.175626] Starting dynamic subtest: pipe-B
[182.290141] Dynamic subtest pipe-B: SUCCESS (2.120s)
[182.297181] Starting dynamic subtest: pipe-C
[183.497999] Dynamic subtest pipe-C: SUCCESS (1.207s)
[183.504867] Starting dynamic subtest: pipe-D
[184.636856] Dynamic subtest pipe-D: SUCCESS (1.137s)
[184.637753] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.540s)
[185.852560] [036/133] (840s left) kms_pm_rpm (legacy-planes-dpms)
[188.073787] Starting subtest: legacy-planes-dpms
[188.074990] Starting dynamic subtest: plane-63
[196.663834] Dynamic subtest plane-63: SUCCESS (8.587s)
[196.674477] Starting dynamic subtest: plane-93
[204.942640] Dynamic subtest plane-93: SUCCESS (8.271s)
[204.955763] Starting dynamic subtest: plane-123
[213.313936] Dynamic subtest plane-123: SUCCESS (8.372s)
[213.324916] Starting dynamic subtest: plane-133
[221.911481] Dynamic subtest plane-133: SUCCESS (8.597s)
[221.915259] Subtest legacy-planes-dpms: SUCCESS (33.838s)
[222.279519] [037/133] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[222.381674] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[222.383289] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[222.512243] [038/133] (804s left) kms_dirtyfb (default-dirtyfb-ioctl)
[222.609138] Starting subtest: default-dirtyfb-ioctl
[222.610072] Starting dynamic subtest: A-eDP-1
[224.183709] Dynamic subtest A-eDP-1: SUCCESS (1.573s)
[224.184610] Subtest default-dirtyfb-ioctl: SUCCESS (1.574s)
[225.019755] [039/133] (801s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[225.133637] Starting subtest: cursorB-vs-flipA-legacy
[225.137029] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[225.294757] [040/133] (801s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[225.352323] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[225.353494] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[225.485041] [041/133] (801s left) kms_prime (basic-crc-vgem)
[225.606791] Starting subtest: basic-crc-vgem
[225.607724] Starting dynamic subtest: second-to-first
[226.510658] Dynamic subtest second-to-first: SUCCESS (0.904s)
[226.512916] Subtest basic-crc-vgem: SUCCESS (0.906s)
[226.618416] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[226.620312] [042/133] (800s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[226.708207] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[226.774801] [043/133] (800s left) i915_drm_fdinfo (busy)
[226.814300] Starting subtest: busy
[226.815233] Starting dynamic subtest: rcs0
[226.853506] Dynamic subtest rcs0: SKIP (0.039s)
[226.862958] Starting dynamic subtest: bcs0
[226.864674] Dynamic subtest bcs0: SKIP (0.000s)
[226.871381] Starting dynamic subtest: vcs0
[226.873043] Dynamic subtest vcs0: SKIP (0.000s)
[226.879702] Starting dynamic subtest: vcs1
[226.881422] Dynamic subtest vcs1: SKIP (0.000s)
[226.888086] Starting dynamic subtest: vecs0
[226.889846] Dynamic subtest vecs0: SKIP (0.000s)
[226.896746] Starting dynamic subtest: ccs0
[226.898531] Dynamic subtest ccs0: SKIP (0.000s)
[226.900266] Subtest busy: SKIP (0.046s)
[226.953921] [044/133] (799s left) gem_userptr_blits (nohangcheck)
[227.027497] Starting subtest: nohangcheck
[227.289261] Subtest nohangcheck: SUCCESS (0.260s)
[227.444481] [045/133] (799s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[227.535077] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[228.149311] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.614s)
[228.327621] [046/133] (798s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[228.419476] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[228.421165] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[229.542585] [047/133] (797s left) kms_scaling_modes (scaling-mode-full)
[229.639341] Starting subtest: scaling-mode-full
[229.640200] Starting dynamic subtest: pipe-A-eDP-1
[229.733306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[229.742046] Starting dynamic subtest: pipe-B-eDP-1
[230.861426] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[230.870011] Starting dynamic subtest: pipe-C-eDP-1
[231.968548] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[231.977375] Starting dynamic subtest: pipe-D-eDP-1
[233.104478] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[233.105471] Subtest scaling-mode-full: SUCCESS (3.467s)
[234.303775] [048/133] (792s left) kms_psr (fbc-pr-basic)
[234.398545] Starting subtest: fbc-pr-basic
[234.400252] Subtest fbc-pr-basic: SKIP (0.000s)
[234.488683] [049/133] (792s left) gem_ringfill (basic-all)
[240.001434] Starting subtest: basic-all
[241.160613] Subtest basic-all: SUCCESS (1.158s)
[241.321791] [050/133] (785s left) gem_exec_whisper (basic-fds-forked-all)
[241.389582] Starting subtest: basic-fds-forked-all
[263.774423] Subtest basic-fds-forked-all: SUCCESS (22.380s)
[263.977295] [051/133] (763s left) api_intel_bb (full-batch)
[264.040317] Starting subtest: full-batch
[264.053044] Subtest full-batch: SUCCESS (0.013s)
[264.210997] [052/133] (762s left) kms_cursor_crc (cursor-sliding-256x85)
[264.453558] Starting subtest: cursor-sliding-256x85
[264.497888] Subtest cursor-sliding-256x85: SKIP (0.042s)
[264.718990] [053/133] (762s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[264.811232] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[264.812042] Starting dynamic subtest: pipe-A-eDP-1
[264.833127] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[264.841250] Starting dynamic subtest: pipe-B-eDP-1
[264.862178] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[264.869961] Starting dynamic subtest: pipe-C-eDP-1
[264.890496] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[264.897772] Starting dynamic subtest: pipe-D-eDP-1
[264.919744] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[264.921452] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[267.069801] [054/133] (760s left) gen9_exec_parse (allowed-single)
[267.126872] Subtest allowed-single: SKIP (0.000s)
[267.194719] [055/133] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[267.302778] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[274.292081] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.989s)
[274.457891] [056/133] (752s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[274.543736] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[274.546201] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[274.660971] [057/133] (752s left) gem_exec_fence (expired-history)
[275.144072] Starting subtest: expired-history
[282.790091] Subtest expired-history: SUCCESS (7.642s)
[283.267460] [058/133] (744s left) kms_psr (fbc-psr-sprite-plane-move)
[283.355186] Starting subtest: fbc-psr-sprite-plane-move
[283.356118] Starting dynamic subtest: eDP-1
[283.357918] Dynamic subtest eDP-1: SKIP (0.000s)
[283.359637] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[283.446792] [059/133] (743s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[283.525547] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[290.187719] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.661s)
[290.319477] [060/133] (737s left) gem_ctx_bad_destroy (double-destroy)
[290.377719] Starting subtest: double-destroy
[290.378859] Subtest double-destroy: SUCCESS (0.000s)
[290.466691] [061/133] (736s left) syncobj_timeline (invalid-signal-illegal-handle)
[290.520858] Starting subtest: invalid-signal-illegal-handle
[290.522240] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[290.647702] [062/133] (736s left) kms_chamelium_hpd (common-hpd-after-suspend)
[291.033021] Subtest common-hpd-after-suspend: SKIP (0.000s)
[291.807754] [063/133] (735s left) kms_frontbuffer_tracking (fbc-tiling-4)
[291.900602] Starting subtest: fbc-tiling-4
[296.180699] Subtest fbc-tiling-4: SUCCESS (4.279s)
[297.354320] [064/133] (730s left) gem_cs_tlb (engines)
[297.422843] Starting subtest: engines
[297.423832] Starting dynamic subtest: rcs0
[299.579198] Dynamic subtest rcs0: SUCCESS (2.154s)
[299.587875] Starting dynamic subtest: bcs0
[301.732868] Dynamic subtest bcs0: SUCCESS (2.151s)
[301.742873] Starting dynamic subtest: vcs0
[303.887005] Dynamic subtest vcs0: SUCCESS (2.153s)
[303.896877] Starting dynamic subtest: vcs1
[306.042695] Dynamic subtest vcs1: SUCCESS (2.154s)
[306.052264] Starting dynamic subtest: vecs0
[308.195117] Dynamic subtest vecs0: SUCCESS (2.151s)
[308.203326] Starting dynamic subtest: ccs0
[310.349746] Dynamic subtest ccs0: SUCCESS (2.154s)
[310.350660] Subtest engines: SUCCESS (12.923s)
[310.526353] [065/133] (717s left) gem_mmap_gtt (hang-busy)
[310.587884] Subtest hang-busy: SKIP (0.000s)
[310.655798] [066/133] (716s left) kms_psr (psr2-sprite-plane-onoff)
[310.761569] Starting subtest: psr2-sprite-plane-onoff
[310.762505] Starting dynamic subtest: eDP-1
[312.533644] Dynamic subtest eDP-1: SUCCESS (1.771s)
[312.534587] Subtest psr2-sprite-plane-onoff: SUCCESS (1.772s)
[313.403520] [067/133] (714s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[313.497134] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[314.122593] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.625s)
[314.281324] [068/133] (713s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[314.366486] Starting subtest: y-tiled-64bpp-rotate-270
[314.368436] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[314.472576] [069/133] (713s left) gem_bad_reloc (negative-reloc-lut)
[314.532267] Subtest negative-reloc-lut: SKIP (0.000s)
[314.610097] [070/133] (713s left) gem_ctx_persistence (engines-mixed)
[314.677506] Starting subtest: engines-mixed
[314.678482] Starting dynamic subtest: rcs0
[314.786561] Dynamic subtest rcs0: SUCCESS (0.108s)
[314.797703] Starting dynamic subtest: bcs0
[314.866184] Dynamic subtest bcs0: SUCCESS (0.078s)
[314.878375] Starting dynamic subtest: vcs0
[314.948191] Dynamic subtest vcs0: SUCCESS (0.080s)
[314.960699] Starting dynamic subtest: vcs1
[315.028804] Dynamic subtest vcs1: SUCCESS (0.079s)
[315.039561] Starting dynamic subtest: vecs0
[315.113218] Dynamic subtest vecs0: SUCCESS (0.082s)
[315.122859] Starting dynamic subtest: ccs0
[315.185659] Dynamic subtest ccs0: SUCCESS (0.071s)
[315.187095] Subtest engines-mixed: SUCCESS (0.509s)
[315.283948] [071/133] (712s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[315.368466] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[315.369297] Starting dynamic subtest: pipe-A
[315.432678] Dynamic subtest pipe-A: SUCCESS (0.065s)
[315.443379] Starting dynamic subtest: pipe-B
[316.616742] Dynamic subtest pipe-B: SUCCESS (1.182s)
[316.626909] Starting dynamic subtest: pipe-C
[317.721746] Dynamic subtest pipe-C: SUCCESS (1.101s)
[317.734235] Starting dynamic subtest: pipe-D
[318.851486] Dynamic subtest pipe-D: SUCCESS (1.127s)
[318.854712] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.484s)
[320.018023] [072/133] (707s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[320.103515] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[320.105143] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[320.231943] [073/133] (707s left) gem_exec_schedule (semaphore-noskip)
[320.295830] Starting subtest: semaphore-noskip
[320.719822] Subtest semaphore-noskip: SUCCESS (0.421s)
[321.112264] [074/133] (706s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[321.221821] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[321.223659] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[321.355261] [075/133] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[321.447189] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[321.449050] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[321.564736] [076/133] (706s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[321.668123] Starting subtest: 4-tiled-16bpp-rotate-0
[323.026168] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.358s)
[323.167755] [077/133] (704s left) gem_exec_basic (basic)
[323.224857] Starting subtest: basic
[323.225844] Starting dynamic subtest: rcs0-smem
[323.228139] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[323.235984] Starting dynamic subtest: bcs0-smem
[323.236802] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[323.244301] Starting dynamic subtest: vcs0-smem
[323.245087] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[323.252720] Starting dynamic subtest: vcs1-smem
[323.253785] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[323.262760] Starting dynamic subtest: vecs0-smem
[323.263641] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[323.270708] Starting dynamic subtest: ccs0-smem
[323.271611] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[323.272484] Subtest basic: SUCCESS (0.018s)
[324.980536] [078/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[325.090027] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[325.091629] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[325.228410] [079/133] (702s left) gem_mmap (short-mmap)
[325.277293] Subtest short-mmap: SKIP (0.000s)
[325.329438] [080/133] (702s left) gem_exec_reloc (basic-gtt-wc-active)
[325.379101] Subtest basic-gtt-wc-active: SKIP (0.000s)
[325.430947] [081/133] (702s left) gem_ctx_shared (create-shared-gtt)
[325.497194] Starting subtest: create-shared-gtt
[327.650229] Subtest create-shared-gtt: SUCCESS (2.151s)
[328.086962] [082/133] (700s left) gem_exec_reloc (basic-write-wc)
[328.142844] Subtest basic-write-wc: SKIP (0.000s)
[328.206816] [083/133] (699s left) gem_eio (wait-immediate)
[328.441449] Starting subtest: wait-immediate
[328.866006] Subtest wait-immediate: SUCCESS (0.425s)
[329.043679] [084/133] (699s left) gem_ctx_persistence (legacy-engines-mixed)
[329.097975] Starting subtest: legacy-engines-mixed
[329.099011] Starting dynamic subtest: render
[329.157394] Dynamic subtest render: SUCCESS (0.059s)
[329.168791] Starting dynamic subtest: bsd1
[329.202411] Dynamic subtest bsd1: SUCCESS (0.043s)
[329.213136] Starting dynamic subtest: bsd2
[329.277034] Dynamic subtest bsd2: SUCCESS (0.072s)
[329.289199] Starting dynamic subtest: blt
[329.331755] Dynamic subtest blt: SUCCESS (0.052s)
[329.343601] Starting dynamic subtest: vebox
[329.405679] Dynamic subtest vebox: SUCCESS (0.071s)
[329.406993] Subtest legacy-engines-mixed: SUCCESS (0.309s)
[329.502664] [085/133] (698s left) perf_pmu (semaphore-busy)
[329.538231] Starting subtest: semaphore-busy
[329.539227] Starting dynamic subtest: rcs0
[331.189674] Dynamic subtest rcs0: SUCCESS (1.648s)
[331.200558] Starting dynamic subtest: bcs0
[332.822176] Dynamic subtest bcs0: SUCCESS (1.629s)
[332.833226] Starting dynamic subtest: vcs0
[336.501830] Dynamic subtest vcs0: SUCCESS (3.676s)
[336.512516] Starting dynamic subtest: vcs1
[342.455649] Dynamic subtest vcs1: SUCCESS (5.953s)
[342.466340] Starting dynamic subtest: vecs0
[348.466323] Dynamic subtest vecs0: SUCCESS (6.013s)
[348.476872] Starting dynamic subtest: ccs0
[351.545926] Dynamic subtest ccs0: SUCCESS (3.075s)
[351.547572] Subtest semaphore-busy: SUCCESS (22.010s)
[351.693508] [086/133] (676s left) gem_exec_schedule (pi-common)
[351.875798] Starting subtest: pi-common
[351.876777] Starting dynamic subtest: rcs0
[351.913869] Dynamic subtest rcs0: SUCCESS (0.040s)
[351.926243] Starting dynamic subtest: bcs0
[351.957024] Dynamic subtest bcs0: SUCCESS (0.042s)
[351.966294] Starting dynamic subtest: vcs0
[351.994291] Dynamic subtest vcs0: SUCCESS (0.036s)
[352.002728] Starting dynamic subtest: vcs1
[352.028396] Dynamic subtest vcs1: SUCCESS (0.033s)
[352.036752] Starting dynamic subtest: vecs0
[352.058097] Dynamic subtest vecs0: SUCCESS (0.029s)
[352.066518] Starting dynamic subtest: ccs0
[352.089466] Dynamic subtest ccs0: SUCCESS (0.030s)
[352.090347] Subtest pi-common: SUCCESS (0.216s)
[352.376364] [087/133] (675s left) i915_hangman (engine-error-state-capture)
[352.446815] Starting subtest: engine-error-state-capture
[352.447640] Starting dynamic subtest: rcs0
[355.931463] Dynamic subtest rcs0: SUCCESS (3.482s)
[355.942342] Starting dynamic subtest: bcs0
[361.948482] Dynamic subtest bcs0: SUCCESS (6.015s)
[361.959527] Starting dynamic subtest: vcs0
[367.899459] Dynamic subtest vcs0: SUCCESS (5.949s)
[367.909860] Starting dynamic subtest: vcs1
[373.915073] Dynamic subtest vcs1: SUCCESS (6.014s)
[373.925785] Starting dynamic subtest: vecs0
[379.931911] Dynamic subtest vecs0: SUCCESS (6.015s)
[379.943095] Starting dynamic subtest: ccs0
[385.944469] Dynamic subtest ccs0: SUCCESS (6.012s)
[385.946031] Subtest engine-error-state-capture: SUCCESS (33.502s)
[386.041758] [088/133] (642s left) syncobj_timeline (wait-for-submit-snapshot)
[386.111409] Starting subtest: wait-for-submit-snapshot
[386.194619] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[386.293576] [089/133] (642s left) kms_color (ctm-blue-to-red)
[386.404174] Starting subtest: ctm-blue-to-red
[386.405042] Starting dynamic subtest: pipe-A-eDP-1
[387.067226] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.662s)
[387.075479] Starting dynamic subtest: pipe-B-eDP-1
[388.477646] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[388.486362] Starting dynamic subtest: pipe-C-eDP-1
[389.819580] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s)
[389.828117] Starting dynamic subtest: pipe-D-eDP-1
[391.173986] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[391.174917] Subtest ctm-blue-to-red: SUCCESS (4.769s)
[392.020556] [090/133] (636s left) prime_vgem (basic-gtt)
[392.094590] Starting subtest: basic-gtt
[392.096664] Subtest basic-gtt: SKIP (0.000s)
[392.231386] [091/133] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[392.327697] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[399.727809] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.401s)
[399.911199] [092/133] (628s left) api_intel_allocator (default-alignment)
[399.972890] Starting subtest: default-alignment
[399.974971] Subtest default-alignment: SUCCESS (0.003s)
[400.118678] [093/133] (628s left) i915_pm_rps (fence-order)
[400.169425] Starting subtest: fence-order
[403.602744] Subtest fence-order: SUCCESS (3.433s)
[403.763332] [094/133] (624s left) kms_vblank (query-busy)
[403.871131] Starting subtest: query-busy
[403.872085] Starting dynamic subtest: pipe-A-eDP-1
[405.755022] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[405.765206] Starting dynamic subtest: pipe-D-eDP-1
[408.281003] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[408.281946] Subtest query-busy: SUCCESS (4.410s)
[409.100553] [095/133] (619s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[409.195108] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[409.196794] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[409.319276] [096/133] (619s left) kms_addfb_basic (invalid-get-prop-any)
[409.381523] Starting subtest: invalid-get-prop-any
[409.382522] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[409.550967] [097/133] (619s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[409.654918] Starting subtest: fbc-psr2-cursor-mmap-gtt
[409.655755] Starting dynamic subtest: eDP-1
[409.657334] Dynamic subtest eDP-1: SKIP (0.000s)
[409.658916] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.002s)
[409.748117] [098/133] (618s left) kms_flip (2x-blocking-absolute-wf_vblank)
[409.838320] Starting subtest: 2x-blocking-absolute-wf_vblank
[409.848745] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[409.980204] [099/133] (618s left) kms_cursor_crc (cursor-onscreen-256x85)
[410.221285] Starting subtest: cursor-onscreen-256x85
[410.260807] Subtest cursor-onscreen-256x85: SKIP (0.038s)
[410.464673] [100/133] (618s left) kms_flip (2x-modeset-vs-vblank-race)
[410.550309] Starting subtest: 2x-modeset-vs-vblank-race
[410.561227] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[410.657636] [101/133] (618s left) kms_atomic_interruptible (atomic-setmode)
[410.752583] Starting subtest: atomic-setmode
[410.753443] Starting dynamic subtest: pipe-A-eDP-1
[417.644559] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.890s)
[417.645448] Subtest atomic-setmode: SUCCESS (6.891s)
[418.529736] [102/133] (610s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[418.630546] Starting subtest: psr-argb161616f-draw-render
[418.632233] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[418.756036] [103/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[418.851730] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[418.853302] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[418.968653] [104/133] (609s left) kms_plane_scaling (invalid-num-scalers)
[419.060628] Starting subtest: invalid-num-scalers
[419.061590] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[419.077845] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[419.087711] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[419.109061] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[419.117694] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[419.140285] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[419.148360] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[419.170975] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[419.171849] Subtest invalid-num-scalers: SUCCESS (0.111s)
[419.308497] [105/133] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[419.394064] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[419.395879] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[419.503964] [106/133] (609s left) sw_sync (alloc_fence_invalid_timeline)
[419.539781] Starting subtest: alloc_fence_invalid_timeline
[419.540703] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[419.616507] [107/133] (609s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[419.662190] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[419.768039] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[419.859265] [108/133] (609s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[419.943267] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[419.945558] Starting dynamic subtest: A-eDP1
[428.858323] Dynamic subtest A-eDP1: SUCCESS (8.911s)
[428.869295] Starting dynamic subtest: B-eDP1
[437.792228] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[437.802087] Starting dynamic subtest: C-eDP1
[446.715597] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[446.727669] Starting dynamic subtest: D-eDP1
[455.640599] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[455.643375] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.695s)
[456.883289] [109/133] (572s left) kms_addfb_basic (size-max)
[456.972403] Starting subtest: size-max
[456.973324] Subtest size-max: SUCCESS (0.000s)
[457.107316] [110/133] (571s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[457.364700] Starting subtest: cursor-rapid-movement-256x256
[457.367900] Starting dynamic subtest: pipe-A-eDP-1
[457.919201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[457.947234] Starting dynamic subtest: pipe-D-eDP-1
[459.196292] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s)
[459.197186] Subtest cursor-rapid-movement-256x256: SUCCESS (1.830s)
[460.050042] [111/133] (569s left) gem_exec_whisper (basic-queues-all)
[460.111668] Starting subtest: basic-queues-all
[468.271651] Subtest basic-queues-all: SUCCESS (8.157s)
[468.477190] [112/133] (560s left) kms_dsc (dsc-fractional-bpp)
[468.567184] Starting subtest: dsc-fractional-bpp
[468.572575] Subtest dsc-fractional-bpp: SKIP (0.000s)
[468.661392] [113/133] (560s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[468.758707] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[468.759651] Starting dynamic subtest: pipe-A-default-mode
[469.043820] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[469.045660] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.284s)
[469.875084] [114/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[469.976625] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[469.978393] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[470.090835] [115/133] (559s left) gem_softpin (evict-prime)
[470.162449] Starting subtest: evict-prime
[470.163486] Starting dynamic subtest: rcs0
[471.360215] Dynamic subtest rcs0: SUCCESS (1.198s)
[471.372299] Starting dynamic subtest: bcs0
[472.511846] Dynamic subtest bcs0: SUCCESS (1.150s)
[472.524761] Starting dynamic subtest: vcs0
[473.932618] Dynamic subtest vcs0: SUCCESS (1.416s)
[473.944107] Starting dynamic subtest: vcs1
[476.003592] Dynamic subtest vcs1: SUCCESS (2.068s)
[476.015075] Starting dynamic subtest: vecs0
[477.959438] Dynamic subtest vecs0: SUCCESS (1.953s)
[477.968569] Starting dynamic subtest: ccs0
[479.118140] Dynamic subtest ccs0: SUCCESS (1.158s)
[479.131051] Starting dynamic subtest: all
[480.985975] Dynamic subtest all: SUCCESS (1.862s)
[480.987446] Subtest evict-prime: SUCCESS (10.821s)
[481.082360] [116/133] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[481.192693] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[481.194403] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[481.315727] [117/133] (547s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[481.414427] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[481.550246] [118/133] (547s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[481.620988] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[481.728980] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[481.821805] [119/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[481.915811] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[481.917426] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[482.040000] [120/133] (547s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[482.132619] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[486.273429] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.140s)
[487.472306] [121/133] (541s left) gem_mmap_wc (bad-size)
[487.533895] Subtest bad-size: SKIP (0.000s)
[487.593189] [122/133] (541s left) kms_hdr (static-toggle-suspend)
[487.692577] Starting subtest: static-toggle-suspend
[487.695237] Subtest static-toggle-suspend: SKIP (0.000s)
[487.782141] [123/133] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[487.878423] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[487.880080] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[488.009978] [124/133] (541s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[493.019097] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[493.021312] Starting dynamic subtest: pipe-A-eDP-1
[493.810875] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[493.821202] Starting dynamic subtest: pipe-B-eDP-1
[494.951184] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[494.953068] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.931s)
[496.160935] [125/133] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[496.255955] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[496.257928] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[496.392864] [126/133] (533s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[496.484337] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[496.485224] Starting dynamic subtest: pipe-A-eDP-1
[496.497659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[496.508556] Starting dynamic subtest: pipe-B-eDP-1
[496.518533] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[496.528692] Starting dynamic subtest: pipe-C-eDP-1
[496.535705] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[496.543469] Starting dynamic subtest: pipe-D-eDP-1
[496.550479] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[496.551269] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[498.749563] [127/133] (530s left) syncobj_timeline (single-wait-all-available-submitted)
[498.796114] Starting subtest: single-wait-all-available-submitted
[498.796905] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[498.928117] [128/133] (530s left) gem_exec_parallel (userptr)
[498.983090] Starting subtest: userptr
[498.983998] Starting dynamic subtest: rcs0
[500.455763] Dynamic subtest rcs0: SUCCESS (1.472s)
[500.466878] Starting dynamic subtest: bcs0
[501.940235] Dynamic subtest bcs0: SUCCESS (1.482s)
[501.952460] Starting dynamic subtest: vcs0
[503.932144] Dynamic subtest vcs0: SUCCESS (1.987s)
[503.941902] Starting dynamic subtest: vcs1
[505.916464] Dynamic subtest vcs1: SUCCESS (1.981s)
[505.925905] Starting dynamic subtest: vecs0
[507.964873] Dynamic subtest vecs0: SUCCESS (2.045s)
[507.975666] Starting dynamic subtest: ccs0
[509.502514] Dynamic subtest ccs0: SUCCESS (1.536s)
[509.503903] Subtest userptr: SUCCESS (10.517s)
[509.705605] [129/133] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[509.803379] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[509.805097] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[509.943523] [130/133] (519s left) i915_selftest (mock)
[513.503660] Starting subtest: mock
[513.505225] Starting dynamic subtest: sanitycheck
[514.163108] Dynamic subtest sanitycheck: SUCCESS (0.659s)
[514.171545] Starting dynamic subtest: shmem
[514.826200] Dynamic subtest shmem: SUCCESS (0.661s)
[514.834749] Starting dynamic subtest: fence
[522.171063] Dynamic subtest fence: SUCCESS (7.340s)
[522.179277] Starting dynamic subtest: scatterlist
[523.834847] Dynamic subtest scatterlist: SUCCESS (1.661s)
[523.843580] Starting dynamic subtest: syncmap
[527.066960] Dynamic subtest syncmap: SUCCESS (3.229s)
[527.076066] Starting dynamic subtest: uncore
[527.701886] Dynamic subtest uncore: SUCCESS (0.633s)
[527.710321] Starting dynamic subtest: ring
[528.373002] Dynamic subtest ring: SUCCESS (0.669s)
[528.381571] Starting dynamic subtest: engine
[529.044976] Dynamic subtest engine: SUCCESS (0.670s)
[529.053560] Starting dynamic subtest: timelines
[532.861003] Dynamic subtest timelines: SUCCESS (3.812s)
[532.868934] Starting dynamic subtest: requests
[536.595751] Dynamic subtest requests: SUCCESS (3.732s)
[536.603576] Starting dynamic subtest: objects
[537.382298] Dynamic subtest objects: SUCCESS (0.785s)
[537.390190] Starting dynamic subtest: phys
[538.216346] Dynamic subtest phys: SUCCESS (0.832s)
[538.224223] Starting dynamic subtest: dmabuf
[539.038328] Dynamic subtest dmabuf: SUCCESS (0.820s)
[539.052552] Starting dynamic subtest: vma
[544.374428] Dynamic subtest vma: SUCCESS (5.332s)
[544.382794] Starting dynamic subtest: evict
[545.772233] Dynamic subtest evict: SUCCESS (1.395s)
[545.780986] Starting dynamic subtest: gtt
[548.970927] Dynamic subtest gtt: SUCCESS (3.196s)
[548.979406] Starting dynamic subtest: hugepages
[549.877618] Dynamic subtest hugepages: SUCCESS (0.905s)
[549.886072] Starting dynamic subtest: memory_region
[552.460903] Dynamic subtest memory_region: SUCCESS (2.580s)
[552.462256] Subtest mock: SUCCESS (38.948s)
[552.487106] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[552.487792] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[552.489720] [131/133] (477s left) gem_mmap_gtt (basic-write-read)
[553.941384] Subtest basic-write-read: SKIP (0.000s)
[554.001207] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[554.002560] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[554.005039] [132/133] (475s left) perf (gen12-group-exclusive-stream-sample-oa)
[554.140838] Starting subtest: gen12-group-exclusive-stream-sample-oa
[554.163870] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.023s)
[554.199421] [133/133] (475s left) perf_pmu (busy-double-start)
[554.234356] Starting subtest: busy-double-start
[554.235381] Starting dynamic subtest: rcs0
[557.841709] Dynamic subtest rcs0: FAIL (3.587s)
[557.849696] Starting dynamic subtest: bcs0
[561.439959] Dynamic subtest bcs0: SUCCESS (3.615s)
[561.452679] Starting dynamic subtest: vcs0
[565.508714] Dynamic subtest vcs0: SUCCESS (4.065s)
[565.518932] Starting dynamic subtest: vcs1
[569.473660] Dynamic subtest vcs1: SUCCESS (3.962s)
[569.488647] Starting dynamic subtest: vecs0
[573.473029] Dynamic subtest vecs0: SUCCESS (3.995s)
[573.484396] Starting dynamic subtest: ccs0
[577.065695] Dynamic subtest ccs0: FAIL (3.564s)
[577.066573] Subtest busy-double-start: FAIL (22.800s)
[577.164586] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: gem_set_tiling_vs_blt
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_plane_cursor
results: parsing output: 24/ for test: kms_cdclk
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: core_getstats
results: parsing output: 30/ for test: kms_rmfb
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_dirtyfb
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_prime
results: parsing output: 41/ for test: kms_pipe_b_c_ivb
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_scaling_modes
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_ringfill
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_bad_destroy
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_cs_tlb
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_bad_reloc
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: i915_pm_rps
results: parsing output: 93/ for test: kms_vblank
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_atomic_interruptible
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_hdr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_parallel
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: i915_selftest
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: perf_pmu
Done.