[57.090531] Initializing watchdogs
[57.090575]   /dev/watchdog0
[57.103809] [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]
[57.107983] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.110128] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.113236] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[57.192229] Subtest write-snoop: SKIP (0.000s)
[57.275245] [002/133] (960s left) kms_content_protection (content-type-change)
[57.429756] Starting subtest: content-type-change
[57.434492] Subtest content-type-change: SKIP (0.000s)
[57.581320] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[57.671475] Starting subtest: multiplane-rotation
[75.061551] Subtest multiplane-rotation: SUCCESS (17.369s)
[75.185494] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[75.291825] Subtest ctm-red-to-blue: SKIP (0.000s)
[75.333355] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[75.392526] Starting subtest: invalid-reset-one-illegal-handle
[75.394572] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[75.513261] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[75.610112] Starting subtest: disable-crc-after-crtc
[75.611944] Starting dynamic subtest: pipe-A-eDP-1
[77.235914] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.626s)
[77.245376] Starting dynamic subtest: pipe-B-eDP-1
[79.481322] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.240s)
[79.491275] Starting dynamic subtest: pipe-C-eDP-1
[81.745325] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.263s)
[81.753665] Starting dynamic subtest: pipe-D-eDP-1
[83.993581] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.249s)
[83.995916] Subtest disable-crc-after-crtc: SUCCESS (8.383s)
[84.835909] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[84.915900] Subtest tiled-to-tiled: SKIP (0.000s)
[84.998069] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[85.052675] Starting subtest: wait-all-interrupted
[85.155648] Subtest wait-all-interrupted: SUCCESS (0.102s)
[85.252144] [009/133] (932s left) syncobj_wait (wait-all-complex)
[85.305424] Starting subtest: wait-all-complex
[85.517492] Subtest wait-all-complex: SUCCESS (0.212s)
[85.614567] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[85.739737] Starting subtest: reject-modify-context-protection-on
[85.742088] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[85.881800] [011/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[86.004758] Starting subtest: cursorA-vs-flipB-varying-size
[86.009083] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[86.170647] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[86.268861] Starting subtest: primary-rotation-90
[86.273306] Subtest primary-rotation-90: SKIP (0.001s)
[86.360935] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[86.425304] Starting subtest: reset-multiple-signaled
[86.427577] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[86.539268] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.628152] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.631884] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[87.757917] [015/133] (930s left) gem_softpin (noreloc-s3)
[87.823106] Starting subtest: noreloc-S3
[108.170795] Subtest noreloc-S3: SUCCESS (5.410s)
[108.340487] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[108.452119] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[112.901925] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.425s)
[114.050980] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[114.105677] Starting subtest: invalid-ctx-set
[114.108137] Subtest invalid-ctx-set: SUCCESS (0.001s)
[114.240048] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[114.291867] Starting subtest: single-wait-all-for-submit-unsubmitted
[114.392628] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.100s)
[114.494267] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[114.593556] Starting subtest: x-tiled-64bpp-rotate-90
[114.612763] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[114.770234] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[114.817370] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[114.887094] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[114.981923] Starting subtest: fbc-psr-cursor-plane-move
[114.983841] Starting dynamic subtest: eDP-1
[114.987303] Dynamic subtest eDP-1: SKIP (0.000s)
[114.990826] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[115.077036] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[115.181155] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[116.152525] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.967s)
[116.334403] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[116.426996] Starting subtest: 2x-flip-vs-rmfb
[116.437751] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[116.539790] [024/133] (901s left) kms_plane_cursor (viewport)
[116.640925] Starting subtest: viewport
[116.644645] Starting dynamic subtest: pipe-A-eDP-1-size-64
[119.158882] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.510s)
[119.219486] Starting dynamic subtest: pipe-A-eDP-1-size-128
[121.676094] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.460s)
[121.738162] Starting dynamic subtest: pipe-A-eDP-1-size-256
[124.248125] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.515s)
[124.607572] Starting dynamic subtest: pipe-B-eDP-1-size-64
[127.750222] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.151s)
[127.809787] Starting dynamic subtest: pipe-B-eDP-1-size-128
[130.231617] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.426s)
[130.292816] Starting dynamic subtest: pipe-B-eDP-1-size-256
[132.811564] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.526s)
[133.162263] Starting dynamic subtest: pipe-C-eDP-1-size-64
[136.027873] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.875s)
[136.064070] Starting dynamic subtest: pipe-C-eDP-1-size-128
[138.182324] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.124s)
[138.218159] Starting dynamic subtest: pipe-C-eDP-1-size-256
[140.281093] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.069s)
[140.610491] Starting dynamic subtest: pipe-D-eDP-1-size-64
[143.398495] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.796s)
[143.435948] Starting dynamic subtest: pipe-D-eDP-1-size-128
[145.542333] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.113s)
[145.580109] Starting dynamic subtest: pipe-D-eDP-1-size-256
[147.708928] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.136s)
[148.025477] Subtest viewport: SUCCESS (31.360s)
[148.896361] [025/133] (869s left) kms_cdclk (mode-transition)
[148.993681] Starting subtest: mode-transition
[148.995975] Starting dynamic subtest: pipe-A-eDP-1
[149.283306] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[149.291577] Starting dynamic subtest: pipe-B-eDP-1
[149.295973] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[149.303582] Starting dynamic subtest: pipe-C-eDP-1
[149.307943] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[149.315425] Starting dynamic subtest: pipe-D-eDP-1
[149.319899] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[149.323909] Subtest mode-transition: SKIP (0.295s)
[150.106552] [026/133] (868s left) gem_exec_balancer (fairslice)
[150.173701] Starting subtest: fairslice
[153.049735] Subtest fairslice: SUCCESS (2.874s)
[153.838281] [027/133] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[153.955438] Starting subtest: basic-flip-before-cursor-varying-size
[154.885516] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.928s)
[155.739726] [028/133] (862s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[155.835448] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[155.837682] Starting dynamic subtest: pipe-A-default-mode
[156.123396] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[156.128201] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.286s)
[156.972767] [029/133] (861s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[157.075625] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[157.077988] Starting dynamic subtest: pipe-A-default-mode
[159.814818] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[159.817134] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.738s)
[160.669855] [030/133] (858s left) core_getstats (basic)
[160.737764] Starting subtest: basic
[160.739946] Subtest basic: SUCCESS (0.000s)
[160.858235] [031/133] (857s left) kms_rmfb (close-fd)
[160.958948] Starting subtest: close-fd
[160.960885] Starting dynamic subtest: pipe-A-eDP-1
[161.065919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[161.074136] Starting dynamic subtest: pipe-B-eDP-1
[162.213431] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[162.222952] Starting dynamic subtest: pipe-C-eDP-1
[163.325740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[163.334556] Starting dynamic subtest: pipe-D-eDP-1
[164.460147] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[164.462298] Subtest close-fd: SUCCESS (3.502s)
[165.693751] [032/133] (853s left) gem_exec_reloc (basic-gtt-wc)
[165.755551] Subtest basic-gtt-wc: SKIP (0.000s)
[165.827945] [033/133] (853s left) kms_properties (crtc-properties-legacy)
[165.922764] Starting subtest: crtc-properties-legacy
[165.925063] Starting dynamic subtest: pipe-A-eDP-1
[166.358127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[166.367215] Starting dynamic subtest: pipe-B-eDP-1
[167.526086] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[167.534733] Starting dynamic subtest: pipe-C-eDP-1
[168.653541] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[168.663711] Starting dynamic subtest: pipe-D-eDP-1
[169.784110] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[169.786003] Subtest crtc-properties-legacy: SUCCESS (3.860s)
[170.620449] [034/133] (848s left) kms_invalid_mode (zero-hdisplay)
[170.713754] Starting subtest: zero-hdisplay
[170.715916] Starting dynamic subtest: pipe-A-eDP-1
[171.008695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[171.016983] Starting dynamic subtest: pipe-B-eDP-1
[171.018830] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[171.026213] Starting dynamic subtest: pipe-C-eDP-1
[171.028131] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[171.035916] Starting dynamic subtest: pipe-D-eDP-1
[171.038025] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[171.040256] Subtest zero-hdisplay: SUCCESS (0.300s)
[171.848440] [035/133] (847s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[171.967037] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[171.969302] Starting dynamic subtest: pipe-A
[173.017055] Dynamic subtest pipe-A: SUCCESS (1.050s)
[173.025094] Starting dynamic subtest: pipe-B
[175.123341] Dynamic subtest pipe-B: SUCCESS (2.104s)
[175.132067] Starting dynamic subtest: pipe-C
[176.330221] Dynamic subtest pipe-C: SUCCESS (1.205s)
[176.338376] Starting dynamic subtest: pipe-D
[177.498352] Dynamic subtest pipe-D: SUCCESS (1.167s)
[177.500498] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.530s)
[178.696096] [036/133] (840s left) kms_pm_rpm (legacy-planes-dpms)
[180.921701] Starting subtest: legacy-planes-dpms
[180.924221] Starting dynamic subtest: plane-63
[189.548717] Dynamic subtest plane-63: SUCCESS (8.621s)
[189.560472] Starting dynamic subtest: plane-93
[197.838303] Dynamic subtest plane-93: SUCCESS (8.282s)
[197.849642] Starting dynamic subtest: plane-123
[206.475758] Dynamic subtest plane-123: SUCCESS (8.640s)
[206.486861] Starting dynamic subtest: plane-133
[215.063414] Dynamic subtest plane-133: SUCCESS (8.586s)
[215.066067] Subtest legacy-planes-dpms: SUCCESS (34.140s)
[215.455425] [037/133] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[215.561435] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[215.565648] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.694832] [038/133] (803s left) kms_dirtyfb (default-dirtyfb-ioctl)
[215.786720] Starting subtest: default-dirtyfb-ioctl
[215.788602] Starting dynamic subtest: A-eDP-1
[217.403268] Dynamic subtest A-eDP-1: SUCCESS (1.615s)
[217.405400] Subtest default-dirtyfb-ioctl: SUCCESS (1.616s)
[218.290843] [039/133] (800s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[218.431194] Starting subtest: cursorB-vs-flipA-legacy
[218.435569] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[218.599651] [040/133] (800s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[218.662358] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[218.664622] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[218.778481] [041/133] (800s left) kms_prime (basic-crc-vgem)
[218.899519] Starting subtest: basic-crc-vgem
[218.902044] Starting dynamic subtest: second-to-first
[219.834075] Dynamic subtest second-to-first: SUCCESS (0.937s)
[219.835941] Subtest basic-crc-vgem: SUCCESS (0.938s)
[219.948217] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[219.951221] [042/133] (799s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[220.050240] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[220.112238] [043/133] (799s left) i915_drm_fdinfo (busy)
[220.151367] Starting subtest: busy
[220.152985] Starting dynamic subtest: rcs0
[220.193150] Dynamic subtest rcs0: SKIP (0.041s)
[220.203928] Starting dynamic subtest: bcs0
[220.207818] Dynamic subtest bcs0: SKIP (0.001s)
[220.216242] Starting dynamic subtest: vcs0
[220.220004] Dynamic subtest vcs0: SKIP (0.001s)
[220.229925] Starting dynamic subtest: vcs1
[220.233330] Dynamic subtest vcs1: SKIP (0.001s)
[220.241122] Starting dynamic subtest: vecs0
[220.244608] Dynamic subtest vecs0: SKIP (0.001s)
[220.251995] Starting dynamic subtest: ccs0
[220.255534] Dynamic subtest ccs0: SKIP (0.001s)
[220.259042] Subtest busy: SKIP (0.058s)
[220.306681] [044/133] (798s left) gem_userptr_blits (nohangcheck)
[220.377473] Starting subtest: nohangcheck
[220.649997] Subtest nohangcheck: SUCCESS (0.269s)
[220.806874] [045/133] (798s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[220.904678] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[221.506432] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s)
[221.747205] [046/133] (797s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[221.842578] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[221.847118] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[223.020212] [047/133] (796s left) kms_scaling_modes (scaling-mode-full)
[223.115453] Starting subtest: scaling-mode-full
[223.117574] Starting dynamic subtest: pipe-A-eDP-1
[223.209073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[223.225248] Starting dynamic subtest: pipe-B-eDP-1
[224.423160] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s)
[224.444997] Starting dynamic subtest: pipe-C-eDP-1
[225.629114] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[225.638100] Starting dynamic subtest: pipe-D-eDP-1
[226.769662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[226.771923] Subtest scaling-mode-full: SUCCESS (3.657s)
[227.959707] [048/133] (791s left) kms_psr (fbc-pr-basic)
[228.059971] Starting subtest: fbc-pr-basic
[228.064503] Subtest fbc-pr-basic: SKIP (0.000s)
[228.158048] [049/133] (791s left) gem_ringfill (basic-all)
[233.801218] Starting subtest: basic-all
[234.957454] Subtest basic-all: SUCCESS (1.157s)
[235.123246] [050/133] (784s left) gem_exec_whisper (basic-fds-forked-all)
[235.192832] Starting subtest: basic-fds-forked-all
[256.860752] Subtest basic-fds-forked-all: SUCCESS (21.661s)
[257.090758] [051/133] (762s left) api_intel_bb (full-batch)
[257.154632] Starting subtest: full-batch
[257.160518] Subtest full-batch: SUCCESS (0.009s)
[257.308010] [052/133] (762s left) kms_cursor_crc (cursor-sliding-256x85)
[257.560728] Starting subtest: cursor-sliding-256x85
[257.608935] Subtest cursor-sliding-256x85: SKIP (0.043s)
[257.828273] [053/133] (761s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[257.922546] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[257.924870] Starting dynamic subtest: pipe-A-eDP-1
[257.981971] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[257.992621] Starting dynamic subtest: pipe-B-eDP-1
[258.040770] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[258.051133] Starting dynamic subtest: pipe-C-eDP-1
[258.098320] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[258.108580] Starting dynamic subtest: pipe-D-eDP-1
[258.155412] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[258.159014] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[260.139312] [054/133] (759s left) gen9_exec_parse (allowed-single)
[260.205223] Subtest allowed-single: SKIP (0.000s)
[260.296917] [055/133] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[260.394045] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[267.362936] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.970s)
[267.525452] [056/133] (752s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[267.632960] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[267.637367] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[267.752813] [057/133] (752s left) gem_exec_fence (expired-history)
[268.262117] Starting subtest: expired-history
[275.604141] Subtest expired-history: SUCCESS (7.342s)
[276.083473] [058/133] (743s left) kms_psr (fbc-psr-sprite-plane-move)
[276.186044] Starting subtest: fbc-psr-sprite-plane-move
[276.188319] Starting dynamic subtest: eDP-1
[276.192875] Dynamic subtest eDP-1: SKIP (0.000s)
[276.196984] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[276.283753] [059/133] (743s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[276.392972] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[283.132645] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.741s)
[283.271493] [060/133] (736s left) gem_ctx_bad_destroy (double-destroy)
[283.333817] Starting subtest: double-destroy
[283.336273] Subtest double-destroy: SUCCESS (0.000s)
[283.432009] [061/133] (736s left) syncobj_timeline (invalid-signal-illegal-handle)
[283.493507] Starting subtest: invalid-signal-illegal-handle
[283.496119] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[283.624979] [062/133] (736s left) kms_chamelium_hpd (common-hpd-after-suspend)
[284.007440] Subtest common-hpd-after-suspend: SKIP (0.000s)
[284.795144] [063/133] (735s left) kms_frontbuffer_tracking (fbc-tiling-4)
[284.901867] Starting subtest: fbc-tiling-4
[289.150764] Subtest fbc-tiling-4: SUCCESS (4.258s)
[290.345803] [064/133] (729s left) gem_cs_tlb (engines)
[290.409962] Starting subtest: engines
[290.412293] Starting dynamic subtest: rcs0
[292.565771] Dynamic subtest rcs0: SUCCESS (2.151s)
[292.575773] Starting dynamic subtest: bcs0
[294.718398] Dynamic subtest bcs0: SUCCESS (2.151s)
[294.727643] Starting dynamic subtest: vcs0
[296.871705] Dynamic subtest vcs0: SUCCESS (2.152s)
[296.881024] Starting dynamic subtest: vcs1
[299.025538] Dynamic subtest vcs1: SUCCESS (2.152s)
[299.035091] Starting dynamic subtest: vecs0
[301.179433] Dynamic subtest vecs0: SUCCESS (2.152s)
[301.191304] Starting dynamic subtest: ccs0
[303.334464] Dynamic subtest ccs0: SUCCESS (2.154s)
[303.336890] Subtest engines: SUCCESS (12.917s)
[303.483580] [065/133] (716s left) gem_mmap_gtt (hang-busy)
[303.541584] Subtest hang-busy: SKIP (0.000s)
[303.611617] [066/133] (716s left) kms_psr (psr2-sprite-plane-onoff)
[303.702758] Starting subtest: psr2-sprite-plane-onoff
[303.705051] Starting dynamic subtest: eDP-1
[305.422849] Dynamic subtest eDP-1: SUCCESS (1.718s)
[305.425020] Subtest psr2-sprite-plane-onoff: SUCCESS (1.719s)
[306.300426] [067/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[306.405302] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[307.007203] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.603s)
[307.227211] [068/133] (713s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[307.333437] Starting subtest: y-tiled-64bpp-rotate-270
[307.337888] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[307.469216] [069/133] (712s left) gem_bad_reloc (negative-reloc-lut)
[307.540402] Subtest negative-reloc-lut: SKIP (0.000s)
[307.606925] [070/133] (712s left) gem_ctx_persistence (engines-mixed)
[307.666173] Starting subtest: engines-mixed
[307.668653] Starting dynamic subtest: rcs0
[307.771829] Dynamic subtest rcs0: SUCCESS (0.105s)
[307.785026] Starting dynamic subtest: bcs0
[307.856200] Dynamic subtest bcs0: SUCCESS (0.082s)
[307.868768] Starting dynamic subtest: vcs0
[307.914573] Dynamic subtest vcs0: SUCCESS (0.057s)
[307.930982] Starting dynamic subtest: vcs1
[307.938817] Dynamic subtest vcs1: SUCCESS (0.023s)
[307.947484] Starting dynamic subtest: vecs0
[308.027150] Dynamic subtest vecs0: SUCCESS (0.087s)
[308.038492] Starting dynamic subtest: ccs0
[308.091313] Dynamic subtest ccs0: SUCCESS (0.062s)
[308.093528] Subtest engines-mixed: SUCCESS (0.427s)
[308.193896] [071/133] (712s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[308.289950] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[308.291896] Starting dynamic subtest: pipe-A
[308.353697] Dynamic subtest pipe-A: SUCCESS (0.065s)
[308.364089] Starting dynamic subtest: pipe-B
[309.506302] Dynamic subtest pipe-B: SUCCESS (1.150s)
[309.515396] Starting dynamic subtest: pipe-C
[310.614071] Dynamic subtest pipe-C: SUCCESS (1.106s)
[310.624380] Starting dynamic subtest: pipe-D
[311.745569] Dynamic subtest pipe-D: SUCCESS (1.130s)
[311.748030] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.457s)
[312.927987] [072/133] (707s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[313.040399] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[313.044649] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[313.182562] [073/133] (707s left) gem_exec_schedule (semaphore-noskip)
[313.266891] Starting subtest: semaphore-noskip
[313.670261] Subtest semaphore-noskip: SUCCESS (0.413s)
[314.037444] [074/133] (706s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[314.136978] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[314.140958] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[314.282643] [075/133] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[314.369833] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[314.373909] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[314.515907] [076/133] (706s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[314.624388] Starting subtest: 4-tiled-16bpp-rotate-0
[315.937178] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.312s)
[316.117504] [077/133] (704s left) gem_exec_basic (basic)
[316.176973] Starting subtest: basic
[316.178963] Starting dynamic subtest: rcs0-smem
[316.180990] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[316.191987] Starting dynamic subtest: bcs0-smem
[316.193650] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[316.203182] Starting dynamic subtest: vcs0-smem
[316.204766] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[316.212775] Starting dynamic subtest: vcs1-smem
[316.214404] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[316.222413] Starting dynamic subtest: vecs0-smem
[316.224026] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[316.232483] Starting dynamic subtest: ccs0-smem
[316.234082] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[316.235629] Subtest basic: SUCCESS (0.013s)
[317.892229] [078/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[317.988414] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[317.993151] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.124613] [079/133] (702s left) gem_mmap (short-mmap)
[318.184227] Subtest short-mmap: SKIP (0.000s)
[318.248015] [080/133] (702s left) gem_exec_reloc (basic-gtt-wc-active)
[318.317360] Subtest basic-gtt-wc-active: SKIP (0.000s)
[318.403086] [081/133] (702s left) gem_ctx_shared (create-shared-gtt)
[318.470864] Starting subtest: create-shared-gtt
[320.626002] Subtest create-shared-gtt: SUCCESS (2.153s)
[321.225842] [082/133] (699s left) gem_exec_reloc (basic-write-wc)
[321.292383] Subtest basic-write-wc: SKIP (0.000s)
[321.374753] [083/133] (699s left) gem_eio (wait-immediate)
[321.612163] Starting subtest: wait-immediate
[322.008961] Subtest wait-immediate: SUCCESS (0.399s)
[322.215103] [084/133] (698s left) gem_ctx_persistence (legacy-engines-mixed)
[322.278397] Starting subtest: legacy-engines-mixed
[322.280260] Starting dynamic subtest: render
[322.383001] Dynamic subtest render: SUCCESS (0.107s)
[322.396923] Starting dynamic subtest: bsd1
[322.454549] Dynamic subtest bsd1: SUCCESS (0.068s)
[322.469634] Starting dynamic subtest: bsd2
[322.520453] Dynamic subtest bsd2: SUCCESS (0.063s)
[322.532305] Starting dynamic subtest: blt
[322.592786] Dynamic subtest blt: SUCCESS (0.070s)
[322.604656] Starting dynamic subtest: vebox
[322.661174] Dynamic subtest vebox: SUCCESS (0.066s)
[322.663293] Subtest legacy-engines-mixed: SUCCESS (0.387s)
[322.764433] [085/133] (698s left) perf_pmu (semaphore-busy)
[322.797804] Starting subtest: semaphore-busy
[322.799736] Starting dynamic subtest: rcs0
[324.451090] Dynamic subtest rcs0: SUCCESS (1.648s)
[324.463982] Starting dynamic subtest: bcs0
[326.081310] Dynamic subtest bcs0: SUCCESS (1.628s)
[326.093856] Starting dynamic subtest: vcs0
[330.304619] Dynamic subtest vcs0: SUCCESS (4.221s)
[330.317343] Starting dynamic subtest: vcs1
[336.319705] Dynamic subtest vcs1: SUCCESS (6.014s)
[336.330282] Starting dynamic subtest: vecs0
[342.335905] Dynamic subtest vecs0: SUCCESS (6.015s)
[342.347057] Starting dynamic subtest: ccs0
[345.409894] Dynamic subtest ccs0: SUCCESS (3.071s)
[345.412482] Subtest semaphore-busy: SUCCESS (22.613s)
[345.574624] [086/133] (675s left) gem_exec_schedule (pi-common)
[345.769185] Starting subtest: pi-common
[345.771317] Starting dynamic subtest: rcs0
[345.809971] Dynamic subtest rcs0: SUCCESS (0.043s)
[345.819314] Starting dynamic subtest: bcs0
[345.854734] Dynamic subtest bcs0: SUCCESS (0.044s)
[345.864771] Starting dynamic subtest: vcs0
[345.894126] Dynamic subtest vcs0: SUCCESS (0.038s)
[345.905630] Starting dynamic subtest: vcs1
[345.931750] Dynamic subtest vcs1: SUCCESS (0.037s)
[345.946294] Starting dynamic subtest: vecs0
[345.964422] Dynamic subtest vecs0: SUCCESS (0.032s)
[345.974386] Starting dynamic subtest: ccs0
[345.999515] Dynamic subtest ccs0: SUCCESS (0.034s)
[346.001767] Subtest pi-common: SUCCESS (0.234s)
[346.249222] [087/133] (674s left) i915_hangman (engine-error-state-capture)
[346.325090] Starting subtest: engine-error-state-capture
[346.327470] Starting dynamic subtest: rcs0
[349.796025] Dynamic subtest rcs0: SUCCESS (3.470s)
[349.808702] Starting dynamic subtest: bcs0
[355.748307] Dynamic subtest bcs0: SUCCESS (5.950s)
[355.761509] Starting dynamic subtest: vcs0
[361.699615] Dynamic subtest vcs0: SUCCESS (5.949s)
[361.712837] Starting dynamic subtest: vcs1
[366.755249] Dynamic subtest vcs1: SUCCESS (5.053s)
[366.768821] Starting dynamic subtest: vecs0
[372.772143] Dynamic subtest vecs0: SUCCESS (6.014s)
[372.784618] Starting dynamic subtest: ccs0
[378.787783] Dynamic subtest ccs0: SUCCESS (6.013s)
[378.790857] Subtest engine-error-state-capture: SUCCESS (32.466s)
[378.984743] [088/133] (642s left) syncobj_timeline (wait-for-submit-snapshot)
[379.037629] Starting subtest: wait-for-submit-snapshot
[379.119850] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[379.227677] [089/133] (642s left) kms_color (ctm-blue-to-red)
[379.317540] Starting subtest: ctm-blue-to-red
[379.319836] Starting dynamic subtest: pipe-A-eDP-1
[379.996171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.679s)
[380.006673] Starting dynamic subtest: pipe-B-eDP-1
[381.347058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[381.356991] Starting dynamic subtest: pipe-C-eDP-1
[382.633203] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[382.644170] Starting dynamic subtest: pipe-D-eDP-1
[383.964037] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[383.966464] Subtest ctm-blue-to-red: SUCCESS (4.648s)
[384.830885] [090/133] (636s left) prime_vgem (basic-gtt)
[384.933395] Starting subtest: basic-gtt
[384.938222] Subtest basic-gtt: SKIP (0.000s)
[385.075109] [091/133] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[385.183108] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[392.585266] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.404s)
[392.766942] [092/133] (628s left) api_intel_allocator (default-alignment)
[392.831901] Starting subtest: default-alignment
[392.834162] Subtest default-alignment: SUCCESS (0.003s)
[393.018408] [093/133] (628s left) i915_pm_rps (fence-order)
[393.077992] Starting subtest: fence-order
[395.929724] Subtest fence-order: SUCCESS (2.850s)
[396.093638] [094/133] (625s left) kms_vblank (query-busy)
[396.195914] Starting subtest: query-busy
[396.197850] Starting dynamic subtest: pipe-A-eDP-1
[398.073265] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[398.090453] Starting dynamic subtest: pipe-D-eDP-1
[400.592708] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.517s)
[400.595048] Subtest query-busy: SUCCESS (4.399s)
[401.424983] [095/133] (620s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[401.535070] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[401.539110] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[401.659957] [096/133] (619s left) kms_addfb_basic (invalid-get-prop-any)
[401.725508] Starting subtest: invalid-get-prop-any
[401.727851] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[401.899385] [097/133] (619s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[401.992977] Starting subtest: fbc-psr2-cursor-mmap-gtt
[401.994858] Starting dynamic subtest: eDP-1
[401.999071] Dynamic subtest eDP-1: SKIP (0.000s)
[402.003318] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[402.089433] [098/133] (619s left) kms_flip (2x-blocking-absolute-wf_vblank)
[402.181577] Starting subtest: 2x-blocking-absolute-wf_vblank
[402.189978] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[402.327993] [099/133] (619s left) kms_cursor_crc (cursor-onscreen-256x85)
[402.590654] Starting subtest: cursor-onscreen-256x85
[402.638765] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[402.848238] [100/133] (618s left) kms_flip (2x-modeset-vs-vblank-race)
[402.939648] Starting subtest: 2x-modeset-vs-vblank-race
[402.948748] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[403.089171] [101/133] (618s left) kms_atomic_interruptible (atomic-setmode)
[403.182749] Starting subtest: atomic-setmode
[403.184571] Starting dynamic subtest: pipe-A-eDP-1
[410.098055] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.914s)
[410.100334] Subtest atomic-setmode: SUCCESS (6.915s)
[410.984879] [102/133] (610s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[411.093884] Starting subtest: psr-argb161616f-draw-render
[411.097841] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[411.228931] [103/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[411.342851] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[411.346832] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[411.497374] [104/133] (610s left) kms_plane_scaling (invalid-num-scalers)
[411.590681] Starting subtest: invalid-num-scalers
[411.592891] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[411.607528] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[411.617032] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[411.640422] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[411.650355] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[411.673577] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[411.683188] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[411.704147] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[411.706264] Subtest invalid-num-scalers: SUCCESS (0.116s)
[411.820709] [105/133] (610s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[411.929685] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[411.933080] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[412.072111] [106/133] (609s left) sw_sync (alloc_fence_invalid_timeline)
[412.103408] Starting subtest: alloc_fence_invalid_timeline
[412.105111] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[412.178860] [107/133] (609s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[412.239109] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[412.345311] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[412.443744] [108/133] (609s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[412.541694] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[412.543838] Starting dynamic subtest: A-eDP1
[421.410853] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[421.422294] Starting dynamic subtest: B-eDP1
[430.350023] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[430.362676] Starting dynamic subtest: C-eDP1
[439.270274] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[439.282865] Starting dynamic subtest: D-eDP1
[448.194650] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[448.196894] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.652s)
[449.442878] [109/133] (572s left) kms_addfb_basic (size-max)
[449.544772] Starting subtest: size-max
[449.547054] Subtest size-max: SUCCESS (0.000s)
[449.657806] [110/133] (572s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[449.901544] Starting subtest: cursor-rapid-movement-256x256
[449.906774] Starting dynamic subtest: pipe-A-eDP-1
[450.465195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.559s)
[450.502956] Starting dynamic subtest: pipe-D-eDP-1
[451.641276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[451.643557] Subtest cursor-rapid-movement-256x256: SUCCESS (1.738s)
[452.533375] [111/133] (569s left) gem_exec_whisper (basic-queues-all)
[452.608737] Starting subtest: basic-queues-all
[461.194548] Subtest basic-queues-all: SUCCESS (8.581s)
[461.403998] [112/133] (560s left) kms_dsc (dsc-fractional-bpp)
[461.507013] Starting subtest: dsc-fractional-bpp
[461.519798] Subtest dsc-fractional-bpp: SKIP (0.000s)
[461.606513] [113/133] (560s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[461.707898] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[461.710201] Starting dynamic subtest: pipe-A-default-mode
[462.004906] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[462.009517] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.296s)
[462.846271] [114/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[462.968694] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[462.972850] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[463.115970] [115/133] (559s left) gem_softpin (evict-prime)
[463.179690] Starting subtest: evict-prime
[463.182088] Starting dynamic subtest: rcs0
[464.374105] Dynamic subtest rcs0: SUCCESS (1.194s)
[464.387120] Starting dynamic subtest: bcs0
[465.534736] Dynamic subtest bcs0: SUCCESS (1.159s)
[465.547664] Starting dynamic subtest: vcs0
[466.773196] Dynamic subtest vcs0: SUCCESS (1.234s)
[466.786610] Starting dynamic subtest: vcs1
[468.809629] Dynamic subtest vcs1: SUCCESS (2.034s)
[468.827752] Starting dynamic subtest: vecs0
[470.754275] Dynamic subtest vecs0: SUCCESS (1.942s)
[470.767299] Starting dynamic subtest: ccs0
[471.919173] Dynamic subtest ccs0: SUCCESS (1.164s)
[471.936274] Starting dynamic subtest: all
[473.747831] Dynamic subtest all: SUCCESS (1.825s)
[473.750307] Subtest evict-prime: SUCCESS (10.567s)
[473.858136] [116/133] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[473.965332] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[473.969731] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[474.111553] [117/133] (548s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[474.210755] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[474.340752] [118/133] (548s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[474.396860] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[474.506194] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[474.608561] [119/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[474.705008] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[474.709526] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[474.833838] [120/133] (547s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[474.937142] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[479.010875] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.078s)
[480.194743] [121/133] (542s left) gem_mmap_wc (bad-size)
[480.262504] Subtest bad-size: SKIP (0.000s)
[480.335059] [122/133] (542s left) kms_hdr (static-toggle-suspend)
[480.429545] Starting subtest: static-toggle-suspend
[480.436021] Subtest static-toggle-suspend: SKIP (0.000s)
[480.528341] [123/133] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[480.643221] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[480.647307] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[480.779662] [124/133] (541s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[485.833982] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[485.836153] Starting dynamic subtest: pipe-A-eDP-1
[486.626122] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[486.636972] Starting dynamic subtest: pipe-B-eDP-1
[487.753939] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[487.758353] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.919s)
[488.962711] [125/133] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[489.067923] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[489.071881] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[489.181114] [126/133] (533s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[489.270821] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[489.273127] Starting dynamic subtest: pipe-A-eDP-1
[489.293209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[489.304770] Starting dynamic subtest: pipe-B-eDP-1
[489.323851] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[489.333725] Starting dynamic subtest: pipe-C-eDP-1
[489.352983] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[489.362621] Starting dynamic subtest: pipe-D-eDP-1
[489.380885] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[489.382918] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[491.457459] [127/133] (531s left) syncobj_timeline (single-wait-all-available-submitted)
[491.519432] Starting subtest: single-wait-all-available-submitted
[491.521591] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[491.657875] [128/133] (531s left) gem_exec_parallel (userptr)
[491.744912] Starting subtest: userptr
[491.747291] Starting dynamic subtest: rcs0
[493.212877] Dynamic subtest rcs0: SUCCESS (1.467s)
[493.226869] Starting dynamic subtest: bcs0
[494.686747] Dynamic subtest bcs0: SUCCESS (1.470s)
[494.699890] Starting dynamic subtest: vcs0
[496.774345] Dynamic subtest vcs0: SUCCESS (2.083s)
[496.787507] Starting dynamic subtest: vcs1
[498.821254] Dynamic subtest vcs1: SUCCESS (2.044s)
[498.834310] Starting dynamic subtest: vecs0
[500.804607] Dynamic subtest vecs0: SUCCESS (1.980s)
[500.816905] Starting dynamic subtest: ccs0
[502.293729] Dynamic subtest ccs0: SUCCESS (1.488s)
[502.295938] Subtest userptr: SUCCESS (10.548s)
[502.504461] [129/133] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[502.618564] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[502.622781] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[502.761359] [130/133] (520s left) i915_selftest (mock)
[506.277143] Starting subtest: mock
[506.279519] Starting dynamic subtest: sanitycheck
[507.011115] Dynamic subtest sanitycheck: SUCCESS (0.734s)
[507.020702] Starting dynamic subtest: shmem
[507.765720] Dynamic subtest shmem: SUCCESS (0.753s)
[507.775066] Starting dynamic subtest: fence
[515.982970] Dynamic subtest fence: SUCCESS (8.214s)
[515.992276] Starting dynamic subtest: scatterlist
[517.717610] Dynamic subtest scatterlist: SUCCESS (1.732s)
[517.728086] Starting dynamic subtest: syncmap
[521.040894] Dynamic subtest syncmap: SUCCESS (3.320s)
[521.056478] Starting dynamic subtest: uncore
[521.785044] Dynamic subtest uncore: SUCCESS (0.742s)
[521.795023] Starting dynamic subtest: ring
[522.522002] Dynamic subtest ring: SUCCESS (0.735s)
[522.532102] Starting dynamic subtest: engine
[523.204961] Dynamic subtest engine: SUCCESS (0.681s)
[523.215086] Starting dynamic subtest: timelines
[527.114017] Dynamic subtest timelines: SUCCESS (3.905s)
[527.123269] Starting dynamic subtest: requests
[530.775541] Dynamic subtest requests: SUCCESS (3.658s)
[530.785413] Starting dynamic subtest: objects
[531.688514] Dynamic subtest objects: SUCCESS (0.912s)
[531.704268] Starting dynamic subtest: phys
[532.595328] Dynamic subtest phys: SUCCESS (0.904s)
[532.603564] Starting dynamic subtest: dmabuf
[533.440287] Dynamic subtest dmabuf: SUCCESS (0.842s)
[533.450044] Starting dynamic subtest: vma
[538.731368] Dynamic subtest vma: SUCCESS (5.287s)
[538.740881] Starting dynamic subtest: evict
[540.141168] Dynamic subtest evict: SUCCESS (1.407s)
[540.151152] Starting dynamic subtest: gtt
[543.827328] Dynamic subtest gtt: SUCCESS (3.683s)
[543.837705] Starting dynamic subtest: hugepages
[544.815869] Dynamic subtest hugepages: SUCCESS (0.987s)
[544.825511] Starting dynamic subtest: memory_region
[547.446836] Dynamic subtest memory_region: SUCCESS (2.628s)
[547.449700] Subtest mock: SUCCESS (41.162s)
[547.478116] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[547.478794] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[547.482044] [131/133] (475s left) gem_mmap_gtt (basic-write-read)
[549.014228] Subtest basic-write-read: SKIP (0.000s)
[549.083721] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[549.084957] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[549.090910] [132/133] (473s left) perf (gen12-group-exclusive-stream-sample-oa)
[549.250419] Starting subtest: gen12-group-exclusive-stream-sample-oa
[549.271130] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[549.322550] [133/133] (473s left) perf_pmu (busy-double-start)
[549.358904] Starting subtest: busy-double-start
[549.360762] Starting dynamic subtest: rcs0
[553.003214] Dynamic subtest rcs0: FAIL (3.593s)
[553.011623] Starting dynamic subtest: bcs0
[556.556812] Dynamic subtest bcs0: SUCCESS (3.604s)
[556.567883] Starting dynamic subtest: vcs0
[560.372357] Dynamic subtest vcs0: SUCCESS (3.813s)
[560.383854] Starting dynamic subtest: vcs1
[564.332579] Dynamic subtest vcs1: SUCCESS (3.957s)
[564.343324] Starting dynamic subtest: vecs0
[568.329972] Dynamic subtest vecs0: SUCCESS (3.994s)
[568.340942] Starting dynamic subtest: ccs0
[571.965612] Dynamic subtest ccs0: FAIL (3.564s)
[571.967661] Subtest busy-double-start: FAIL (22.535s)
[572.056219] 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.