[56.498002] Initializing watchdogs
[56.498064]   /dev/watchdog0
[56.512915] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.517788] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.520752] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.524771] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[56.599180] Subtest write-snoop: SKIP (0.000s)
[56.685741] [002/133] (960s left) kms_content_protection (content-type-change)
[56.835352] Starting subtest: content-type-change
[56.839986] Subtest content-type-change: SKIP (0.000s)
[56.983434] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[57.079043] Starting subtest: multiplane-rotation
[74.541230] Subtest multiplane-rotation: SUCCESS (17.448s)
[74.699780] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[74.811187] Subtest ctm-red-to-blue: SKIP (0.000s)
[74.856291] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[74.925110] Starting subtest: invalid-reset-one-illegal-handle
[74.926783] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[75.061983] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[75.155523] Starting subtest: disable-crc-after-crtc
[75.157197] Starting dynamic subtest: pipe-A-eDP-1
[77.061535] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.905s)
[77.071682] Starting dynamic subtest: pipe-B-eDP-1
[79.442812] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.379s)
[79.452289] Starting dynamic subtest: pipe-C-eDP-1
[81.752763] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.311s)
[81.761831] Starting dynamic subtest: pipe-D-eDP-1
[84.022750] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.267s)
[84.025120] Subtest disable-crc-after-crtc: SUCCESS (8.866s)
[84.869131] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[84.947820] Subtest tiled-to-tiled: SKIP (0.000s)
[85.033279] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[85.097193] Starting subtest: wait-all-interrupted
[85.200860] Subtest wait-all-interrupted: SUCCESS (0.103s)
[85.299305] [009/133] (932s left) syncobj_wait (wait-all-complex)
[85.355798] Starting subtest: wait-all-complex
[85.569662] Subtest wait-all-complex: SUCCESS (0.213s)
[85.665406] [010/133] (931s left) gem_pxp (reject-modify-context-protection-on)
[85.802849] Starting subtest: reject-modify-context-protection-on
[85.805339] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[85.927235] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[86.058128] Starting subtest: cursorA-vs-flipB-varying-size
[86.062530] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[86.236035] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[86.335062] Starting subtest: primary-rotation-90
[86.339211] Subtest primary-rotation-90: SKIP (0.001s)
[86.436946] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[86.490127] Starting subtest: reset-multiple-signaled
[86.492119] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[86.607509] [014/133] (930s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.707556] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.711289] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[87.894614] [015/133] (929s left) gem_softpin (noreloc-s3)
[87.963712] Starting subtest: noreloc-S3
[108.214231] Subtest noreloc-S3: SUCCESS (5.409s)
[116.394539] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[116.522836] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[120.959497] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.407s)
[122.120214] [017/133] (903s left) gem_ctx_param (invalid-ctx-set)
[122.187847] Starting subtest: invalid-ctx-set
[122.190230] Subtest invalid-ctx-set: SUCCESS (0.001s)
[122.334350] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[122.391003] Starting subtest: single-wait-all-for-submit-unsubmitted
[122.497631] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[122.597099] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[122.705373] Starting subtest: x-tiled-64bpp-rotate-90
[122.726366] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[122.906572] [020/133] (902s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[122.970703] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[123.028379] [021/133] (902s left) kms_psr (fbc-psr-cursor-plane-move)
[123.126464] Starting subtest: fbc-psr-cursor-plane-move
[123.128440] Starting dynamic subtest: eDP-1
[123.132635] Dynamic subtest eDP-1: SKIP (0.000s)
[123.136860] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[123.218884] [022/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[123.323387] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[124.339435] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[124.489408] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb)
[124.580098] Starting subtest: 2x-flip-vs-rmfb
[124.588870] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[124.689768] [024/133] (901s left) kms_plane_cursor (viewport)
[124.790881] Starting subtest: viewport
[124.794731] Starting dynamic subtest: pipe-A-eDP-1-size-64
[127.374995] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[127.435968] Starting dynamic subtest: pipe-A-eDP-1-size-128
[130.026885] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.593s)
[130.088717] Starting dynamic subtest: pipe-A-eDP-1-size-256
[132.711302] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.627s)
[133.059967] Starting dynamic subtest: pipe-B-eDP-1-size-64
[136.312469] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.256s)
[136.371017] Starting dynamic subtest: pipe-B-eDP-1-size-128
[138.938856] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[138.998372] Starting dynamic subtest: pipe-B-eDP-1-size-256
[141.518535] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.526s)
[141.881812] Starting dynamic subtest: pipe-C-eDP-1-size-64
[144.903648] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.029s)
[144.946064] Starting dynamic subtest: pipe-C-eDP-1-size-128
[147.137012] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[147.174212] Starting dynamic subtest: pipe-C-eDP-1-size-256
[149.402194] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s)
[149.728763] Starting dynamic subtest: pipe-D-eDP-1-size-64
[152.599587] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.882s)
[152.638140] Starting dynamic subtest: pipe-D-eDP-1-size-128
[154.865477] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.235s)
[154.903196] Starting dynamic subtest: pipe-D-eDP-1-size-256
[157.110369] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.213s)
[157.428281] Subtest viewport: SUCCESS (32.605s)
[158.298456] [025/133] (867s left) kms_cdclk (mode-transition)
[158.397262] Starting subtest: mode-transition
[158.399364] Starting dynamic subtest: pipe-A-eDP-1
[158.684794] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[158.693776] Starting dynamic subtest: pipe-B-eDP-1
[158.698323] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[158.706432] Starting dynamic subtest: pipe-C-eDP-1
[158.711078] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[158.718858] Starting dynamic subtest: pipe-D-eDP-1
[158.722877] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[158.727073] Subtest mode-transition: SKIP (0.293s)
[159.520910] [026/133] (866s left) gem_exec_balancer (fairslice)
[159.578334] Starting subtest: fairslice
[162.456290] Subtest fairslice: SUCCESS (2.876s)
[162.855886] [027/133] (863s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[162.984505] Starting subtest: basic-flip-before-cursor-varying-size
[163.898190] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.912s)
[164.746583] [028/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[164.836193] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[164.838382] Starting dynamic subtest: pipe-A-default-mode
[165.131012] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[165.136335] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.293s)
[165.982103] [029/133] (860s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[166.082586] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[166.084990] Starting dynamic subtest: pipe-A-default-mode
[168.799952] Dynamic subtest pipe-A-default-mode: SUCCESS (2.718s)
[168.802360] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.720s)
[169.665380] [030/133] (856s left) core_getstats (basic)
[169.729998] Starting subtest: basic
[169.732364] Subtest basic: SUCCESS (0.000s)
[169.863435] [031/133] (856s left) kms_rmfb (close-fd)
[169.957131] Starting subtest: close-fd
[169.959073] Starting dynamic subtest: pipe-A-eDP-1
[170.063994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[170.072344] Starting dynamic subtest: pipe-B-eDP-1
[171.217688] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[171.226995] Starting dynamic subtest: pipe-C-eDP-1
[172.339937] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[172.348772] Starting dynamic subtest: pipe-D-eDP-1
[173.465511] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[173.467670] Subtest close-fd: SUCCESS (3.508s)
[174.707376] [032/133] (851s left) gem_exec_reloc (basic-gtt-wc)
[174.763726] Subtest basic-gtt-wc: SKIP (0.000s)
[174.851710] [033/133] (851s left) kms_properties (crtc-properties-legacy)
[174.958367] Starting subtest: crtc-properties-legacy
[174.960646] Starting dynamic subtest: pipe-A-eDP-1
[175.398006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[175.407403] Starting dynamic subtest: pipe-B-eDP-1
[176.556022] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[176.565477] Starting dynamic subtest: pipe-C-eDP-1
[177.676994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[177.686157] Starting dynamic subtest: pipe-D-eDP-1
[178.817276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[178.819400] Subtest crtc-properties-legacy: SUCCESS (3.858s)
[179.647952] [034/133] (846s left) kms_invalid_mode (zero-hdisplay)
[179.756025] Starting subtest: zero-hdisplay
[179.758174] Starting dynamic subtest: pipe-A-eDP-1
[180.050589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[180.060717] Starting dynamic subtest: pipe-B-eDP-1
[180.062627] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[180.070375] Starting dynamic subtest: pipe-C-eDP-1
[180.072309] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[180.080491] Starting dynamic subtest: pipe-D-eDP-1
[180.082718] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[180.084915] Subtest zero-hdisplay: SUCCESS (0.305s)
[180.879010] [035/133] (845s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[180.978661] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[180.980850] Starting dynamic subtest: pipe-A
[182.030022] Dynamic subtest pipe-A: SUCCESS (1.051s)
[182.043497] Starting dynamic subtest: pipe-B
[184.161651] Dynamic subtest pipe-B: SUCCESS (2.129s)
[184.169911] Starting dynamic subtest: pipe-C
[185.359533] Dynamic subtest pipe-C: SUCCESS (1.197s)
[185.368235] Starting dynamic subtest: pipe-D
[186.585614] Dynamic subtest pipe-D: SUCCESS (1.224s)
[186.587960] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.607s)
[187.805778] [036/133] (838s left) kms_pm_rpm (legacy-planes-dpms)
[189.942560] Starting subtest: legacy-planes-dpms
[189.945075] Starting dynamic subtest: plane-63
[198.634804] Dynamic subtest plane-63: SUCCESS (8.691s)
[198.646298] Starting dynamic subtest: plane-93
[207.254859] Dynamic subtest plane-93: SUCCESS (8.615s)
[207.266272] Starting dynamic subtest: plane-123
[215.980415] Dynamic subtest plane-123: SUCCESS (8.722s)
[215.991076] Starting dynamic subtest: plane-133
[224.408566] Dynamic subtest plane-133: SUCCESS (8.429s)
[224.411170] Subtest legacy-planes-dpms: SUCCESS (34.469s)
[224.786502] [037/133] (801s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[224.882624] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[224.886609] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[225.013519] [038/133] (801s left) kms_dirtyfb (default-dirtyfb-ioctl)
[225.098195] Starting subtest: default-dirtyfb-ioctl
[225.100552] Starting dynamic subtest: A-eDP-1
[226.719640] Dynamic subtest A-eDP-1: SUCCESS (1.619s)
[226.721505] Subtest default-dirtyfb-ioctl: SUCCESS (1.621s)
[227.542223] [039/133] (798s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[227.671556] Starting subtest: cursorB-vs-flipA-legacy
[227.676016] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[227.851712] [040/133] (798s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[227.911773] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[227.913755] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[228.058330] [041/133] (798s left) kms_prime (basic-crc-vgem)
[228.195954] Starting subtest: basic-crc-vgem
[228.198185] Starting dynamic subtest: second-to-first
[229.212623] Dynamic subtest second-to-first: SUCCESS (1.019s)
[229.214349] Subtest basic-crc-vgem: SUCCESS (1.020s)
[229.324944] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[229.327882] [042/133] (797s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[229.430069] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[229.500722] [043/133] (797s left) i915_drm_fdinfo (busy)
[229.536822] Starting subtest: busy
[229.538754] Starting dynamic subtest: rcs0
[229.563266] Dynamic subtest rcs0: SKIP (0.026s)
[229.573627] Starting dynamic subtest: bcs0
[229.576914] Dynamic subtest bcs0: SKIP (0.000s)
[229.585556] Starting dynamic subtest: vcs0
[229.589140] Dynamic subtest vcs0: SKIP (0.000s)
[229.597118] Starting dynamic subtest: vcs1
[229.600450] Dynamic subtest vcs1: SKIP (0.000s)
[229.608133] Starting dynamic subtest: vecs0
[229.611570] Dynamic subtest vecs0: SKIP (0.000s)
[229.619357] Starting dynamic subtest: ccs0
[229.622784] Dynamic subtest ccs0: SKIP (0.000s)
[229.626163] Subtest busy: SKIP (0.031s)
[229.662088] [044/133] (797s left) gem_userptr_blits (nohangcheck)
[229.744087] Starting subtest: nohangcheck
[229.986879] Subtest nohangcheck: SUCCESS (0.241s)
[230.136643] [045/133] (796s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[230.236482] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[230.849348] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.615s)
[231.046582] [046/133] (795s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[231.146935] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[231.151203] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[232.282010] [047/133] (794s left) kms_scaling_modes (scaling-mode-full)
[232.380230] Starting subtest: scaling-mode-full
[232.382506] Starting dynamic subtest: pipe-A-eDP-1
[232.472291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[232.482139] Starting dynamic subtest: pipe-B-eDP-1
[233.674765] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.201s)
[233.683678] Starting dynamic subtest: pipe-C-eDP-1
[234.806892] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[234.817949] Starting dynamic subtest: pipe-D-eDP-1
[235.925087] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s)
[235.927492] Subtest scaling-mode-full: SUCCESS (3.548s)
[237.100702] [048/133] (789s left) kms_psr (fbc-pr-basic)
[237.196955] Starting subtest: fbc-pr-basic
[237.201150] Subtest fbc-pr-basic: SKIP (0.000s)
[237.296532] [049/133] (789s left) gem_ringfill (basic-all)
[242.770141] Starting subtest: basic-all
[243.930378] Subtest basic-all: SUCCESS (1.160s)
[244.098499] [050/133] (782s left) gem_exec_whisper (basic-fds-forked-all)
[244.171222] Starting subtest: basic-fds-forked-all
[265.766952] Subtest basic-fds-forked-all: SUCCESS (21.592s)
[265.978673] [051/133] (761s left) api_intel_bb (full-batch)
[266.043022] Starting subtest: full-batch
[266.053184] Subtest full-batch: SUCCESS (0.013s)
[266.188431] [052/133] (760s left) kms_cursor_crc (cursor-sliding-256x85)
[266.432764] Starting subtest: cursor-sliding-256x85
[266.477813] Subtest cursor-sliding-256x85: SKIP (0.043s)
[266.682838] [053/133] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[266.784891] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[266.787184] Starting dynamic subtest: pipe-A-eDP-1
[266.844484] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[266.854087] Starting dynamic subtest: pipe-B-eDP-1
[266.908583] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[266.918850] Starting dynamic subtest: pipe-C-eDP-1
[266.965015] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[266.974366] Starting dynamic subtest: pipe-D-eDP-1
[267.021533] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[267.025000] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[269.054154] [054/133] (758s left) gen9_exec_parse (allowed-single)
[269.107537] Subtest allowed-single: SKIP (0.000s)
[269.176756] [055/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[269.278708] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[276.319863] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.041s)
[276.480403] [056/133] (750s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[276.574811] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[276.579161] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[276.691507] [057/133] (750s left) gem_exec_fence (expired-history)
[277.221823] Starting subtest: expired-history
[284.469911] Subtest expired-history: SUCCESS (7.247s)
[286.154942] [058/133] (741s left) kms_psr (fbc-psr-sprite-plane-move)
[286.262710] Starting subtest: fbc-psr-sprite-plane-move
[286.264919] Starting dynamic subtest: eDP-1
[286.269210] Dynamic subtest eDP-1: SKIP (0.000s)
[286.273491] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[286.359841] [059/133] (741s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[286.457357] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[293.344922] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.886s)
[293.492321] [060/133] (733s left) gem_ctx_bad_destroy (double-destroy)
[293.543928] Starting subtest: double-destroy
[293.546412] Subtest double-destroy: SUCCESS (0.000s)
[293.647211] [061/133] (733s left) syncobj_timeline (invalid-signal-illegal-handle)
[293.702572] Starting subtest: invalid-signal-illegal-handle
[293.705076] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[293.832134] [062/133] (733s left) kms_chamelium_hpd (common-hpd-after-suspend)
[294.206908] Subtest common-hpd-after-suspend: SKIP (0.000s)
[294.990429] [063/133] (732s left) kms_frontbuffer_tracking (fbc-tiling-4)
[295.090906] Starting subtest: fbc-tiling-4
[299.394245] Subtest fbc-tiling-4: SUCCESS (4.305s)
[300.556638] [064/133] (727s left) gem_cs_tlb (engines)
[300.622859] Starting subtest: engines
[300.625275] Starting dynamic subtest: rcs0
[302.779011] Dynamic subtest rcs0: SUCCESS (2.151s)
[302.792316] Starting dynamic subtest: bcs0
[304.931512] Dynamic subtest bcs0: SUCCESS (2.152s)
[304.942844] Starting dynamic subtest: vcs0
[307.084901] Dynamic subtest vcs0: SUCCESS (2.152s)
[307.096874] Starting dynamic subtest: vcs1
[309.236886] Dynamic subtest vcs1: SUCCESS (2.151s)
[309.246992] Starting dynamic subtest: vecs0
[311.390322] Dynamic subtest vecs0: SUCCESS (2.151s)
[311.402345] Starting dynamic subtest: ccs0
[313.544259] Dynamic subtest ccs0: SUCCESS (2.152s)
[313.546797] Subtest engines: SUCCESS (12.915s)
[313.705155] [065/133] (713s left) gem_mmap_gtt (hang-busy)
[313.758473] Subtest hang-busy: SKIP (0.000s)
[313.827468] [066/133] (713s left) kms_psr (psr2-sprite-plane-onoff)
[313.933182] Starting subtest: psr2-sprite-plane-onoff
[313.935453] Starting dynamic subtest: eDP-1
[315.664515] Dynamic subtest eDP-1: SUCCESS (1.729s)
[315.666433] Subtest psr2-sprite-plane-onoff: SUCCESS (1.731s)
[316.520217] [067/133] (711s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[316.630431] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[317.254722] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[317.454262] [068/133] (710s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[317.555289] Starting subtest: y-tiled-64bpp-rotate-270
[317.559631] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[317.673464] [069/133] (710s left) gem_bad_reloc (negative-reloc-lut)
[317.737357] Subtest negative-reloc-lut: SKIP (0.000s)
[317.803343] [070/133] (710s left) gem_ctx_persistence (engines-mixed)
[317.876590] Starting subtest: engines-mixed
[317.878628] Starting dynamic subtest: rcs0
[317.986481] Dynamic subtest rcs0: SUCCESS (0.111s)
[317.998567] Starting dynamic subtest: bcs0
[318.055529] Dynamic subtest bcs0: SUCCESS (0.067s)
[318.067778] Starting dynamic subtest: vcs0
[318.138531] Dynamic subtest vcs0: SUCCESS (0.081s)
[318.151576] Starting dynamic subtest: vcs1
[318.219485] Dynamic subtest vcs1: SUCCESS (0.080s)
[318.231867] Starting dynamic subtest: vecs0
[318.300537] Dynamic subtest vecs0: SUCCESS (0.078s)
[318.313637] Starting dynamic subtest: ccs0
[318.372091] Dynamic subtest ccs0: SUCCESS (0.069s)
[318.374351] Subtest engines-mixed: SUCCESS (0.499s)
[318.478641] [071/133] (709s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[318.569397] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[318.571330] Starting dynamic subtest: pipe-A
[318.632844] Dynamic subtest pipe-A: SUCCESS (0.065s)
[318.645265] Starting dynamic subtest: pipe-B
[319.819770] Dynamic subtest pipe-B: SUCCESS (1.184s)
[319.831334] Starting dynamic subtest: pipe-C
[320.934197] Dynamic subtest pipe-C: SUCCESS (1.113s)
[320.943265] Starting dynamic subtest: pipe-D
[322.055434] Dynamic subtest pipe-D: SUCCESS (1.120s)
[322.057679] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.487s)
[323.253247] [072/133] (704s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[323.360174] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[323.364179] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.485291] [073/133] (704s left) gem_exec_schedule (semaphore-noskip)
[323.560000] Starting subtest: semaphore-noskip
[323.973156] Subtest semaphore-noskip: SUCCESS (0.419s)
[324.330450] [074/133] (703s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[324.431633] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[324.435795] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[324.548786] [075/133] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[324.659763] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[324.664150] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[324.795444] [076/133] (703s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[324.896854] Starting subtest: 4-tiled-16bpp-rotate-0
[326.132303] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.235s)
[326.297482] [077/133] (701s left) gem_exec_basic (basic)
[326.364536] Starting subtest: basic
[326.366542] Starting dynamic subtest: rcs0-smem
[326.368377] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[326.378521] Starting dynamic subtest: bcs0-smem
[326.380570] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[326.390358] Starting dynamic subtest: vcs0-smem
[326.391902] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[326.399840] Starting dynamic subtest: vcs1-smem
[326.401369] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[326.409521] Starting dynamic subtest: vecs0-smem
[326.411082] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[326.419267] Starting dynamic subtest: ccs0-smem
[326.420798] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[326.422302] Subtest basic: SUCCESS (0.016s)
[327.823060] [078/133] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[327.917966] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[327.922136] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[328.037311] [079/133] (700s left) gem_mmap (short-mmap)
[328.102463] Subtest short-mmap: SKIP (0.000s)
[328.166236] [080/133] (700s left) gem_exec_reloc (basic-gtt-wc-active)
[328.233959] Subtest basic-gtt-wc-active: SKIP (0.000s)
[328.309418] [081/133] (700s left) gem_ctx_shared (create-shared-gtt)
[328.381351] Starting subtest: create-shared-gtt
[330.534225] Subtest create-shared-gtt: SUCCESS (2.154s)
[330.968993] [082/133] (697s left) gem_exec_reloc (basic-write-wc)
[331.030839] Subtest basic-write-wc: SKIP (0.000s)
[331.120408] [083/133] (697s left) gem_eio (wait-immediate)
[331.378598] Starting subtest: wait-immediate
[331.808237] Subtest wait-immediate: SUCCESS (0.429s)
[331.996101] [084/133] (696s left) gem_ctx_persistence (legacy-engines-mixed)
[332.058248] Starting subtest: legacy-engines-mixed
[332.060318] Starting dynamic subtest: render
[332.175942] Dynamic subtest render: SUCCESS (0.116s)
[332.190222] Starting dynamic subtest: bsd1
[332.263715] Dynamic subtest bsd1: SUCCESS (0.085s)
[332.278297] Starting dynamic subtest: bsd2
[332.348993] Dynamic subtest bsd2: SUCCESS (0.082s)
[332.360788] Starting dynamic subtest: blt
[332.425963] Dynamic subtest blt: SUCCESS (0.074s)
[332.437783] Starting dynamic subtest: vebox
[332.491737] Dynamic subtest vebox: SUCCESS (0.063s)
[332.494239] Subtest legacy-engines-mixed: SUCCESS (0.434s)
[332.596451] [085/133] (695s left) perf_pmu (semaphore-busy)
[332.631774] Starting subtest: semaphore-busy
[332.634234] Starting dynamic subtest: rcs0
[334.296316] Dynamic subtest rcs0: SUCCESS (1.659s)
[334.308862] Starting dynamic subtest: bcs0
[335.930289] Dynamic subtest bcs0: SUCCESS (1.630s)
[335.942613] Starting dynamic subtest: vcs0
[340.235638] Dynamic subtest vcs0: SUCCESS (4.303s)
[340.248315] Starting dynamic subtest: vcs1
[346.248456] Dynamic subtest vcs1: SUCCESS (6.012s)
[346.260848] Starting dynamic subtest: vecs0
[352.266517] Dynamic subtest vecs0: SUCCESS (6.016s)
[352.278895] Starting dynamic subtest: ccs0
[355.339290] Dynamic subtest ccs0: SUCCESS (3.071s)
[355.342049] Subtest semaphore-busy: SUCCESS (22.708s)
[355.479283] [086/133] (673s left) gem_exec_schedule (pi-common)
[355.677664] Starting subtest: pi-common
[355.679961] Starting dynamic subtest: rcs0
[355.719099] Dynamic subtest rcs0: SUCCESS (0.045s)
[355.728931] Starting dynamic subtest: bcs0
[355.762427] Dynamic subtest bcs0: SUCCESS (0.042s)
[355.772200] Starting dynamic subtest: vcs0
[355.799295] Dynamic subtest vcs0: SUCCESS (0.036s)
[355.809140] Starting dynamic subtest: vcs1
[355.842113] Dynamic subtest vcs1: SUCCESS (0.041s)
[355.852655] Starting dynamic subtest: vecs0
[355.874246] Dynamic subtest vecs0: SUCCESS (0.031s)
[355.884128] Starting dynamic subtest: ccs0
[355.907206] Dynamic subtest ccs0: SUCCESS (0.031s)
[355.909489] Subtest pi-common: SUCCESS (0.234s)
[356.163775] [087/133] (672s left) i915_hangman (engine-error-state-capture)
[356.243484] Starting subtest: engine-error-state-capture
[356.245740] Starting dynamic subtest: rcs0
[359.723661] Dynamic subtest rcs0: SUCCESS (3.479s)
[359.736413] Starting dynamic subtest: bcs0
[365.740566] Dynamic subtest bcs0: SUCCESS (6.015s)
[365.753133] Starting dynamic subtest: vcs0
[370.732262] Dynamic subtest vcs0: SUCCESS (4.989s)
[370.745095] Starting dynamic subtest: vcs1
[376.683361] Dynamic subtest vcs1: SUCCESS (5.949s)
[376.696267] Starting dynamic subtest: vecs0
[382.700208] Dynamic subtest vecs0: SUCCESS (6.014s)
[382.712740] Starting dynamic subtest: ccs0
[388.716388] Dynamic subtest ccs0: SUCCESS (6.013s)
[388.719438] Subtest engine-error-state-capture: SUCCESS (32.476s)
[388.822227] [088/133] (639s left) syncobj_timeline (wait-for-submit-snapshot)
[388.892468] Starting subtest: wait-for-submit-snapshot
[388.973397] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[389.087641] [089/133] (639s left) kms_color (ctm-blue-to-red)
[389.183973] Starting subtest: ctm-blue-to-red
[389.186279] Starting dynamic subtest: pipe-A-eDP-1
[389.874897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s)
[389.887652] Starting dynamic subtest: pipe-B-eDP-1
[391.297387] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[391.308392] Starting dynamic subtest: pipe-C-eDP-1
[392.669494] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[392.680093] Starting dynamic subtest: pipe-D-eDP-1
[394.050369] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.377s)
[394.052276] Subtest ctm-blue-to-red: SUCCESS (4.865s)
[394.875452] [090/133] (633s left) prime_vgem (basic-gtt)
[394.961737] Starting subtest: basic-gtt
[394.966439] Subtest basic-gtt: SKIP (0.000s)
[395.111523] [091/133] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[395.220250] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[402.677600] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.459s)
[402.840449] [092/133] (625s left) api_intel_allocator (default-alignment)
[402.901340] Starting subtest: default-alignment
[402.903727] Subtest default-alignment: SUCCESS (0.003s)
[403.066348] [093/133] (625s left) i915_pm_rps (fence-order)
[403.138268] Starting subtest: fence-order
[406.593797] Subtest fence-order: SUCCESS (3.454s)
[406.764562] [094/133] (622s left) kms_vblank (query-busy)
[406.871924] Starting subtest: query-busy
[406.874157] Starting dynamic subtest: pipe-A-eDP-1
[408.745776] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[408.761471] Starting dynamic subtest: pipe-D-eDP-1
[411.341094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[411.343052] Subtest query-busy: SUCCESS (4.468s)
[412.160182] [095/133] (616s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[412.254544] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[412.258566] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[412.389664] [096/133] (616s left) kms_addfb_basic (invalid-get-prop-any)
[412.447605] Starting subtest: invalid-get-prop-any
[412.449743] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[412.603419] [097/133] (616s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[412.699108] Starting subtest: fbc-psr2-cursor-mmap-gtt
[412.701218] Starting dynamic subtest: eDP-1
[412.704823] Dynamic subtest eDP-1: SKIP (0.000s)
[412.708684] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[412.800292] [098/133] (616s left) kms_flip (2x-blocking-absolute-wf_vblank)
[412.894773] Starting subtest: 2x-blocking-absolute-wf_vblank
[412.903251] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[413.048305] [099/133] (616s left) kms_cursor_crc (cursor-onscreen-256x85)
[413.309270] Starting subtest: cursor-onscreen-256x85
[413.356293] Subtest cursor-onscreen-256x85: SKIP (0.044s)
[413.578376] [100/133] (615s left) kms_flip (2x-modeset-vs-vblank-race)
[413.666335] Starting subtest: 2x-modeset-vs-vblank-race
[413.675782] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[413.808617] [101/133] (615s left) kms_atomic_interruptible (atomic-setmode)
[413.909601] Starting subtest: atomic-setmode
[413.911512] Starting dynamic subtest: pipe-A-eDP-1
[420.816317] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.907s)
[420.818661] Subtest atomic-setmode: SUCCESS (6.908s)
[421.717403] [102/133] (607s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[421.821912] Starting subtest: psr-argb161616f-draw-render
[421.825772] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[421.955132] [103/133] (607s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[422.051409] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[422.055839] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[422.193048] [104/133] (607s left) kms_plane_scaling (invalid-num-scalers)
[422.298099] Starting subtest: invalid-num-scalers
[422.300214] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[422.316090] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[422.326299] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[422.350297] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[422.360628] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[422.383120] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[422.392706] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[422.417174] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[422.419411] Subtest invalid-num-scalers: SUCCESS (0.121s)
[422.552252] [105/133] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[422.650324] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[422.653726] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[422.777396] [106/133] (606s left) sw_sync (alloc_fence_invalid_timeline)
[422.817002] Starting subtest: alloc_fence_invalid_timeline
[422.819012] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[422.897983] [107/133] (606s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[422.967285] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[423.074275] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[423.175524] [108/133] (606s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[423.274024] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[423.276612] Starting dynamic subtest: A-eDP1
[432.139515] Dynamic subtest A-eDP1: SUCCESS (8.866s)
[432.151783] Starting dynamic subtest: B-eDP1
[441.077735] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[441.088160] Starting dynamic subtest: C-eDP1
[450.001693] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[450.014738] Starting dynamic subtest: D-eDP1
[458.937849] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[458.944001] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.668s)
[460.178135] [109/133] (569s left) kms_addfb_basic (size-max)
[460.269883] Starting subtest: size-max
[460.272123] Subtest size-max: SUCCESS (0.000s)
[460.414016] [110/133] (569s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[460.661651] Starting subtest: cursor-rapid-movement-256x256
[460.666423] Starting dynamic subtest: pipe-A-eDP-1
[461.196568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[461.226062] Starting dynamic subtest: pipe-D-eDP-1
[462.444559] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[462.447012] Subtest cursor-rapid-movement-256x256: SUCCESS (1.783s)
[463.331655] [111/133] (566s left) gem_exec_whisper (basic-queues-all)
[463.407670] Starting subtest: basic-queues-all
[472.684912] Subtest basic-queues-all: SUCCESS (9.276s)
[472.895118] [112/133] (556s left) kms_dsc (dsc-fractional-bpp)
[472.996872] Starting subtest: dsc-fractional-bpp
[473.009687] Subtest dsc-fractional-bpp: SKIP (0.001s)
[473.093055] [113/133] (556s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[473.174184] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[473.176356] Starting dynamic subtest: pipe-A-default-mode
[473.464791] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[473.469397] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.289s)
[474.357956] [114/133] (555s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[474.459840] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[474.464644] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[474.584224] [115/133] (555s left) gem_softpin (evict-prime)
[474.636783] Starting subtest: evict-prime
[474.639111] Starting dynamic subtest: rcs0
[475.823521] Dynamic subtest rcs0: SUCCESS (1.185s)
[475.837105] Starting dynamic subtest: bcs0
[476.986839] Dynamic subtest bcs0: SUCCESS (1.161s)
[476.999112] Starting dynamic subtest: vcs0
[478.774423] Dynamic subtest vcs0: SUCCESS (1.784s)
[478.792069] Starting dynamic subtest: vcs1
[480.748531] Dynamic subtest vcs1: SUCCESS (1.971s)
[480.762412] Starting dynamic subtest: vecs0
[482.800019] Dynamic subtest vecs0: SUCCESS (2.048s)
[482.813100] Starting dynamic subtest: ccs0
[483.948103] Dynamic subtest ccs0: SUCCESS (1.147s)
[483.961117] Starting dynamic subtest: all
[485.730314] Dynamic subtest all: SUCCESS (1.779s)
[485.732952] Subtest evict-prime: SUCCESS (11.091s)
[485.837086] [116/133] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[485.953655] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[485.957869] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[486.095858] [117/133] (543s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[486.186620] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[486.324084] [118/133] (543s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[486.389124] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[486.490420] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[486.591763] [119/133] (543s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[486.704368] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[486.708575] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[486.851338] [120/133] (543s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[486.959632] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[491.030070] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.072s)
[492.260855] [121/133] (537s left) gem_mmap_wc (bad-size)
[492.328815] Subtest bad-size: SKIP (0.000s)
[492.394984] [122/133] (537s left) kms_hdr (static-toggle-suspend)
[492.501955] Starting subtest: static-toggle-suspend
[492.508605] Subtest static-toggle-suspend: SKIP (0.000s)
[492.603055] [123/133] (537s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[492.694494] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[492.698676] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[492.819710] [124/133] (537s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[497.803484] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[497.805866] Starting dynamic subtest: pipe-A-eDP-1
[498.591392] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s)
[498.602116] Starting dynamic subtest: pipe-B-eDP-1
[499.716472] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[499.720877] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.912s)
[500.916823] [125/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[501.023015] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[501.027196] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[501.167640] [126/133] (529s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[501.260217] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[501.262462] Starting dynamic subtest: pipe-A-eDP-1
[501.282993] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[501.295140] Starting dynamic subtest: pipe-B-eDP-1
[501.314862] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[501.326531] Starting dynamic subtest: pipe-C-eDP-1
[501.345287] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[501.355103] Starting dynamic subtest: pipe-D-eDP-1
[501.374471] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[501.376670] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[503.498502] [127/133] (526s left) syncobj_timeline (single-wait-all-available-submitted)
[503.551752] Starting subtest: single-wait-all-available-submitted
[503.554140] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[503.692806] [128/133] (526s left) gem_exec_parallel (userptr)
[503.757383] Starting subtest: userptr
[503.759644] Starting dynamic subtest: rcs0
[505.206748] Dynamic subtest rcs0: SUCCESS (1.451s)
[505.217621] Starting dynamic subtest: bcs0
[506.719620] Dynamic subtest bcs0: SUCCESS (1.509s)
[506.731335] Starting dynamic subtest: vcs0
[508.748433] Dynamic subtest vcs0: SUCCESS (2.027s)
[508.760081] Starting dynamic subtest: vcs1
[510.732513] Dynamic subtest vcs1: SUCCESS (1.981s)
[510.743496] Starting dynamic subtest: vecs0
[512.782471] Dynamic subtest vecs0: SUCCESS (2.046s)
[512.795496] Starting dynamic subtest: ccs0
[514.323112] Dynamic subtest ccs0: SUCCESS (1.540s)
[514.325525] Subtest userptr: SUCCESS (10.568s)
[514.538360] [129/133] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[514.656413] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[514.660591] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[514.794945] [130/133] (515s left) i915_selftest (mock)
[516.777889] Starting subtest: mock
[516.779978] Starting dynamic subtest: sanitycheck
[517.572280] Dynamic subtest sanitycheck: SUCCESS (0.797s)
[517.582566] Starting dynamic subtest: shmem
[518.297114] Dynamic subtest shmem: SUCCESS (0.723s)
[518.307846] Starting dynamic subtest: fence
[525.941445] Dynamic subtest fence: SUCCESS (7.640s)
[525.951652] Starting dynamic subtest: scatterlist
[527.653944] Dynamic subtest scatterlist: SUCCESS (1.710s)
[527.664099] Starting dynamic subtest: syncmap
[530.974058] Dynamic subtest syncmap: SUCCESS (3.317s)
[530.984649] Starting dynamic subtest: uncore
[531.745359] Dynamic subtest uncore: SUCCESS (0.769s)
[531.755179] Starting dynamic subtest: ring
[532.479195] Dynamic subtest ring: SUCCESS (0.732s)
[532.489804] Starting dynamic subtest: engine
[533.305224] Dynamic subtest engine: SUCCESS (0.824s)
[533.315117] Starting dynamic subtest: timelines
[537.279717] Dynamic subtest timelines: SUCCESS (3.971s)
[537.289560] Starting dynamic subtest: requests
[540.670426] Dynamic subtest requests: SUCCESS (3.387s)
[540.680879] Starting dynamic subtest: objects
[541.552574] Dynamic subtest objects: SUCCESS (0.881s)
[541.562641] Starting dynamic subtest: phys
[542.424468] Dynamic subtest phys: SUCCESS (0.869s)
[542.434659] Starting dynamic subtest: dmabuf
[543.338382] Dynamic subtest dmabuf: SUCCESS (0.888s)
[543.348764] Starting dynamic subtest: vma
[548.807097] Dynamic subtest vma: SUCCESS (5.489s)
[548.817219] Starting dynamic subtest: evict
[550.292109] Dynamic subtest evict: SUCCESS (1.483s)
[550.302267] Starting dynamic subtest: gtt
[553.556405] Dynamic subtest gtt: SUCCESS (3.261s)
[553.566600] Starting dynamic subtest: hugepages
[554.549592] Dynamic subtest hugepages: SUCCESS (0.991s)
[554.559983] Starting dynamic subtest: memory_region
[557.362819] Dynamic subtest memory_region: SUCCESS (2.811s)
[557.365734] Subtest mock: SUCCESS (40.580s)
[557.394608] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[557.395275] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[557.398602] [131/133] (473s left) gem_mmap_gtt (basic-write-read)
[558.904344] Subtest basic-write-read: SKIP (0.000s)
[559.008214] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[559.009436] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[559.013241] [132/133] (471s left) perf (gen12-group-exclusive-stream-sample-oa)
[559.173021] Starting subtest: gen12-group-exclusive-stream-sample-oa
[559.194802] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.023s)
[559.245633] [133/133] (471s left) perf_pmu (busy-double-start)
[559.287157] Starting subtest: busy-double-start
[559.289005] Starting dynamic subtest: rcs0
[562.934288] Dynamic subtest rcs0: FAIL (3.593s)
[562.944894] Starting dynamic subtest: bcs0
[566.459945] Dynamic subtest bcs0: SUCCESS (3.578s)
[566.471086] Starting dynamic subtest: vcs0
[570.300179] Dynamic subtest vcs0: SUCCESS (3.837s)
[570.312132] Starting dynamic subtest: vcs1
[574.325804] Dynamic subtest vcs1: SUCCESS (4.023s)
[574.337887] Starting dynamic subtest: vecs0
[578.304078] Dynamic subtest vecs0: SUCCESS (3.975s)
[578.315935] Starting dynamic subtest: ccs0
[581.938750] Dynamic subtest ccs0: FAIL (3.565s)
[581.940985] Subtest busy-double-start: FAIL (22.582s)
[582.026013] 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.