[58.591218] Initializing watchdogs
[58.591263]   /dev/watchdog0
[58.605741] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.610090] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.614550] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.618529] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[58.705304] Subtest write-snoop: SKIP (0.000s)
[58.787366] [002/133] (960s left) kms_content_protection (content-type-change)
[58.944860] Starting subtest: content-type-change
[58.949288] Subtest content-type-change: SKIP (0.000s)
[59.121540] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[59.213707] Starting subtest: multiplane-rotation
[76.631442] Subtest multiplane-rotation: SUCCESS (17.415s)
[76.789918] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[76.895983] Subtest ctm-red-to-blue: SKIP (0.000s)
[76.941198] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[76.993307] Starting subtest: invalid-reset-one-illegal-handle
[76.995214] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[77.109823] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[77.215652] Starting subtest: disable-crc-after-crtc
[77.217769] Starting dynamic subtest: pipe-A-eDP-1
[78.875664] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.658s)
[78.885588] Starting dynamic subtest: pipe-B-eDP-1
[81.264537] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.390s)
[81.273336] Starting dynamic subtest: pipe-C-eDP-1
[83.523421] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.254s)
[83.532440] Starting dynamic subtest: pipe-D-eDP-1
[85.795887] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.272s)
[85.798198] Subtest disable-crc-after-crtc: SUCCESS (8.580s)
[86.642606] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[86.714465] Subtest tiled-to-tiled: SKIP (0.000s)
[86.796198] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[86.853970] Starting subtest: wait-all-interrupted
[86.953925] Subtest wait-all-interrupted: SUCCESS (0.101s)
[87.058575] [009/133] (932s left) syncobj_wait (wait-all-complex)
[87.122061] Starting subtest: wait-all-complex
[87.334670] Subtest wait-all-complex: SUCCESS (0.212s)
[87.429776] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[87.566224] Starting subtest: reject-modify-context-protection-on
[87.568889] Subtest reject-modify-context-protection-on: SUCCESS (0.003s)
[87.711915] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[87.842814] Starting subtest: cursorA-vs-flipB-varying-size
[87.847298] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[88.007800] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[88.102178] Starting subtest: primary-rotation-90
[88.106633] Subtest primary-rotation-90: SKIP (0.001s)
[88.197106] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[88.264888] Starting subtest: reset-multiple-signaled
[88.267121] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[88.371702] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[88.473317] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[88.477080] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[89.579147] [015/133] (930s left) gem_softpin (noreloc-s3)
[89.649225] Starting subtest: noreloc-S3
[110.100583] Subtest noreloc-S3: SUCCESS (5.427s)
[117.270128] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[117.380157] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[121.874242] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.484s)
[123.016238] [017/133] (903s left) gem_ctx_param (invalid-ctx-set)
[123.077625] Starting subtest: invalid-ctx-set
[123.080015] Subtest invalid-ctx-set: SUCCESS (0.001s)
[123.208348] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[123.265475] Starting subtest: single-wait-all-for-submit-unsubmitted
[123.368801] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[123.469731] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[123.576941] Starting subtest: x-tiled-64bpp-rotate-90
[123.597634] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[123.746645] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[123.805106] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[123.862154] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[123.959765] Starting subtest: fbc-psr-cursor-plane-move
[123.962076] Starting dynamic subtest: eDP-1
[123.966594] Dynamic subtest eDP-1: SKIP (0.000s)
[123.970969] Subtest fbc-psr-cursor-plane-move: SKIP (0.002s)
[124.061656] [022/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[124.191449] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[125.227772] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[125.398506] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb)
[125.486049] Starting subtest: 2x-flip-vs-rmfb
[125.497590] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[125.598050] [024/133] (901s left) kms_plane_cursor (viewport)
[125.706799] Starting subtest: viewport
[125.710411] Starting dynamic subtest: pipe-A-eDP-1-size-64
[128.272868] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.562s)
[128.330670] Starting dynamic subtest: pipe-A-eDP-1-size-128
[130.921916] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.594s)
[130.982980] Starting dynamic subtest: pipe-A-eDP-1-size-256
[133.558536] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s)
[133.916044] Starting dynamic subtest: pipe-B-eDP-1-size-64
[137.201425] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.292s)
[137.261158] Starting dynamic subtest: pipe-B-eDP-1-size-128
[139.837149] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[139.897778] Starting dynamic subtest: pipe-B-eDP-1-size-256
[142.507095] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.615s)
[142.862380] Starting dynamic subtest: pipe-C-eDP-1-size-64
[145.718045] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.863s)
[145.756247] Starting dynamic subtest: pipe-C-eDP-1-size-128
[147.929621] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[147.973309] Starting dynamic subtest: pipe-C-eDP-1-size-256
[150.140083] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.179s)
[150.487799] Starting dynamic subtest: pipe-D-eDP-1-size-64
[153.402774] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.926s)
[153.440965] Starting dynamic subtest: pipe-D-eDP-1-size-128
[155.647058] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.212s)
[155.685748] Starting dynamic subtest: pipe-D-eDP-1-size-256
[157.856747] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[158.173839] Subtest viewport: SUCCESS (32.455s)
[159.051011] [025/133] (868s left) kms_cdclk (mode-transition)
[159.154806] Starting subtest: mode-transition
[159.157090] Starting dynamic subtest: pipe-A-eDP-1
[159.442726] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[159.458270] Starting dynamic subtest: pipe-B-eDP-1
[159.463550] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[159.480979] Starting dynamic subtest: pipe-C-eDP-1
[159.485715] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[159.495849] Starting dynamic subtest: pipe-D-eDP-1
[159.500260] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[159.504599] Subtest mode-transition: SKIP (0.295s)
[160.279416] [026/133] (866s left) gem_exec_balancer (fairslice)
[160.350794] Starting subtest: fairslice
[163.241733] Subtest fairslice: SUCCESS (2.890s)
[163.992791] [027/133] (863s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[164.117002] Starting subtest: basic-flip-before-cursor-varying-size
[165.034681] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.918s)
[165.911066] [028/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[166.016497] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[166.018728] Starting dynamic subtest: pipe-A-default-mode
[166.305108] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[166.309534] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.288s)
[167.142222] [029/133] (860s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[167.232328] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[167.234455] Starting dynamic subtest: pipe-A-default-mode
[169.982603] Dynamic subtest pipe-A-default-mode: SUCCESS (2.749s)
[169.984751] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.751s)
[170.834709] [030/133] (856s left) core_getstats (basic)
[170.899559] Starting subtest: basic
[170.901445] Subtest basic: SUCCESS (0.000s)
[171.013978] [031/133] (856s left) kms_rmfb (close-fd)
[171.117676] Starting subtest: close-fd
[171.119736] Starting dynamic subtest: pipe-A-eDP-1
[171.224910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[171.234177] Starting dynamic subtest: pipe-B-eDP-1
[172.385381] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[172.395798] Starting dynamic subtest: pipe-C-eDP-1
[173.605406] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[173.614142] Starting dynamic subtest: pipe-D-eDP-1
[174.740640] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[174.742753] Subtest close-fd: SUCCESS (3.622s)
[175.978815] [032/133] (851s left) gem_exec_reloc (basic-gtt-wc)
[176.045055] Subtest basic-gtt-wc: SKIP (0.000s)
[176.129054] [033/133] (851s left) kms_properties (crtc-properties-legacy)
[176.229314] Starting subtest: crtc-properties-legacy
[176.231483] Starting dynamic subtest: pipe-A-eDP-1
[176.682209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[176.693163] Starting dynamic subtest: pipe-B-eDP-1
[177.818333] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s)
[177.826650] Starting dynamic subtest: pipe-C-eDP-1
[178.949890] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[178.966756] Starting dynamic subtest: pipe-D-eDP-1
[180.080368] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[180.082312] Subtest crtc-properties-legacy: SUCCESS (3.850s)
[180.916987] [034/133] (846s left) kms_invalid_mode (zero-hdisplay)
[181.015714] Starting subtest: zero-hdisplay
[181.018017] Starting dynamic subtest: pipe-A-eDP-1
[181.308443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[181.317793] Starting dynamic subtest: pipe-B-eDP-1
[181.320153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[181.328193] Starting dynamic subtest: pipe-C-eDP-1
[181.330181] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[181.338572] Starting dynamic subtest: pipe-D-eDP-1
[181.340812] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[181.343091] Subtest zero-hdisplay: SUCCESS (0.305s)
[182.146097] [035/133] (845s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[182.240251] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[182.242606] Starting dynamic subtest: pipe-A
[183.298514] Dynamic subtest pipe-A: SUCCESS (1.061s)
[183.308851] Starting dynamic subtest: pipe-B
[185.450117] Dynamic subtest pipe-B: SUCCESS (2.149s)
[185.466453] Starting dynamic subtest: pipe-C
[186.638895] Dynamic subtest pipe-C: SUCCESS (1.186s)
[186.647632] Starting dynamic subtest: pipe-D
[187.873056] Dynamic subtest pipe-D: SUCCESS (1.232s)
[187.875366] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.636s)
[189.084553] [036/133] (838s left) kms_pm_rpm (legacy-planes-dpms)
[191.122759] Starting subtest: legacy-planes-dpms
[191.125551] Starting dynamic subtest: plane-63
[199.744210] Dynamic subtest plane-63: SUCCESS (8.620s)
[199.754548] Starting dynamic subtest: plane-93
[208.363966] Dynamic subtest plane-93: SUCCESS (8.615s)
[208.376806] Starting dynamic subtest: plane-123
[216.766671] Dynamic subtest plane-123: SUCCESS (8.401s)
[216.777352] Starting dynamic subtest: plane-133
[225.086142] Dynamic subtest plane-133: SUCCESS (8.319s)
[225.088630] Subtest legacy-planes-dpms: SUCCESS (33.965s)
[225.469375] [037/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[225.572294] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[225.576724] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[225.696183] [038/133] (801s left) kms_dirtyfb (default-dirtyfb-ioctl)
[225.797712] Starting subtest: default-dirtyfb-ioctl
[225.799862] Starting dynamic subtest: A-eDP-1
[227.407896] Dynamic subtest A-eDP-1: SUCCESS (1.608s)
[227.410198] Subtest default-dirtyfb-ioctl: SUCCESS (1.609s)
[228.314022] [039/133] (799s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[228.438809] Starting subtest: cursorB-vs-flipA-legacy
[228.443214] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[228.605112] [040/133] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[228.675823] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[228.678177] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[228.817269] [041/133] (798s left) kms_prime (basic-crc-vgem)
[228.948319] Starting subtest: basic-crc-vgem
[228.950380] Starting dynamic subtest: second-to-first
[229.899783] Dynamic subtest second-to-first: SUCCESS (0.953s)
[229.901768] Subtest basic-crc-vgem: SUCCESS (0.955s)
[230.013239] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[230.016487] [042/133] (797s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[230.111303] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[230.182607] [043/133] (797s left) i915_drm_fdinfo (busy)
[230.219854] Starting subtest: busy
[230.221649] Starting dynamic subtest: rcs0
[230.262879] Dynamic subtest rcs0: SKIP (0.043s)
[230.274082] Starting dynamic subtest: bcs0
[230.277410] Dynamic subtest bcs0: SKIP (0.001s)
[230.285712] Starting dynamic subtest: vcs0
[230.289260] Dynamic subtest vcs0: SKIP (0.001s)
[230.297191] Starting dynamic subtest: vcs1
[230.300564] Dynamic subtest vcs1: SKIP (0.000s)
[230.308120] Starting dynamic subtest: vecs0
[230.311518] Dynamic subtest vecs0: SKIP (0.000s)
[230.319153] Starting dynamic subtest: ccs0
[230.322552] Dynamic subtest ccs0: SKIP (0.000s)
[230.326009] Subtest busy: SKIP (0.052s)
[230.363310] [044/133] (797s left) gem_userptr_blits (nohangcheck)
[230.448247] Starting subtest: nohangcheck
[230.707406] Subtest nohangcheck: SUCCESS (0.257s)
[230.872247] [045/133] (796s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[230.977131] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[231.579413] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s)
[231.800968] [046/133] (796s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[231.903273] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[231.907896] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[233.036260] [047/133] (794s left) kms_scaling_modes (scaling-mode-full)
[233.134383] Starting subtest: scaling-mode-full
[233.136704] Starting dynamic subtest: pipe-A-eDP-1
[233.225736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s)
[233.235155] Starting dynamic subtest: pipe-B-eDP-1
[234.443128] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s)
[234.453475] Starting dynamic subtest: pipe-C-eDP-1
[235.551652] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[235.560598] Starting dynamic subtest: pipe-D-eDP-1
[236.676266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[236.678548] Subtest scaling-mode-full: SUCCESS (3.544s)
[237.859578] [048/133] (790s left) kms_psr (fbc-pr-basic)
[237.966712] Starting subtest: fbc-pr-basic
[237.970808] Subtest fbc-pr-basic: SKIP (0.000s)
[238.065798] [049/133] (789s left) gem_ringfill (basic-all)
[243.914238] Starting subtest: basic-all
[245.072090] Subtest basic-all: SUCCESS (1.158s)
[245.249403] [050/133] (782s left) gem_exec_whisper (basic-fds-forked-all)
[245.313828] Starting subtest: basic-fds-forked-all
[266.969839] Subtest basic-fds-forked-all: SUCCESS (21.653s)
[267.180988] [051/133] (760s left) api_intel_bb (full-batch)
[267.234171] Starting subtest: full-batch
[267.240841] Subtest full-batch: SUCCESS (0.007s)
[267.406791] [052/133] (760s left) kms_cursor_crc (cursor-sliding-256x85)
[267.650935] Starting subtest: cursor-sliding-256x85
[267.702464] Subtest cursor-sliding-256x85: SKIP (0.046s)
[267.906984] [053/133] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[268.010664] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[268.012950] Starting dynamic subtest: pipe-A-eDP-1
[268.070656] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[268.081410] Starting dynamic subtest: pipe-B-eDP-1
[268.130456] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[268.140244] Starting dynamic subtest: pipe-C-eDP-1
[268.187377] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[268.198205] Starting dynamic subtest: pipe-D-eDP-1
[268.245640] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[268.249087] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[270.308031] [054/133] (757s left) gen9_exec_parse (allowed-single)
[270.377017] Subtest allowed-single: SKIP (0.000s)
[270.459175] [055/133] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[270.559619] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[277.705744] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.147s)
[277.877341] [056/133] (750s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[277.983002] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[277.987535] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[278.108673] [057/133] (750s left) gem_exec_fence (expired-history)
[278.615866] Starting subtest: expired-history
[285.680487] Subtest expired-history: SUCCESS (7.067s)
[286.332937] [058/133] (742s left) kms_psr (fbc-psr-sprite-plane-move)
[286.439427] Starting subtest: fbc-psr-sprite-plane-move
[286.441825] Starting dynamic subtest: eDP-1
[286.446240] Dynamic subtest eDP-1: SKIP (0.000s)
[286.450477] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[286.539080] [059/133] (741s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[286.637555] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[293.416175] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.783s)
[293.553384] [060/133] (734s left) gem_ctx_bad_destroy (double-destroy)
[293.616281] Starting subtest: double-destroy
[293.618652] Subtest double-destroy: SUCCESS (0.000s)
[293.716294] [061/133] (734s left) syncobj_timeline (invalid-signal-illegal-handle)
[293.781968] Starting subtest: invalid-signal-illegal-handle
[293.784177] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[293.917737] [062/133] (734s left) kms_chamelium_hpd (common-hpd-after-suspend)
[294.301982] Subtest common-hpd-after-suspend: SKIP (0.000s)
[295.151291] [063/133] (733s left) kms_frontbuffer_tracking (fbc-tiling-4)
[295.254949] Starting subtest: fbc-tiling-4
[299.522787] Subtest fbc-tiling-4: SUCCESS (4.272s)
[300.705681] [064/133] (727s left) gem_cs_tlb (engines)
[300.759716] Starting subtest: engines
[300.762181] Starting dynamic subtest: rcs0
[302.917169] Dynamic subtest rcs0: SUCCESS (2.152s)
[302.928940] Starting dynamic subtest: bcs0
[305.069624] Dynamic subtest bcs0: SUCCESS (2.151s)
[305.081299] Starting dynamic subtest: vcs0
[307.222628] Dynamic subtest vcs0: SUCCESS (2.152s)
[307.232840] Starting dynamic subtest: vcs1
[309.375470] Dynamic subtest vcs1: SUCCESS (2.152s)
[309.391203] Starting dynamic subtest: vecs0
[311.528429] Dynamic subtest vecs0: SUCCESS (2.151s)
[311.540719] Starting dynamic subtest: ccs0
[313.681429] Dynamic subtest ccs0: SUCCESS (2.153s)
[313.683731] Subtest engines: SUCCESS (12.916s)
[313.825840] [065/133] (714s left) gem_mmap_gtt (hang-busy)
[313.886748] Subtest hang-busy: SKIP (0.000s)
[313.946713] [066/133] (714s left) kms_psr (psr2-sprite-plane-onoff)
[314.053343] Starting subtest: psr2-sprite-plane-onoff
[314.055622] Starting dynamic subtest: eDP-1
[315.804852] Dynamic subtest eDP-1: SUCCESS (1.752s)
[315.807147] Subtest psr2-sprite-plane-onoff: SUCCESS (1.753s)
[316.662659] [067/133] (712s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[316.782578] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[317.387604] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.606s)
[317.562215] [068/133] (711s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[317.672048] Starting subtest: y-tiled-64bpp-rotate-270
[317.676535] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[317.806842] [069/133] (711s left) gem_bad_reloc (negative-reloc-lut)
[317.873178] Subtest negative-reloc-lut: SKIP (0.000s)
[317.963145] [070/133] (710s left) gem_ctx_persistence (engines-mixed)
[318.028309] Starting subtest: engines-mixed
[318.030629] Starting dynamic subtest: rcs0
[318.129919] Dynamic subtest rcs0: SUCCESS (0.101s)
[318.142156] Starting dynamic subtest: bcs0
[318.214202] Dynamic subtest bcs0: SUCCESS (0.082s)
[318.229121] Starting dynamic subtest: vcs0
[318.267972] Dynamic subtest vcs0: SUCCESS (0.051s)
[318.279170] Starting dynamic subtest: vcs1
[318.348583] Dynamic subtest vcs1: SUCCESS (0.079s)
[318.361821] Starting dynamic subtest: vecs0
[318.421676] Dynamic subtest vecs0: SUCCESS (0.070s)
[318.433306] Starting dynamic subtest: ccs0
[318.503930] Dynamic subtest ccs0: SUCCESS (0.080s)
[318.506043] Subtest engines-mixed: SUCCESS (0.477s)
[318.625339] [071/133] (710s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[318.718368] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[318.720129] Starting dynamic subtest: pipe-A
[318.784232] Dynamic subtest pipe-A: SUCCESS (0.068s)
[318.794674] Starting dynamic subtest: pipe-B
[319.971563] Dynamic subtest pipe-B: SUCCESS (1.185s)
[319.986837] Starting dynamic subtest: pipe-C
[321.077675] Dynamic subtest pipe-C: SUCCESS (1.103s)
[321.092332] Starting dynamic subtest: pipe-D
[322.210362] Dynamic subtest pipe-D: SUCCESS (1.130s)
[322.212632] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.494s)
[323.394279] [072/133] (705s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[323.496143] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[323.500250] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.612918] [073/133] (705s left) gem_exec_schedule (semaphore-noskip)
[323.691808] Starting subtest: semaphore-noskip
[324.093932] Subtest semaphore-noskip: SUCCESS (0.410s)
[324.482004] [074/133] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[324.577510] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[324.581486] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[324.721743] [075/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[324.821603] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[324.825516] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[324.970012] [076/133] (704s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[325.087287] Starting subtest: 4-tiled-16bpp-rotate-0
[326.321487] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.235s)
[326.483036] [077/133] (702s left) gem_exec_basic (basic)
[326.548927] Starting subtest: basic
[326.550792] Starting dynamic subtest: rcs0-smem
[326.552504] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[326.562783] Starting dynamic subtest: bcs0-smem
[326.564532] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[326.573387] Starting dynamic subtest: vcs0-smem
[326.575244] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[326.583637] Starting dynamic subtest: vcs1-smem
[326.585142] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[326.593451] Starting dynamic subtest: vecs0-smem
[326.595307] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[326.603573] Starting dynamic subtest: ccs0-smem
[326.605153] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[326.606740] Subtest basic: SUCCESS (0.015s)
[328.005627] [078/133] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[328.117598] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[328.122055] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[328.255425] [079/133] (701s left) gem_mmap (short-mmap)
[328.305999] Subtest short-mmap: SKIP (0.000s)
[328.373919] [080/133] (701s left) gem_exec_reloc (basic-gtt-wc-active)
[328.436452] Subtest basic-gtt-wc-active: SKIP (0.000s)
[328.520239] [081/133] (700s left) gem_ctx_shared (create-shared-gtt)
[328.591909] Starting subtest: create-shared-gtt
[330.743199] Subtest create-shared-gtt: SUCCESS (2.153s)
[331.250244] [082/133] (698s left) gem_exec_reloc (basic-write-wc)
[331.313536] Subtest basic-write-wc: SKIP (0.000s)
[331.402163] [083/133] (698s left) gem_eio (wait-immediate)
[331.660986] Starting subtest: wait-immediate
[332.093877] Subtest wait-immediate: SUCCESS (0.434s)
[332.274912] [084/133] (697s left) gem_ctx_persistence (legacy-engines-mixed)
[332.353869] Starting subtest: legacy-engines-mixed
[332.355978] Starting dynamic subtest: render
[332.485331] Dynamic subtest render: SUCCESS (0.130s)
[332.500621] Starting dynamic subtest: bsd1
[332.565793] Dynamic subtest bsd1: SUCCESS (0.078s)
[332.580450] Starting dynamic subtest: bsd2
[332.647864] Dynamic subtest bsd2: SUCCESS (0.079s)
[332.659811] Starting dynamic subtest: blt
[332.735835] Dynamic subtest blt: SUCCESS (0.085s)
[332.750643] Starting dynamic subtest: vebox
[332.825144] Dynamic subtest vebox: SUCCESS (0.086s)
[332.827611] Subtest legacy-engines-mixed: SUCCESS (0.472s)
[332.927514] [085/133] (696s left) perf_pmu (semaphore-busy)
[332.966026] Starting subtest: semaphore-busy
[332.968009] Starting dynamic subtest: rcs0
[334.622184] Dynamic subtest rcs0: SUCCESS (1.653s)
[334.632618] Starting dynamic subtest: bcs0
[336.255587] Dynamic subtest bcs0: SUCCESS (1.630s)
[336.266962] Starting dynamic subtest: vcs0
[340.416217] Dynamic subtest vcs0: SUCCESS (4.157s)
[340.426414] Starting dynamic subtest: vcs1
[346.432037] Dynamic subtest vcs1: SUCCESS (6.014s)
[346.442464] Starting dynamic subtest: vecs0
[352.448079] Dynamic subtest vecs0: SUCCESS (6.014s)
[352.458427] Starting dynamic subtest: ccs0
[355.522002] Dynamic subtest ccs0: SUCCESS (3.071s)
[355.524721] Subtest semaphore-busy: SUCCESS (22.556s)
[355.662462] [086/133] (673s left) gem_exec_schedule (pi-common)
[355.859711] Starting subtest: pi-common
[355.861724] Starting dynamic subtest: rcs0
[355.899078] Dynamic subtest rcs0: SUCCESS (0.042s)
[355.909002] Starting dynamic subtest: bcs0
[355.940986] Dynamic subtest bcs0: SUCCESS (0.040s)
[355.950627] Starting dynamic subtest: vcs0
[355.978688] Dynamic subtest vcs0: SUCCESS (0.037s)
[355.988760] Starting dynamic subtest: vcs1
[356.014274] Dynamic subtest vcs1: SUCCESS (0.035s)
[356.024384] Starting dynamic subtest: vecs0
[356.053458] Dynamic subtest vecs0: SUCCESS (0.033s)
[356.071033] Starting dynamic subtest: ccs0
[356.079824] Dynamic subtest ccs0: SUCCESS (0.031s)
[356.087975] Subtest pi-common: SUCCESS (0.224s)
[356.393048] [087/133] (673s left) i915_hangman (engine-error-state-capture)
[356.535834] Starting subtest: engine-error-state-capture
[356.547712] Starting dynamic subtest: rcs0
[359.907469] Dynamic subtest rcs0: SUCCESS (3.379s)
[359.921088] Starting dynamic subtest: bcs0
[365.923827] Dynamic subtest bcs0: SUCCESS (6.013s)
[365.937944] Starting dynamic subtest: vcs0
[371.875700] Dynamic subtest vcs0: SUCCESS (5.949s)
[371.888275] Starting dynamic subtest: vcs1
[377.891370] Dynamic subtest vcs1: SUCCESS (6.013s)
[377.904849] Starting dynamic subtest: vecs0
[383.843575] Dynamic subtest vecs0: SUCCESS (5.949s)
[383.856355] Starting dynamic subtest: ccs0
[388.901255] Dynamic subtest ccs0: SUCCESS (5.054s)
[388.904254] Subtest engine-error-state-capture: SUCCESS (32.375s)
[389.007742] [088/133] (640s left) syncobj_timeline (wait-for-submit-snapshot)
[389.084258] Starting subtest: wait-for-submit-snapshot
[389.164605] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[389.272729] [089/133] (640s left) kms_color (ctm-blue-to-red)
[389.372455] Starting subtest: ctm-blue-to-red
[389.374311] Starting dynamic subtest: pipe-A-eDP-1
[390.057853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[390.068464] Starting dynamic subtest: pipe-B-eDP-1
[391.485502] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.428s)
[391.495815] Starting dynamic subtest: pipe-C-eDP-1
[392.856709] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[392.867270] Starting dynamic subtest: pipe-D-eDP-1
[394.181052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[394.183451] Subtest ctm-blue-to-red: SUCCESS (4.810s)
[395.020788] [090/133] (634s left) prime_vgem (basic-gtt)
[395.115014] Starting subtest: basic-gtt
[395.119684] Subtest basic-gtt: SKIP (0.000s)
[395.242927] [091/133] (634s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[395.344871] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[402.842018] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.498s)
[402.991447] [092/133] (626s left) api_intel_allocator (default-alignment)
[403.049479] Starting subtest: default-alignment
[403.051858] Subtest default-alignment: SUCCESS (0.003s)
[403.213807] [093/133] (626s left) i915_pm_rps (fence-order)
[403.279667] Starting subtest: fence-order
[406.781423] Subtest fence-order: SUCCESS (3.500s)
[406.947983] [094/133] (623s left) kms_vblank (query-busy)
[407.045974] Starting subtest: query-busy
[407.048178] Starting dynamic subtest: pipe-A-eDP-1
[408.930036] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[408.945467] Starting dynamic subtest: pipe-D-eDP-1
[411.491564] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.560s)
[411.493865] Subtest query-busy: SUCCESS (4.448s)
[412.328983] [095/133] (617s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[412.432199] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[412.436703] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[412.564592] [096/133] (617s left) kms_addfb_basic (invalid-get-prop-any)
[412.631663] Starting subtest: invalid-get-prop-any
[412.633962] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[412.800291] [097/133] (617s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[412.899800] Starting subtest: fbc-psr2-cursor-mmap-gtt
[412.902001] Starting dynamic subtest: eDP-1
[412.905990] Dynamic subtest eDP-1: SKIP (0.000s)
[412.909976] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[413.000343] [098/133] (617s left) kms_flip (2x-blocking-absolute-wf_vblank)
[413.096877] Starting subtest: 2x-blocking-absolute-wf_vblank
[413.104581] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[413.245236] [099/133] (617s left) kms_cursor_crc (cursor-onscreen-256x85)
[413.502452] Starting subtest: cursor-onscreen-256x85
[413.548705] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[413.753105] [100/133] (616s left) kms_flip (2x-modeset-vs-vblank-race)
[413.853251] Starting subtest: 2x-modeset-vs-vblank-race
[413.863000] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[413.966395] [101/133] (616s left) kms_atomic_interruptible (atomic-setmode)
[414.050751] Starting subtest: atomic-setmode
[414.052639] Starting dynamic subtest: pipe-A-eDP-1
[420.968673] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.916s)
[420.971064] Subtest atomic-setmode: SUCCESS (6.917s)
[421.862012] [102/133] (608s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[421.968278] Starting subtest: psr-argb161616f-draw-render
[421.972502] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[422.104813] [103/133] (608s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[422.210403] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[422.214856] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[422.350803] [104/133] (608s left) kms_plane_scaling (invalid-num-scalers)
[422.444308] Starting subtest: invalid-num-scalers
[422.446442] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[422.462275] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[422.472420] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[422.498201] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[422.508471] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[422.532061] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[422.541969] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[422.565375] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[422.567634] Subtest invalid-num-scalers: SUCCESS (0.121s)
[422.700218] [105/133] (607s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[422.805688] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[422.809069] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[422.944178] [106/133] (607s left) sw_sync (alloc_fence_invalid_timeline)
[422.984054] Starting subtest: alloc_fence_invalid_timeline
[422.986001] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[423.077297] [107/133] (607s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[423.127460] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[423.233604] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[423.334625] [108/133] (607s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[423.445639] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[423.447806] Starting dynamic subtest: A-eDP1
[432.375948] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[432.387454] Starting dynamic subtest: B-eDP1
[441.312211] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[441.325142] Starting dynamic subtest: C-eDP1
[450.226816] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[450.236937] Starting dynamic subtest: D-eDP1
[459.080431] Dynamic subtest D-eDP1: SUCCESS (8.851s)
[459.085941] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.635s)
[460.337510] [109/133] (570s left) kms_addfb_basic (size-max)
[460.438270] Starting subtest: size-max
[460.440433] Subtest size-max: SUCCESS (0.000s)
[460.563700] [110/133] (570s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[460.792143] Starting subtest: cursor-rapid-movement-256x256
[460.797145] Starting dynamic subtest: pipe-A-eDP-1
[461.342816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[461.382232] Starting dynamic subtest: pipe-D-eDP-1
[462.551101] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.175s)
[462.553269] Subtest cursor-rapid-movement-256x256: SUCCESS (1.757s)
[463.408640] [111/133] (567s left) gem_exec_whisper (basic-queues-all)
[463.471181] Starting subtest: basic-queues-all
[472.005073] Subtest basic-queues-all: SUCCESS (8.532s)
[472.215629] [112/133] (558s left) kms_dsc (dsc-fractional-bpp)
[472.313381] Starting subtest: dsc-fractional-bpp
[472.326737] Subtest dsc-fractional-bpp: SKIP (0.001s)
[472.408386] [113/133] (558s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[472.516770] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[472.519112] Starting dynamic subtest: pipe-A-default-mode
[472.805697] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[472.810326] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.288s)
[473.634274] [114/133] (557s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[473.729313] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[473.733778] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[473.874759] [115/133] (557s left) gem_softpin (evict-prime)
[473.941345] Starting subtest: evict-prime
[473.943241] Starting dynamic subtest: rcs0
[475.129736] Dynamic subtest rcs0: SUCCESS (1.190s)
[475.147579] Starting dynamic subtest: bcs0
[476.280097] Dynamic subtest bcs0: SUCCESS (1.148s)
[476.293300] Starting dynamic subtest: vcs0
[477.923105] Dynamic subtest vcs0: SUCCESS (1.639s)
[477.935909] Starting dynamic subtest: vcs1
[479.875652] Dynamic subtest vcs1: SUCCESS (1.951s)
[479.889432] Starting dynamic subtest: vecs0
[481.944879] Dynamic subtest vecs0: SUCCESS (2.066s)
[481.958119] Starting dynamic subtest: ccs0
[483.102338] Dynamic subtest ccs0: SUCCESS (1.157s)
[483.115367] Starting dynamic subtest: all
[484.856425] Dynamic subtest all: SUCCESS (1.750s)
[484.859223] Subtest evict-prime: SUCCESS (10.916s)
[485.036104] [116/133] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[485.139191] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[485.143500] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[485.267273] [117/133] (545s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[485.374088] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[485.491320] [118/133] (545s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[485.539479] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[485.649495] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[485.767056] [119/133] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[485.878049] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[485.882616] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[485.994203] [120/133] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[486.095674] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[490.229202] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.136s)
[492.482421] [121/133] (538s left) gem_mmap_wc (bad-size)
[492.545841] Subtest bad-size: SKIP (0.000s)
[492.604946] [122/133] (538s left) kms_hdr (static-toggle-suspend)
[492.700377] Starting subtest: static-toggle-suspend
[492.706538] Subtest static-toggle-suspend: SKIP (0.000s)
[492.797578] [123/133] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[492.897901] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[492.902169] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[493.025234] [124/133] (538s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[498.002859] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[498.004855] Starting dynamic subtest: pipe-A-eDP-1
[498.812853] Dynamic subtest pipe-A-eDP-1: SKIP (0.806s)
[498.823731] Starting dynamic subtest: pipe-B-eDP-1
[499.941588] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[499.946220] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.937s)
[501.159114] [125/133] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[501.260073] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[501.264212] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[501.371277] [126/133] (530s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[501.466028] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[501.468361] Starting dynamic subtest: pipe-A-eDP-1
[501.489334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[501.502360] Starting dynamic subtest: pipe-B-eDP-1
[501.522597] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[501.532375] Starting dynamic subtest: pipe-C-eDP-1
[501.552150] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[501.561803] Starting dynamic subtest: pipe-D-eDP-1
[501.581285] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[501.583493] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[503.744504] [127/133] (527s left) syncobj_timeline (single-wait-all-available-submitted)
[503.819889] Starting subtest: single-wait-all-available-submitted
[503.822298] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[503.957232] [128/133] (527s left) gem_exec_parallel (userptr)
[504.023602] Starting subtest: userptr
[504.025919] Starting dynamic subtest: rcs0
[505.493668] Dynamic subtest rcs0: SUCCESS (1.469s)
[505.504707] Starting dynamic subtest: bcs0
[506.998139] Dynamic subtest bcs0: SUCCESS (1.501s)
[507.009998] Starting dynamic subtest: vcs0
[508.931691] Dynamic subtest vcs0: SUCCESS (1.931s)
[508.942963] Starting dynamic subtest: vcs1
[510.916327] Dynamic subtest vcs1: SUCCESS (1.981s)
[510.928271] Starting dynamic subtest: vecs0
[512.901258] Dynamic subtest vecs0: SUCCESS (1.983s)
[512.914073] Starting dynamic subtest: ccs0
[514.444772] Dynamic subtest ccs0: SUCCESS (1.541s)
[514.447446] Subtest userptr: SUCCESS (10.419s)
[514.654358] [129/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[514.748570] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[514.752535] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[514.876081] [130/133] (516s left) i915_selftest (mock)
[518.441980] Starting subtest: mock
[518.444681] Starting dynamic subtest: sanitycheck
[519.195639] Dynamic subtest sanitycheck: SUCCESS (0.754s)
[519.206020] Starting dynamic subtest: shmem
[519.890837] Dynamic subtest shmem: SUCCESS (0.693s)
[519.901051] Starting dynamic subtest: fence
[528.136220] Dynamic subtest fence: SUCCESS (8.242s)
[528.146205] Starting dynamic subtest: scatterlist
[529.841453] Dynamic subtest scatterlist: SUCCESS (1.703s)
[529.851709] Starting dynamic subtest: syncmap
[533.199848] Dynamic subtest syncmap: SUCCESS (3.355s)
[533.215488] Starting dynamic subtest: uncore
[533.936570] Dynamic subtest uncore: SUCCESS (0.735s)
[533.946281] Starting dynamic subtest: ring
[534.693875] Dynamic subtest ring: SUCCESS (0.755s)
[534.704062] Starting dynamic subtest: engine
[535.413522] Dynamic subtest engine: SUCCESS (0.717s)
[535.423734] Starting dynamic subtest: timelines
[539.350838] Dynamic subtest timelines: SUCCESS (3.933s)
[539.360692] Starting dynamic subtest: requests
[543.032480] Dynamic subtest requests: SUCCESS (3.679s)
[543.042258] Starting dynamic subtest: objects
[543.890780] Dynamic subtest objects: SUCCESS (0.856s)
[543.900866] Starting dynamic subtest: phys
[544.751478] Dynamic subtest phys: SUCCESS (0.858s)
[544.761515] Starting dynamic subtest: dmabuf
[545.616073] Dynamic subtest dmabuf: SUCCESS (0.864s)
[545.626057] Starting dynamic subtest: vma
[551.048160] Dynamic subtest vma: SUCCESS (5.428s)
[551.063822] Starting dynamic subtest: evict
[552.506932] Dynamic subtest evict: SUCCESS (1.456s)
[552.517258] Starting dynamic subtest: gtt
[555.816800] Dynamic subtest gtt: SUCCESS (3.307s)
[555.826800] Starting dynamic subtest: hugepages
[556.854855] Dynamic subtest hugepages: SUCCESS (1.035s)
[556.865280] Starting dynamic subtest: memory_region
[559.647713] Dynamic subtest memory_region: SUCCESS (2.790s)
[559.650561] Subtest mock: SUCCESS (41.200s)
[559.680267] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[559.680955] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[559.684125] [131/133] (471s left) gem_mmap_gtt (basic-write-read)
[561.203790] Subtest basic-write-read: SKIP (0.000s)
[561.282795] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[561.285650] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[561.289963] [132/133] (470s left) perf (gen12-group-exclusive-stream-sample-oa)
[561.433809] Starting subtest: gen12-group-exclusive-stream-sample-oa
[561.454147] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[561.502234] [133/133] (470s left) perf_pmu (busy-double-start)
[561.546452] Starting subtest: busy-double-start
[561.548620] Starting dynamic subtest: rcs0
[565.188762] Dynamic subtest rcs0: FAIL (3.590s)
[565.200032] Starting dynamic subtest: bcs0
[568.761446] Dynamic subtest bcs0: SUCCESS (3.625s)
[568.773464] Starting dynamic subtest: vcs0
[572.458967] Dynamic subtest vcs0: SUCCESS (3.695s)
[572.470617] Starting dynamic subtest: vcs1
[576.463634] Dynamic subtest vcs1: SUCCESS (4.001s)
[576.475194] Starting dynamic subtest: vecs0
[580.472707] Dynamic subtest vecs0: SUCCESS (4.006s)
[580.484412] Starting dynamic subtest: ccs0
[584.114939] Dynamic subtest ccs0: FAIL (3.565s)
[584.117359] Subtest busy-double-start: FAIL (22.493s)
[584.184661] 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.