[56.926964] Initializing watchdogs
[56.927017]   /dev/watchdog0
[56.940578] [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]
[56.944692] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.946976] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.950334] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[57.046962] Subtest write-snoop: SKIP (0.000s)
[57.132232] [002/133] (960s left) kms_content_protection (content-type-change)
[57.283797] Starting subtest: content-type-change
[57.288163] Subtest content-type-change: SKIP (0.000s)
[57.431795] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[57.538473] Starting subtest: multiplane-rotation
[75.039116] Subtest multiplane-rotation: SUCCESS (17.459s)
[75.200105] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[75.302950] Subtest ctm-red-to-blue: SKIP (0.000s)
[75.346996] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[75.414446] Starting subtest: invalid-reset-one-illegal-handle
[75.416452] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[75.558816] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[75.655474] Starting subtest: disable-crc-after-crtc
[75.657178] Starting dynamic subtest: pipe-A-eDP-1
[77.356175] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.700s)
[77.364850] Starting dynamic subtest: pipe-B-eDP-1
[79.598715] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.239s)
[79.608076] Starting dynamic subtest: pipe-C-eDP-1
[81.861566] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.260s)
[81.870339] Starting dynamic subtest: pipe-D-eDP-1
[84.121857] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.257s)
[84.123806] Subtest disable-crc-after-crtc: SUCCESS (8.460s)
[84.990282] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[85.069076] Subtest tiled-to-tiled: SKIP (0.000s)
[85.153614] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[85.215150] Starting subtest: wait-all-interrupted
[85.321803] Subtest wait-all-interrupted: SUCCESS (0.106s)
[85.419196] [009/133] (932s left) syncobj_wait (wait-all-complex)
[85.475168] Starting subtest: wait-all-complex
[85.688408] Subtest wait-all-complex: SUCCESS (0.213s)
[85.785246] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[85.927846] Starting subtest: reject-modify-context-protection-on
[85.930662] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[86.066976] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[86.206600] Starting subtest: cursorA-vs-flipB-varying-size
[86.211835] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[86.374130] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[86.475234] Starting subtest: primary-rotation-90
[86.479565] Subtest primary-rotation-90: SKIP (0.001s)
[86.566725] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[86.636059] Starting subtest: reset-multiple-signaled
[86.638433] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[86.776289] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.868051] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.872168] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[88.016726] [015/133] (929s left) gem_softpin (noreloc-s3)
[88.089548] Starting subtest: noreloc-S3
[108.004503] Subtest noreloc-S3: SUCCESS (5.413s)
[108.176553] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[108.302963] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[112.818786] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.457s)
[114.018986] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[114.080225] Starting subtest: invalid-ctx-set
[114.082711] Subtest invalid-ctx-set: SUCCESS (0.001s)
[114.233241] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[114.282589] Starting subtest: single-wait-all-for-submit-unsubmitted
[114.388092] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[114.484080] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[114.593843] Starting subtest: x-tiled-64bpp-rotate-90
[114.613408] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[114.759699] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[114.832145] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[114.892662] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[114.982955] Starting subtest: fbc-psr-cursor-plane-move
[114.985254] Starting dynamic subtest: eDP-1
[114.989387] Dynamic subtest eDP-1: SKIP (0.000s)
[114.993519] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[115.078326] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[115.176372] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[116.206849] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.022s)
[116.373686] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb)
[116.486093] Starting subtest: 2x-flip-vs-rmfb
[116.495559] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[116.597432] [024/133] (901s left) kms_plane_cursor (viewport)
[116.691473] Starting subtest: viewport
[116.695320] Starting dynamic subtest: pipe-A-eDP-1-size-64
[119.149275] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.442s)
[119.211484] Starting dynamic subtest: pipe-A-eDP-1-size-128
[121.683623] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s)
[121.743477] Starting dynamic subtest: pipe-A-eDP-1-size-256
[124.192837] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.448s)
[124.539803] Starting dynamic subtest: pipe-B-eDP-1-size-64
[127.763800] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.224s)
[127.824949] Starting dynamic subtest: pipe-B-eDP-1-size-128
[130.346686] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.526s)
[130.406220] Starting dynamic subtest: pipe-B-eDP-1-size-256
[132.895768] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.493s)
[133.243102] Starting dynamic subtest: pipe-C-eDP-1-size-64
[135.997390] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.763s)
[136.034528] Starting dynamic subtest: pipe-C-eDP-1-size-128
[138.119350] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.090s)
[138.155513] Starting dynamic subtest: pipe-C-eDP-1-size-256
[140.296752] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.146s)
[140.624589] Starting dynamic subtest: pipe-D-eDP-1-size-64
[143.491248] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.875s)
[143.527886] Starting dynamic subtest: pipe-D-eDP-1-size-128
[145.669192] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.146s)
[145.707286] Starting dynamic subtest: pipe-D-eDP-1-size-256
[147.825428] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.124s)
[148.143147] Subtest viewport: SUCCESS (31.400s)
[149.000994] [025/133] (869s left) kms_cdclk (mode-transition)
[149.110856] Starting subtest: mode-transition
[149.112912] Starting dynamic subtest: pipe-A-eDP-1
[149.402925] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[149.411387] Starting dynamic subtest: pipe-B-eDP-1
[149.415757] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[149.423213] Starting dynamic subtest: pipe-C-eDP-1
[149.427598] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[149.435427] Starting dynamic subtest: pipe-D-eDP-1
[149.439794] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[149.444065] Subtest mode-transition: SKIP (0.297s)
[150.216370] [026/133] (868s left) gem_exec_balancer (fairslice)
[150.284124] Starting subtest: fairslice
[153.134635] Subtest fairslice: SUCCESS (2.852s)
[154.421205] [027/133] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[154.546326] Starting subtest: basic-flip-before-cursor-varying-size
[155.463193] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.916s)
[156.353935] [028/133] (862s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[156.461308] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[156.463678] Starting dynamic subtest: pipe-A-default-mode
[156.746385] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[156.751177] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.285s)
[157.580623] [029/133] (860s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[157.688252] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[157.690696] Starting dynamic subtest: pipe-A-default-mode
[160.438675] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[160.441501] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.752s)
[161.293999] [030/133] (857s left) core_getstats (basic)
[161.361224] Starting subtest: basic
[161.363537] Subtest basic: SUCCESS (0.000s)
[161.498487] [031/133] (857s left) kms_rmfb (close-fd)
[161.602789] Starting subtest: close-fd
[161.604963] Starting dynamic subtest: pipe-A-eDP-1
[161.711321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[161.720448] Starting dynamic subtest: pipe-B-eDP-1
[162.935192] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s)
[162.945064] Starting dynamic subtest: pipe-C-eDP-1
[164.161934] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s)
[164.170420] Starting dynamic subtest: pipe-D-eDP-1
[165.293782] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[165.296036] Subtest close-fd: SUCCESS (3.691s)
[166.525983] [032/133] (852s left) gem_exec_reloc (basic-gtt-wc)
[166.594193] Subtest basic-gtt-wc: SKIP (0.000s)
[166.674190] [033/133] (851s left) kms_properties (crtc-properties-legacy)
[166.775884] Starting subtest: crtc-properties-legacy
[166.778227] Starting dynamic subtest: pipe-A-eDP-1
[167.209610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[167.218205] Starting dynamic subtest: pipe-B-eDP-1
[168.359556] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s)
[168.368241] Starting dynamic subtest: pipe-C-eDP-1
[169.479154] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[169.487838] Starting dynamic subtest: pipe-D-eDP-1
[170.629574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s)
[170.631876] Subtest crtc-properties-legacy: SUCCESS (3.853s)
[171.455423] [034/133] (847s left) kms_invalid_mode (zero-hdisplay)
[171.553063] Starting subtest: zero-hdisplay
[171.555397] Starting dynamic subtest: pipe-A-eDP-1
[171.835449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[171.847781] Starting dynamic subtest: pipe-B-eDP-1
[171.850090] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[171.860466] Starting dynamic subtest: pipe-C-eDP-1
[171.862359] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[171.870119] Starting dynamic subtest: pipe-D-eDP-1
[171.872134] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[171.874111] Subtest zero-hdisplay: SUCCESS (0.289s)
[172.684495] [035/133] (846s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[172.777005] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[172.779298] Starting dynamic subtest: pipe-A
[173.846992] Dynamic subtest pipe-A: SUCCESS (1.072s)
[173.855780] Starting dynamic subtest: pipe-B
[175.972382] Dynamic subtest pipe-B: SUCCESS (2.124s)
[175.980194] Starting dynamic subtest: pipe-C
[177.172674] Dynamic subtest pipe-C: SUCCESS (1.197s)
[177.186270] Starting dynamic subtest: pipe-D
[178.318703] Dynamic subtest pipe-D: SUCCESS (1.145s)
[178.320873] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.542s)
[179.535805] [036/133] (839s left) kms_pm_rpm (legacy-planes-dpms)
[181.470214] Starting subtest: legacy-planes-dpms
[181.472455] Starting dynamic subtest: plane-63
[189.742976] Dynamic subtest plane-63: SUCCESS (8.272s)
[189.756260] Starting dynamic subtest: plane-93
[198.388079] Dynamic subtest plane-93: SUCCESS (8.639s)
[198.400839] Starting dynamic subtest: plane-123
[207.014092] Dynamic subtest plane-123: SUCCESS (8.624s)
[207.025057] Starting dynamic subtest: plane-133
[215.633181] Dynamic subtest plane-133: SUCCESS (8.619s)
[215.635700] Subtest legacy-planes-dpms: SUCCESS (34.165s)
[216.004902] [037/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[216.107395] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[216.111958] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.220448] [038/133] (802s left) kms_dirtyfb (default-dirtyfb-ioctl)
[216.317013] Starting subtest: default-dirtyfb-ioctl
[216.318850] Starting dynamic subtest: A-eDP-1
[217.894156] Dynamic subtest A-eDP-1: SUCCESS (1.578s)
[217.896390] Subtest default-dirtyfb-ioctl: SUCCESS (1.580s)
[218.741476] [039/133] (800s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[218.881679] Starting subtest: cursorB-vs-flipA-legacy
[218.886217] Subtest cursorB-vs-flipA-legacy: SKIP (0.004s)
[219.057056] [040/133] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[219.119593] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[219.121992] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[219.249847] [041/133] (799s left) kms_prime (basic-crc-vgem)
[219.377070] Starting subtest: basic-crc-vgem
[219.379540] Starting dynamic subtest: second-to-first
[220.297974] Dynamic subtest second-to-first: SUCCESS (0.923s)
[220.299798] Subtest basic-crc-vgem: SUCCESS (0.924s)
[220.407607] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[220.410409] [042/133] (798s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[220.476765] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[220.558114] [043/133] (798s left) i915_drm_fdinfo (busy)
[220.597092] Starting subtest: busy
[220.599195] Starting dynamic subtest: rcs0
[220.628945] Dynamic subtest rcs0: SKIP (0.032s)
[220.639494] Starting dynamic subtest: bcs0
[220.643156] Dynamic subtest bcs0: SKIP (0.000s)
[220.651218] Starting dynamic subtest: vcs0
[220.654665] Dynamic subtest vcs0: SKIP (0.000s)
[220.662343] Starting dynamic subtest: vcs1
[220.665948] Dynamic subtest vcs1: SKIP (0.000s)
[220.673512] Starting dynamic subtest: vecs0
[220.677192] Dynamic subtest vecs0: SKIP (0.000s)
[220.684842] Starting dynamic subtest: ccs0
[220.688523] Dynamic subtest ccs0: SKIP (0.000s)
[220.692235] Subtest busy: SKIP (0.038s)
[220.726910] [044/133] (798s left) gem_userptr_blits (nohangcheck)
[220.794739] Starting subtest: nohangcheck
[221.050761] Subtest nohangcheck: SUCCESS (0.253s)
[221.206538] [045/133] (797s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[221.308808] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[221.899111] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.592s)
[222.073213] [046/133] (797s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[222.168081] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[222.172600] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[223.277789] [047/133] (795s left) kms_scaling_modes (scaling-mode-full)
[223.365392] Starting subtest: scaling-mode-full
[223.367666] Starting dynamic subtest: pipe-A-eDP-1
[223.457463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[223.465963] Starting dynamic subtest: pipe-B-eDP-1
[224.580303] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.122s)
[224.590035] Starting dynamic subtest: pipe-C-eDP-1
[225.690637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[225.699659] Starting dynamic subtest: pipe-D-eDP-1
[226.818348] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[226.820524] Subtest scaling-mode-full: SUCCESS (3.456s)
[228.017289] [048/133] (791s left) kms_psr (fbc-pr-basic)
[228.115969] Starting subtest: fbc-pr-basic
[228.120405] Subtest fbc-pr-basic: SKIP (0.000s)
[228.240698] [049/133] (791s left) gem_ringfill (basic-all)
[234.425524] Starting subtest: basic-all
[235.531020] Subtest basic-all: SUCCESS (1.161s)
[235.699365] [050/133] (783s left) gem_exec_whisper (basic-fds-forked-all)
[235.781706] Starting subtest: basic-fds-forked-all
[257.502244] Subtest basic-fds-forked-all: SUCCESS (21.713s)
[257.709867] [051/133] (761s left) api_intel_bb (full-batch)
[257.769925] Starting subtest: full-batch
[257.776938] Subtest full-batch: SUCCESS (0.009s)
[257.941062] [052/133] (761s left) kms_cursor_crc (cursor-sliding-256x85)
[258.183432] Starting subtest: cursor-sliding-256x85
[258.227538] Subtest cursor-sliding-256x85: SKIP (0.041s)
[258.417998] [053/133] (761s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[258.512284] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[258.514488] Starting dynamic subtest: pipe-A-eDP-1
[258.571443] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[258.581224] Starting dynamic subtest: pipe-B-eDP-1
[258.634002] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[258.643988] Starting dynamic subtest: pipe-C-eDP-1
[258.691380] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[258.703031] Starting dynamic subtest: pipe-D-eDP-1
[258.750843] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[258.754499] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[260.671974] [054/133] (758s left) gen9_exec_parse (allowed-single)
[260.745070] Subtest allowed-single: SKIP (0.000s)
[260.806941] [055/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[260.904460] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[267.812077] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.911s)
[267.975242] [056/133] (751s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[268.074588] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[268.079062] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[268.200401] [057/133] (751s left) gem_exec_fence (expired-history)
[268.693773] Starting subtest: expired-history
[276.083653] Subtest expired-history: SUCCESS (7.389s)
[276.680949] [058/133] (743s left) kms_psr (fbc-psr-sprite-plane-move)
[276.773793] Starting subtest: fbc-psr-sprite-plane-move
[276.776218] Starting dynamic subtest: eDP-1
[276.780639] Dynamic subtest eDP-1: SKIP (0.000s)
[276.785098] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[276.872861] [059/133] (742s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[276.977140] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[283.728745] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.752s)
[283.877494] [060/133] (735s left) gem_ctx_bad_destroy (double-destroy)
[283.932576] Starting subtest: double-destroy
[283.935053] Subtest double-destroy: SUCCESS (0.000s)
[284.053397] [061/133] (735s left) syncobj_timeline (invalid-signal-illegal-handle)
[284.102381] Starting subtest: invalid-signal-illegal-handle
[284.104896] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[284.239527] [062/133] (735s left) kms_chamelium_hpd (common-hpd-after-suspend)
[284.618351] Subtest common-hpd-after-suspend: SKIP (0.000s)
[285.403535] [063/133] (734s left) kms_frontbuffer_tracking (fbc-tiling-4)
[285.499615] Starting subtest: fbc-tiling-4
[289.795409] Subtest fbc-tiling-4: SUCCESS (4.298s)
[290.967676] [064/133] (728s left) gem_cs_tlb (engines)
[291.021965] Starting subtest: engines
[291.024214] Starting dynamic subtest: rcs0
[293.235772] Dynamic subtest rcs0: SUCCESS (2.151s)
[293.246577] Starting dynamic subtest: bcs0
[295.327763] Dynamic subtest bcs0: SUCCESS (2.150s)
[295.339890] Starting dynamic subtest: vcs0
[297.532742] Dynamic subtest vcs0: SUCCESS (2.152s)
[297.542610] Starting dynamic subtest: vcs1
[299.686686] Dynamic subtest vcs1: SUCCESS (2.152s)
[299.698539] Starting dynamic subtest: vecs0
[301.840725] Dynamic subtest vecs0: SUCCESS (2.151s)
[301.854000] Starting dynamic subtest: ccs0
[303.993112] Dynamic subtest ccs0: SUCCESS (2.152s)
[303.995670] Subtest engines: SUCCESS (12.915s)
[304.091940] [065/133] (715s left) gem_mmap_gtt (hang-busy)
[304.147433] Subtest hang-busy: SKIP (0.000s)
[304.212848] [066/133] (715s left) kms_psr (psr2-sprite-plane-onoff)
[304.322563] Starting subtest: psr2-sprite-plane-onoff
[304.324688] Starting dynamic subtest: eDP-1
[306.066396] Dynamic subtest eDP-1: SUCCESS (1.741s)
[306.068766] Subtest psr2-sprite-plane-onoff: SUCCESS (1.743s)
[306.933270] [067/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[307.042233] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[307.666304] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.625s)
[307.889057] [068/133] (712s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[307.989338] Starting subtest: y-tiled-64bpp-rotate-270
[307.993976] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[308.131592] [069/133] (712s left) gem_bad_reloc (negative-reloc-lut)
[308.205928] Subtest negative-reloc-lut: SKIP (0.000s)
[308.288571] [070/133] (711s left) gem_ctx_persistence (engines-mixed)
[308.351323] Starting subtest: engines-mixed
[308.353775] Starting dynamic subtest: rcs0
[308.454986] Dynamic subtest rcs0: SUCCESS (0.103s)
[308.467018] Starting dynamic subtest: bcs0
[308.529809] Dynamic subtest bcs0: SUCCESS (0.073s)
[308.547853] Starting dynamic subtest: vcs0
[308.595999] Dynamic subtest vcs0: SUCCESS (0.065s)
[308.607360] Starting dynamic subtest: vcs1
[308.683638] Dynamic subtest vcs1: SUCCESS (0.085s)
[308.695767] Starting dynamic subtest: vecs0
[308.767628] Dynamic subtest vecs0: SUCCESS (0.081s)
[308.779033] Starting dynamic subtest: ccs0
[308.839591] Dynamic subtest ccs0: SUCCESS (0.070s)
[308.842174] Subtest engines-mixed: SUCCESS (0.490s)
[308.945548] [071/133] (711s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[309.039797] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[309.041645] Starting dynamic subtest: pipe-A
[309.104547] Dynamic subtest pipe-A: SUCCESS (0.066s)
[309.115392] Starting dynamic subtest: pipe-B
[310.228838] Dynamic subtest pipe-B: SUCCESS (1.122s)
[310.243796] Starting dynamic subtest: pipe-C
[311.332200] Dynamic subtest pipe-C: SUCCESS (1.100s)
[311.349267] Starting dynamic subtest: pipe-D
[312.460915] Dynamic subtest pipe-D: SUCCESS (1.126s)
[312.463188] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.422s)
[313.643831] [072/133] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[313.745239] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[313.749585] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[313.871444] [073/133] (706s left) gem_exec_schedule (semaphore-noskip)
[313.951093] Starting subtest: semaphore-noskip
[314.375789] Subtest semaphore-noskip: SUCCESS (0.429s)
[314.736247] [074/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[314.833971] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[314.837926] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[314.970326] [075/133] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[315.075313] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[315.079534] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[315.218127] [076/133] (705s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[315.320334] Starting subtest: 4-tiled-16bpp-rotate-0
[316.533871] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.213s)
[316.704912] [077/133] (703s left) gem_exec_basic (basic)
[316.766949] Starting subtest: basic
[316.768968] Starting dynamic subtest: rcs0-smem
[316.770834] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[316.782791] Starting dynamic subtest: bcs0-smem
[316.784514] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[316.793231] Starting dynamic subtest: vcs0-smem
[316.795000] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[316.803705] Starting dynamic subtest: vcs1-smem
[316.805540] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[316.813763] Starting dynamic subtest: vecs0-smem
[316.815512] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[316.823607] Starting dynamic subtest: ccs0-smem
[316.825371] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[316.827124] Subtest basic: SUCCESS (0.014s)
[318.402005] [078/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[318.508058] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[318.511970] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.650958] [079/133] (701s left) gem_mmap (short-mmap)
[318.707666] Subtest short-mmap: SKIP (0.000s)
[318.797484] [080/133] (701s left) gem_exec_reloc (basic-gtt-wc-active)
[318.860529] Subtest basic-gtt-wc-active: SKIP (0.000s)
[318.938957] [081/133] (701s left) gem_ctx_shared (create-shared-gtt)
[319.007052] Starting subtest: create-shared-gtt
[321.160682] Subtest create-shared-gtt: SUCCESS (2.151s)
[321.566532] [082/133] (699s left) gem_exec_reloc (basic-write-wc)
[321.630862] Subtest basic-write-wc: SKIP (0.000s)
[321.706121] [083/133] (699s left) gem_eio (wait-immediate)
[321.949740] Starting subtest: wait-immediate
[322.341627] Subtest wait-immediate: SUCCESS (0.392s)
[322.512864] [084/133] (698s left) gem_ctx_persistence (legacy-engines-mixed)
[322.580664] Starting subtest: legacy-engines-mixed
[322.582668] Starting dynamic subtest: render
[322.655987] Dynamic subtest render: SUCCESS (0.075s)
[322.668571] Starting dynamic subtest: bsd1
[322.727519] Dynamic subtest bsd1: SUCCESS (0.069s)
[322.739791] Starting dynamic subtest: bsd2
[322.801640] Dynamic subtest bsd2: SUCCESS (0.071s)
[322.814399] Starting dynamic subtest: blt
[322.874139] Dynamic subtest blt: SUCCESS (0.070s)
[322.890806] Starting dynamic subtest: vebox
[322.934970] Dynamic subtest vebox: SUCCESS (0.058s)
[322.937017] Subtest legacy-engines-mixed: SUCCESS (0.355s)
[323.037303] [085/133] (697s left) perf_pmu (semaphore-busy)
[323.083664] Starting subtest: semaphore-busy
[323.085312] Starting dynamic subtest: rcs0
[324.699280] Dynamic subtest rcs0: SUCCESS (1.613s)
[324.710528] Starting dynamic subtest: bcs0
[326.333224] Dynamic subtest bcs0: SUCCESS (1.630s)
[326.345912] Starting dynamic subtest: vcs0
[330.929561] Dynamic subtest vcs0: SUCCESS (4.541s)
[330.941379] Starting dynamic subtest: vcs1
[336.826096] Dynamic subtest vcs1: SUCCESS (5.949s)
[336.837651] Starting dynamic subtest: vecs0
[342.894453] Dynamic subtest vecs0: SUCCESS (6.015s)
[342.906364] Starting dynamic subtest: ccs0
[345.916058] Dynamic subtest ccs0: SUCCESS (3.071s)
[345.918894] Subtest semaphore-busy: SUCCESS (22.836s)
[346.077705] [086/133] (674s left) gem_exec_schedule (pi-common)
[346.269245] Starting subtest: pi-common
[346.271370] Starting dynamic subtest: rcs0
[346.303315] Dynamic subtest rcs0: SUCCESS (0.038s)
[346.314237] Starting dynamic subtest: bcs0
[346.346459] Dynamic subtest bcs0: SUCCESS (0.042s)
[346.357277] Starting dynamic subtest: vcs0
[346.382865] Dynamic subtest vcs0: SUCCESS (0.036s)
[346.392189] Starting dynamic subtest: vcs1
[346.416270] Dynamic subtest vcs1: SUCCESS (0.032s)
[346.425748] Starting dynamic subtest: vecs0
[346.448106] Dynamic subtest vecs0: SUCCESS (0.031s)
[346.457600] Starting dynamic subtest: ccs0
[346.480034] Dynamic subtest ccs0: SUCCESS (0.031s)
[346.482314] Subtest pi-common: SUCCESS (0.216s)
[346.748855] [087/133] (674s left) i915_hangman (engine-error-state-capture)
[346.821393] Starting subtest: engine-error-state-capture
[346.823744] Starting dynamic subtest: rcs0
[350.302015] Dynamic subtest rcs0: SUCCESS (3.481s)
[350.314744] Starting dynamic subtest: bcs0
[356.317597] Dynamic subtest bcs0: SUCCESS (6.014s)
[356.329753] Starting dynamic subtest: vcs0
[362.268777] Dynamic subtest vcs0: SUCCESS (5.949s)
[362.281712] Starting dynamic subtest: vcs1
[367.262081] Dynamic subtest vcs1: SUCCESS (4.991s)
[367.275368] Starting dynamic subtest: vecs0
[372.253375] Dynamic subtest vecs0: SUCCESS (4.989s)
[372.266118] Starting dynamic subtest: ccs0
[377.310080] Dynamic subtest ccs0: SUCCESS (5.054s)
[377.312682] Subtest engine-error-state-capture: SUCCESS (30.493s)
[377.445255] [088/133] (643s left) syncobj_timeline (wait-for-submit-snapshot)
[377.513322] Starting subtest: wait-for-submit-snapshot
[377.593631] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[377.698789] [089/133] (643s left) kms_color (ctm-blue-to-red)
[377.795694] Starting subtest: ctm-blue-to-red
[377.797635] Starting dynamic subtest: pipe-A-eDP-1
[378.468465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[378.479526] Starting dynamic subtest: pipe-B-eDP-1
[379.862391] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[379.872816] Starting dynamic subtest: pipe-C-eDP-1
[381.209425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s)
[381.219657] Starting dynamic subtest: pipe-D-eDP-1
[382.511167] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[382.513658] Subtest ctm-blue-to-red: SUCCESS (4.717s)
[383.390496] [090/133] (637s left) prime_vgem (basic-gtt)
[383.482010] Starting subtest: basic-gtt
[383.486524] Subtest basic-gtt: SKIP (0.000s)
[383.623706] [091/133] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[383.723803] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[391.041794] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.320s)
[391.219609] [092/133] (629s left) api_intel_allocator (default-alignment)
[391.275285] Starting subtest: default-alignment
[391.277600] Subtest default-alignment: SUCCESS (0.003s)
[391.445139] [093/133] (629s left) i915_pm_rps (fence-order)
[391.514918] Starting subtest: fence-order
[394.344780] Subtest fence-order: SUCCESS (2.831s)
[394.513504] [094/133] (626s left) kms_vblank (query-busy)
[394.610785] Starting subtest: query-busy
[394.612662] Starting dynamic subtest: pipe-A-eDP-1
[396.487346] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[396.503288] Starting dynamic subtest: pipe-D-eDP-1
[399.004867] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.518s)
[399.007174] Subtest query-busy: SUCCESS (4.396s)
[399.837295] [095/133] (621s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[399.949568] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[399.953828] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[400.067910] [096/133] (621s left) kms_addfb_basic (invalid-get-prop-any)
[400.129652] Starting subtest: invalid-get-prop-any
[400.131903] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[400.303645] [097/133] (621s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[400.403045] Starting subtest: fbc-psr2-cursor-mmap-gtt
[400.405200] Starting dynamic subtest: eDP-1
[400.409405] Dynamic subtest eDP-1: SKIP (0.000s)
[400.413439] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[400.499129] [098/133] (620s left) kms_flip (2x-blocking-absolute-wf_vblank)
[400.591017] Starting subtest: 2x-blocking-absolute-wf_vblank
[400.601790] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[400.701989] [099/133] (620s left) kms_cursor_crc (cursor-onscreen-256x85)
[400.958030] Starting subtest: cursor-onscreen-256x85
[401.004330] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[401.220081] [100/133] (620s left) kms_flip (2x-modeset-vs-vblank-race)
[401.308522] Starting subtest: 2x-modeset-vs-vblank-race
[401.318446] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[401.476041] [101/133] (620s left) kms_atomic_interruptible (atomic-setmode)
[401.575196] Starting subtest: atomic-setmode
[401.577086] Starting dynamic subtest: pipe-A-eDP-1
[408.475515] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.900s)
[408.477879] Subtest atomic-setmode: SUCCESS (6.901s)
[409.373169] [102/133] (612s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[409.493779] Starting subtest: psr-argb161616f-draw-render
[409.498048] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[409.625891] [103/133] (612s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[409.728424] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[409.732752] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[409.867672] [104/133] (611s left) kms_plane_scaling (invalid-num-scalers)
[409.964080] Starting subtest: invalid-num-scalers
[409.966306] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[409.983590] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[409.997062] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[410.018525] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[410.028620] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[410.049813] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[410.059477] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[410.082169] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[410.084532] Subtest invalid-num-scalers: SUCCESS (0.120s)
[410.215556] [105/133] (611s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[410.317893] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[410.321433] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[410.445440] [106/133] (611s left) sw_sync (alloc_fence_invalid_timeline)
[410.480199] Starting subtest: alloc_fence_invalid_timeline
[410.482142] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[410.555930] [107/133] (611s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[410.617845] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[410.723959] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[410.824621] [108/133] (611s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[410.926888] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[410.929159] Starting dynamic subtest: A-eDP1
[419.784970] Dynamic subtest A-eDP1: SUCCESS (8.856s)
[419.797709] Starting dynamic subtest: B-eDP1
[428.710414] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[428.722239] Starting dynamic subtest: C-eDP1
[437.683228] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[437.697248] Starting dynamic subtest: D-eDP1
[446.570167] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[446.572666] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.642s)
[447.816087] [109/133] (574s left) kms_addfb_basic (size-max)
[447.904700] Starting subtest: size-max
[447.907021] Subtest size-max: SUCCESS (0.000s)
[448.048612] [110/133] (573s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[448.283247] Starting subtest: cursor-rapid-movement-256x256
[448.288800] Starting dynamic subtest: pipe-A-eDP-1
[448.831765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[448.865949] Starting dynamic subtest: pipe-D-eDP-1
[450.018918] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.161s)
[450.020855] Subtest cursor-rapid-movement-256x256: SUCCESS (1.732s)
[450.884107] [111/133] (571s left) gem_exec_whisper (basic-queues-all)
[450.958637] Starting subtest: basic-queues-all
[460.320755] Subtest basic-queues-all: SUCCESS (9.355s)
[460.530498] [112/133] (561s left) kms_dsc (dsc-fractional-bpp)
[460.626428] Starting subtest: dsc-fractional-bpp
[460.639234] Subtest dsc-fractional-bpp: SKIP (0.000s)
[460.722903] [113/133] (561s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[460.815075] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[460.817435] Starting dynamic subtest: pipe-A-default-mode
[461.118666] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[461.124064] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.305s)
[461.932784] [114/133] (560s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[462.055993] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[462.060788] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[462.195821] [115/133] (559s left) gem_softpin (evict-prime)
[462.258384] Starting subtest: evict-prime
[462.260812] Starting dynamic subtest: rcs0
[463.469755] Dynamic subtest rcs0: SUCCESS (1.210s)
[463.483365] Starting dynamic subtest: bcs0
[464.626809] Dynamic subtest bcs0: SUCCESS (1.155s)
[464.639710] Starting dynamic subtest: vcs0
[466.335630] Dynamic subtest vcs0: SUCCESS (1.705s)
[466.348765] Starting dynamic subtest: vcs1
[468.284025] Dynamic subtest vcs1: SUCCESS (1.945s)
[468.297212] Starting dynamic subtest: vecs0
[470.366508] Dynamic subtest vecs0: SUCCESS (2.079s)
[470.379612] Starting dynamic subtest: ccs0
[471.524318] Dynamic subtest ccs0: SUCCESS (1.156s)
[471.537478] Starting dynamic subtest: all
[473.312101] Dynamic subtest all: SUCCESS (1.784s)
[473.315148] Subtest evict-prime: SUCCESS (11.051s)
[473.419522] [116/133] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[473.515151] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[473.519197] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[473.634408] [117/133] (548s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[473.737093] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[473.848981] [118/133] (548s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[473.903766] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[474.011201] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[474.112999] [119/133] (548s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[474.217297] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[474.221337] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[474.351079] [120/133] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[474.462328] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[478.515757] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.055s)
[479.745858] [121/133] (542s left) gem_mmap_wc (bad-size)
[479.802592] Subtest bad-size: SKIP (0.000s)
[479.865480] [122/133] (542s left) kms_hdr (static-toggle-suspend)
[479.969613] Starting subtest: static-toggle-suspend
[479.975929] Subtest static-toggle-suspend: SKIP (0.000s)
[480.102869] [123/133] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[480.197275] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[480.201419] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[480.331055] [124/133] (542s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[485.384880] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[485.387252] Starting dynamic subtest: pipe-A-eDP-1
[486.165794] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s)
[486.175822] Starting dynamic subtest: pipe-B-eDP-1
[487.295688] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[487.300145] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.911s)
[488.501881] [125/133] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[488.596341] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[488.600613] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[488.742911] [126/133] (533s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[488.835777] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[488.837994] Starting dynamic subtest: pipe-A-eDP-1
[488.857599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[488.869793] Starting dynamic subtest: pipe-B-eDP-1
[488.888543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[488.898421] Starting dynamic subtest: pipe-C-eDP-1
[488.916926] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[488.927241] Starting dynamic subtest: pipe-D-eDP-1
[488.947941] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[488.950252] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[491.092801] [127/133] (531s left) syncobj_timeline (single-wait-all-available-submitted)
[491.148480] Starting subtest: single-wait-all-available-submitted
[491.150837] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[491.292204] [128/133] (531s left) gem_exec_parallel (userptr)
[491.355975] Starting subtest: userptr
[491.358357] Starting dynamic subtest: rcs0
[492.792569] Dynamic subtest rcs0: SUCCESS (1.439s)
[492.805325] Starting dynamic subtest: bcs0
[494.293223] Dynamic subtest bcs0: SUCCESS (1.499s)
[494.306004] Starting dynamic subtest: vcs0
[496.320282] Dynamic subtest vcs0: SUCCESS (2.022s)
[496.332322] Starting dynamic subtest: vcs1
[498.368063] Dynamic subtest vcs1: SUCCESS (2.045s)
[498.381469] Starting dynamic subtest: vecs0
[500.311238] Dynamic subtest vecs0: SUCCESS (1.940s)
[500.323499] Starting dynamic subtest: ccs0
[501.824594] Dynamic subtest ccs0: SUCCESS (1.512s)
[501.826870] Subtest userptr: SUCCESS (10.471s)
[502.038375] [129/133] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[502.151462] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[502.155677] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[502.290768] [130/133] (520s left) i915_selftest (mock)
[505.826068] Starting subtest: mock
[505.828925] Starting dynamic subtest: sanitycheck
[506.576462] Dynamic subtest sanitycheck: SUCCESS (0.750s)
[506.586357] Starting dynamic subtest: shmem
[507.353140] Dynamic subtest shmem: SUCCESS (0.775s)
[507.363122] Starting dynamic subtest: fence
[515.529039] Dynamic subtest fence: SUCCESS (8.171s)
[515.538978] Starting dynamic subtest: scatterlist
[517.272627] Dynamic subtest scatterlist: SUCCESS (1.741s)
[517.282609] Starting dynamic subtest: syncmap
[520.644938] Dynamic subtest syncmap: SUCCESS (3.369s)
[520.660599] Starting dynamic subtest: uncore
[521.399688] Dynamic subtest uncore: SUCCESS (0.753s)
[521.409564] Starting dynamic subtest: ring
[522.100966] Dynamic subtest ring: SUCCESS (0.699s)
[522.110977] Starting dynamic subtest: engine
[522.857180] Dynamic subtest engine: SUCCESS (0.754s)
[522.867324] Starting dynamic subtest: timelines
[526.716045] Dynamic subtest timelines: SUCCESS (3.855s)
[526.725503] Starting dynamic subtest: requests
[530.100037] Dynamic subtest requests: SUCCESS (3.381s)
[530.109657] Starting dynamic subtest: objects
[530.951315] Dynamic subtest objects: SUCCESS (0.849s)
[530.961234] Starting dynamic subtest: phys
[531.806274] Dynamic subtest phys: SUCCESS (0.852s)
[531.816096] Starting dynamic subtest: dmabuf
[532.699260] Dynamic subtest dmabuf: SUCCESS (0.891s)
[532.709001] Starting dynamic subtest: vma
[538.188747] Dynamic subtest vma: SUCCESS (5.485s)
[538.198824] Starting dynamic subtest: evict
[539.644709] Dynamic subtest evict: SUCCESS (1.454s)
[539.654802] Starting dynamic subtest: gtt
[542.917709] Dynamic subtest gtt: SUCCESS (3.270s)
[542.927570] Starting dynamic subtest: hugepages
[543.886977] Dynamic subtest hugepages: SUCCESS (0.967s)
[543.897231] Starting dynamic subtest: memory_region
[546.527090] Dynamic subtest memory_region: SUCCESS (2.637s)
[546.529906] Subtest mock: SUCCESS (40.693s)
[546.561416] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[546.562096] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[546.565489] [131/133] (476s left) gem_mmap_gtt (basic-write-read)
[548.098454] Subtest basic-write-read: SKIP (0.000s)
[548.156198] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[548.157574] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[548.162378] [132/133] (474s left) perf (gen12-group-exclusive-stream-sample-oa)
[548.304469] Starting subtest: gen12-group-exclusive-stream-sample-oa
[548.325276] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[548.365132] [133/133] (474s left) perf_pmu (busy-double-start)
[548.404442] Starting subtest: busy-double-start
[548.406317] Starting dynamic subtest: rcs0
[552.051431] Dynamic subtest rcs0: FAIL (3.593s)
[552.062292] Starting dynamic subtest: bcs0
[555.565637] Dynamic subtest bcs0: SUCCESS (3.568s)
[555.576434] Starting dynamic subtest: vcs0
[559.919672] Dynamic subtest vcs0: SUCCESS (4.351s)
[559.931656] Starting dynamic subtest: vcs1
[563.883109] Dynamic subtest vcs1: SUCCESS (3.960s)
[563.895315] Starting dynamic subtest: vecs0
[567.893307] Dynamic subtest vecs0: SUCCESS (4.008s)
[567.904807] Starting dynamic subtest: ccs0
[571.527445] Dynamic subtest ccs0: FAIL (3.563s)
[571.529403] Subtest busy-double-start: FAIL (23.052s)
[571.618027] 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.