[58.451387] Initializing watchdogs
[58.451433]   /dev/watchdog0
[58.466526] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.471067] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.473436] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.476848] [001/133] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[58.590886] Starting subtest: primary-yf-tiled-reflect-x-180
[58.673078] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.081s)
[58.773695] [002/133] (960s left) kms_plane (plane-panning-top-left)
[58.864699] Starting subtest: plane-panning-top-left
[58.866688] Starting dynamic subtest: pipe-A
[60.579823] Dynamic subtest pipe-A: SUCCESS (1.699s)
[60.589083] Starting dynamic subtest: pipe-B
[62.939668] Dynamic subtest pipe-B: SUCCESS (2.348s)
[62.942048] Subtest plane-panning-top-left: SUCCESS (4.049s)
[63.754555] [003/133] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[63.853904] Starting subtest: psr-rgb565-draw-mmap-gtt
[63.858256] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[63.935588] [004/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[64.038400] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[64.042512] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[64.135640] [005/133] (954s left) gem_exec_reloc (basic-wc-active)
[64.203218] Subtest basic-wc-active: SKIP (0.000s)
[64.275377] [006/133] (954s left) gem_partial_pwrite_pread (write)
[64.335424] Subtest write: SKIP (0.000s)
[64.402943] [007/133] (954s left) kms_invalid_mode (bad-hsync-start)
[64.503098] Starting subtest: bad-hsync-start
[64.505416] Starting dynamic subtest: pipe-A-eDP-1
[64.787669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[64.796881] Starting dynamic subtest: pipe-B-eDP-1
[64.799081] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[64.805820] Starting dynamic subtest: pipe-C-eDP-1
[64.808110] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[64.814709] Starting dynamic subtest: pipe-D-eDP-1
[64.816978] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[64.819091] Subtest bad-hsync-start: SUCCESS (0.288s)
[65.587641] [008/133] (953s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[65.678328] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[65.680745] Starting dynamic subtest: pipe-A-eDP-1
[65.705342] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.714506] Starting dynamic subtest: pipe-B-eDP-1
[65.736372] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.743379] Starting dynamic subtest: pipe-C-eDP-1
[65.765233] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[65.772251] Starting dynamic subtest: pipe-D-eDP-1
[65.793822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[65.798183] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[67.965970] [009/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[68.111197] Subtest too-many-fences: SKIP (0.000s)
[68.173682] [010/133] (951s left) kms_content_protection (suspend-resume)
[68.314869] Starting subtest: suspend-resume
[68.319441] Subtest suspend-resume: SKIP (0.000s)
[68.425088] [011/133] (950s left) kms_cursor_legacy (torture-bo)
[68.555517] Starting subtest: torture-bo
[68.557931] Starting dynamic subtest: pipe-A
[74.641066] Dynamic subtest pipe-A: SUCCESS (6.071s)
[74.651883] Starting dynamic subtest: pipe-B
[81.702520] Dynamic subtest pipe-B: SUCCESS (7.055s)
[81.712452] Starting dynamic subtest: pipe-C
[89.219937] Dynamic subtest pipe-C: SUCCESS (7.512s)
[89.230620] Starting dynamic subtest: pipe-D
[95.868556] Dynamic subtest pipe-D: SUCCESS (6.645s)
[95.876272] Starting dynamic subtest: all-pipes
[102.240961] Dynamic subtest all-pipes: SUCCESS (6.367s)
[102.243649] Subtest torture-bo: SUCCESS (33.655s)
[102.393779] [012/133] (917s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[102.487284] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[102.491480] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[102.572570] [013/133] (916s left) core_setmaster (master-drop-set-user)
[102.649790] Starting subtest: master-drop-set-user
[102.664789] Subtest master-drop-set-user: SUCCESS (0.015s)
[102.700689] [014/133] (916s left) i915_selftest (live)
[104.415544] Starting subtest: live
[104.418020] Starting dynamic subtest: sanitycheck
[108.697064] Dynamic subtest sanitycheck: SUCCESS (4.280s)
[108.706105] Starting dynamic subtest: uncore
[111.371048] Dynamic subtest uncore: SUCCESS (2.673s)
[111.380193] Starting dynamic subtest: workarounds
[128.959206] Dynamic subtest workarounds: FAIL (17.320s)
[128.966400] Starting dynamic subtest: gt_engines
[133.213079] Dynamic subtest gt_engines: SUCCESS (4.517s)
[133.221326] Starting dynamic subtest: gt_timelines
[151.197846] Dynamic subtest gt_timelines: SUCCESS (17.983s)
[151.206687] Starting dynamic subtest: gt_contexts
[155.492797] Dynamic subtest gt_contexts: SUCCESS (4.294s)
[155.501590] Starting dynamic subtest: gt_lrc
[159.792021] Dynamic subtest gt_lrc: SUCCESS (4.298s)
[159.800866] Starting dynamic subtest: gt_mocs
[164.207865] Dynamic subtest gt_mocs: SUCCESS (4.415s)
[164.216627] Starting dynamic subtest: gt_pm
[170.983513] Dynamic subtest gt_pm: SUCCESS (6.774s)
[170.996452] Starting dynamic subtest: gt_heartbeat
[175.286103] Dynamic subtest gt_heartbeat: SUCCESS (4.302s)
[175.294621] Starting dynamic subtest: gt_tlb
[184.615757] Dynamic subtest gt_tlb: SUCCESS (9.329s)
[184.625321] Starting dynamic subtest: requests
[198.061059] Dynamic subtest requests: SUCCESS (13.443s)
[198.071826] Starting dynamic subtest: migrate
[203.805651] Dynamic subtest migrate: SUCCESS (5.742s)
[203.814605] Starting dynamic subtest: active
[208.119856] Dynamic subtest active: SUCCESS (4.314s)
[208.129066] Starting dynamic subtest: objects
[212.814300] Dynamic subtest objects: SUCCESS (4.692s)
[212.823083] Starting dynamic subtest: mman
[217.630959] Dynamic subtest mman: SUCCESS (4.815s)
[217.639568] Starting dynamic subtest: dmabuf
[221.984566] Dynamic subtest dmabuf: SUCCESS (4.353s)
[221.993218] Starting dynamic subtest: vma
[226.304699] Dynamic subtest vma: SUCCESS (4.319s)
[226.312762] Starting dynamic subtest: coherency
[231.809643] Dynamic subtest coherency: SUCCESS (5.504s)
[231.818202] Starting dynamic subtest: gtt
[241.654273] Dynamic subtest gtt: SUCCESS (9.843s)
[241.663089] Starting dynamic subtest: gem
[247.593358] Dynamic subtest gem: SUCCESS (5.938s)
[247.602428] Starting dynamic subtest: evict
[251.639354] Dynamic subtest evict: SUCCESS (4.044s)
[251.648392] Starting dynamic subtest: hugepages
[260.516769] Dynamic subtest hugepages: SUCCESS (8.875s)
[260.525684] Starting dynamic subtest: gem_contexts
[289.646349] Dynamic subtest gem_contexts: SUCCESS (29.127s)
[289.654046] Starting dynamic subtest: client
[294.018407] Dynamic subtest client: SUCCESS (4.371s)
[294.026614] Starting dynamic subtest: gem_migrate
[298.348938] Dynamic subtest gem_migrate: SUCCESS (4.328s)
[298.357599] Starting dynamic subtest: reset
[301.103993] Dynamic subtest reset: SUCCESS (2.753s)
[301.115161] Starting dynamic subtest: memory_region
[305.402524] Dynamic subtest memory_region: SUCCESS (4.297s)
[305.411319] Starting dynamic subtest: hangcheck
[318.368835] Dynamic subtest hangcheck: SUCCESS (12.965s)
[318.378629] Starting dynamic subtest: execlists
[322.671534] Dynamic subtest execlists: SUCCESS (4.301s)
[322.679250] Starting dynamic subtest: ring_submission
[326.961935] Dynamic subtest ring_submission: SUCCESS (4.288s)
[326.971267] Starting dynamic subtest: perf
[331.232903] Dynamic subtest perf: SUCCESS (4.269s)
[331.240672] Starting dynamic subtest: slpc
[345.259853] Dynamic subtest slpc: SUCCESS (14.024s)
[345.267627] Starting dynamic subtest: guc
[349.159346] Dynamic subtest guc: SUCCESS (3.897s)
[349.167135] Starting dynamic subtest: guc_multi_lrc
[353.461972] Dynamic subtest guc_multi_lrc: SUCCESS (4.300s)
[353.471214] Starting dynamic subtest: guc_hang
[358.315633] Dynamic subtest guc_hang: SUCCESS (4.852s)
[358.324960] Starting dynamic subtest: late_gt_pm
[362.622878] Dynamic subtest late_gt_pm: SUCCESS (4.305s)
[362.625804] Subtest live: FAIL (258.191s)
[362.659098] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[362.662401] [015/133] (656s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[364.246214] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[364.248673] Starting dynamic subtest: pipe-A
[364.346731] Dynamic subtest pipe-A: SUCCESS (0.102s)
[364.356679] Starting dynamic subtest: pipe-B
[365.494555] Dynamic subtest pipe-B: SUCCESS (1.146s)
[365.504603] Starting dynamic subtest: pipe-C
[366.600292] Dynamic subtest pipe-C: SUCCESS (1.104s)
[366.607631] Starting dynamic subtest: pipe-D
[367.731129] Dynamic subtest pipe-D: SUCCESS (1.130s)
[367.733339] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.487s)
[368.870428] [FACT kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)] new: kernel.kmod_is_loaded.i915: true
[368.874358] [016/133] (650s left) gen7_exec_parse (basic-rejected)
[368.945126] Subtest basic-rejected: SKIP (0.000s)
[369.016165] [017/133] (650s left) gem_exec_schedule (u-semaphore-noskip)
[369.080211] Starting subtest: u-semaphore-noskip
[369.484309] Subtest u-semaphore-noskip: SUCCESS (0.410s)
[369.837572] [018/133] (649s left) kms_rmfb (close-fd)
[369.938410] Starting subtest: close-fd
[369.940656] Starting dynamic subtest: pipe-A-eDP-1
[370.046445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[370.055126] Starting dynamic subtest: pipe-B-eDP-1
[371.262851] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.213s)
[371.271998] Starting dynamic subtest: pipe-C-eDP-1
[372.397057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.135s)
[372.405541] Starting dynamic subtest: pipe-D-eDP-1
[373.533365] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[373.535748] Subtest close-fd: SUCCESS (3.596s)
[374.734341] [019/133] (644s left) api_intel_bb (object-noreloc-purge-cache-simple)
[374.788910] Starting subtest: object-noreloc-purge-cache-simple
[374.793675] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[374.906702] [020/133] (644s left) vgem_basic (sysfs)
[374.971686] Starting subtest: sysfs
[374.973887] Subtest sysfs: SUCCESS (0.000s)
[375.025333] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[375.028632] [021/133] (644s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[375.121785] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[375.124072] Starting dynamic subtest: A-eDP1
[384.090968] Dynamic subtest A-eDP1: SUCCESS (8.967s)
[384.101884] Starting dynamic subtest: B-eDP1
[393.034807] Dynamic subtest B-eDP1: SUCCESS (8.941s)
[393.042429] Starting dynamic subtest: C-eDP1
[401.956083] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[401.965607] Starting dynamic subtest: D-eDP1
[410.791118] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[410.796897] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.672s)
[412.014679] [022/133] (607s left) kms_cursor_crc (cursor-offscreen-32x10)
[412.179969] Starting subtest: cursor-offscreen-32x10
[412.224797] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[412.482907] [023/133] (607s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[412.580811] Starting subtest: stress-xrgb8888-ytiled
[412.585266] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[412.652928] [024/133] (607s left) gem_mmap_offset (partial-remap)
[412.706072] Starting subtest: partial-remap
[412.708264] Starting dynamic subtest: smem0
[412.716785] Dynamic subtest smem0: SUCCESS (0.004s)
[412.718967] Subtest partial-remap: SUCCESS (0.005s)
[412.830476] [025/133] (607s left) gen7_exec_parse (basic-allocation)
[412.884337] Subtest basic-allocation: SKIP (0.000s)
[412.950435] [026/133] (607s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[413.037104] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[413.040762] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[413.107758] [027/133] (606s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[413.203527] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[414.228170] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.023s)
[414.369686] [028/133] (605s left) syncobj_basic (illegal-fd-to-handle)
[414.421704] Starting subtest: illegal-fd-to-handle
[414.423523] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[414.514427] [029/133] (605s left) gem_flink_race (flink_name)
[414.553318] Starting subtest: flink_name
[419.961953] Subtest flink_name: SUCCESS (5.402s)
[420.074532] [030/133] (600s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[420.192774] Starting subtest: cursorB-vs-flipA-atomic
[420.197704] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[420.351454] [031/133] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[420.453807] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[420.457846] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[420.568137] [032/133] (599s left) gem_exec_reloc (basic-wc-read-noreloc)
[420.633372] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[420.708547] [033/133] (599s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[420.802102] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[420.804212] Starting dynamic subtest: pipe-A-eDP-1
[420.823693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[420.832282] Starting dynamic subtest: pipe-B-eDP-1
[420.851301] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[420.859112] Starting dynamic subtest: pipe-C-eDP-1
[420.877926] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[420.885685] Starting dynamic subtest: pipe-D-eDP-1
[420.905049] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[420.907201] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[423.083239] [034/133] (597s left) kms_legacy_colorkey (invalid-plane)
[423.170191] Starting subtest: invalid-plane
[423.172510] Starting dynamic subtest: zero-id
[423.174706] Dynamic subtest zero-id: SUCCESS (0.000s)
[423.183098] Starting dynamic subtest: outrange-id
[423.185091] Dynamic subtest outrange-id: SUCCESS (0.000s)
[423.186964] Subtest invalid-plane: SUCCESS (0.001s)
[423.255791] [035/133] (597s left) kms_dsc (dsc-with-bpc)
[423.346516] Starting subtest: dsc-with-bpc
[423.376202] Subtest dsc-with-bpc: SKIP (0.001s)
[423.433109] [036/133] (596s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[423.523718] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[427.128815] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.609s)
[428.283485] [037/133] (592s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[428.343222] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[428.449838] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[428.538241] [038/133] (591s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[428.639265] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[428.641751] Starting dynamic subtest: pipe-A-eDP-1
[428.738639] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[428.747176] Starting dynamic subtest: pipe-B-eDP-1
[429.850579] Dynamic subtest pipe-B-eDP-1: SKIP (1.110s)
[429.855296] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.213s)
[431.054948] [039/133] (589s left) api_intel_allocator (reserve-simple)
[431.121882] Starting subtest: reserve-simple
[431.123797] Subtest reserve-simple: SUCCESS (0.003s)
[431.233683] [040/133] (589s left) gem_exec_params (no-bsd)
[431.286890] Starting subtest: no-bsd
[431.289194] Subtest no-bsd: SUCCESS (0.002s)
[432.980431] [041/133] (587s left) syncobj_wait (wait-for-submit-snapshot)
[433.030387] Starting subtest: wait-for-submit-snapshot
[433.111048] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[433.190286] [042/133] (587s left) gem_ctx_persistence (hang)
[433.254916] Starting subtest: hang
[433.259388] Subtest hang: SKIP (0.000s)
[433.357179] [043/133] (587s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[433.456169] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[433.458449] Starting dynamic subtest: pipe-A-eDP-1
[433.517837] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[433.527266] Starting dynamic subtest: pipe-B-eDP-1
[433.584137] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[433.592326] Starting dynamic subtest: pipe-C-eDP-1
[433.650649] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[433.660352] Starting dynamic subtest: pipe-D-eDP-1
[433.718103] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[433.722568] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[435.705397] [044/133] (585s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[435.764225] Starting subtest: invalid-multi-wait-unsubmitted
[435.766677] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[435.850265] [045/133] (584s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[435.951193] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[435.955160] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[436.060929] [046/133] (584s left) syncobj_wait (invalid-reset-zero-handles)
[436.134668] Starting subtest: invalid-reset-zero-handles
[436.137070] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[436.247223] [047/133] (584s left) gem_madvise (dontneed-before-exec)
[436.285554] Starting subtest: dontneed-before-exec
[436.309713] Subtest dontneed-before-exec: SKIP (0.021s)
[436.371847] [048/133] (584s left) perf (stress-open-close)
[436.507215] Starting subtest: stress-open-close
[436.509078] Starting dynamic subtest: 0-rcs0
[438.674948] Dynamic subtest 0-rcs0: SUCCESS (2.170s)
[438.682715] Starting dynamic subtest: 1-vecs0
[440.841222] Dynamic subtest 1-vecs0: SUCCESS (2.165s)
[440.843116] Subtest stress-open-close: SUCCESS (4.337s)
[440.895588] [049/133] (580s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[441.000964] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[441.103893] [050/133] (579s left) gem_ctx_persistence (engines-mixed)
[441.173142] Starting subtest: engines-mixed
[441.175336] Starting dynamic subtest: rcs0
[441.248446] Dynamic subtest rcs0: SUCCESS (0.075s)
[441.259433] Starting dynamic subtest: bcs0
[441.300247] Dynamic subtest bcs0: SUCCESS (0.050s)
[441.308204] Starting dynamic subtest: vcs0
[441.349114] Dynamic subtest vcs0: SUCCESS (0.047s)
[441.360420] Starting dynamic subtest: vcs1
[441.398424] Dynamic subtest vcs1: SUCCESS (0.048s)
[441.407166] Starting dynamic subtest: vecs0
[441.451467] Dynamic subtest vecs0: SUCCESS (0.051s)
[441.460062] Starting dynamic subtest: ccs0
[441.497009] Dynamic subtest ccs0: SUCCESS (0.044s)
[441.499100] Subtest engines-mixed: SUCCESS (0.325s)
[441.586531] [051/133] (579s left) kms_vrr (flip-suspend)
[441.680464] Starting subtest: flip-suspend
[441.685816] Subtest flip-suspend: SKIP (0.000s)
[441.751040] [052/133] (579s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[441.945491] Starting subtest: cursor-rapid-movement-128x128
[441.950721] Starting dynamic subtest: pipe-A-eDP-1
[442.501099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[442.532174] Starting dynamic subtest: pipe-D-eDP-1
[443.724542] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[443.726891] Subtest cursor-rapid-movement-128x128: SUCCESS (1.778s)
[444.581105] [053/133] (576s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[444.640207] Starting subtest: wait-all-for-submit-delayed-submit
[444.744971] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[444.820729] [054/133] (576s left) gem_exec_fence (submit-chain)
[444.998180] Starting subtest: submit-chain
[445.015707] Subtest submit-chain: SUCCESS (0.018s)
[447.019754] [055/133] (574s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[447.117319] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[453.777517] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.662s)
[453.917566] [056/133] (567s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[454.009674] Starting subtest: fbc-rgb101010-draw-mmap-wc
[458.599726] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.594s)
[459.716048] [057/133] (561s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[459.812427] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[459.816739] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[459.904778] [058/133] (561s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[460.024458] Starting subtest: basic-busy-flip-before-cursor-varying-size
[460.029016] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[460.170098] [059/133] (561s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[460.257614] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[467.614310] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.359s)
[467.728920] [060/133] (553s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[467.819355] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[467.823349] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[467.907981] [061/133] (553s left) kms_properties (crtc-properties-atomic)
[467.989732] Starting subtest: crtc-properties-atomic
[467.992042] Starting dynamic subtest: pipe-A-eDP-1
[468.422492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[468.432432] Starting dynamic subtest: pipe-B-eDP-1
[469.618551] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[469.630246] Starting dynamic subtest: pipe-C-eDP-1
[470.745199] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[470.754265] Starting dynamic subtest: pipe-D-eDP-1
[471.887429] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[471.889772] Subtest crtc-properties-atomic: SUCCESS (3.899s)
[472.684312] [062/133] (548s left) gem_exec_balancer (bonded-true-hang)
[472.949865] Starting subtest: bonded-true-hang
[472.954945] Subtest bonded-true-hang: SKIP (0.000s)
[473.052409] [063/133] (548s left) kms_plane (pixel-format-yf-tiled-modifier)
[473.143176] Starting subtest: pixel-format-yf-tiled-modifier
[473.147124] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[473.221764] [064/133] (548s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[473.325751] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[473.329790] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[473.444849] [065/133] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[473.550228] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[473.554260] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[473.634744] [066/133] (547s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[473.733130] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[474.524646] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.793s)
[474.683868] [067/133] (546s left) gem_exec_suspend (basic)
[474.750714] Starting subtest: basic
[474.752984] Starting dynamic subtest: smem
[475.925514] Dynamic subtest smem: SUCCESS (1.173s)
[475.928893] Subtest basic: SUCCESS (1.175s)
[476.118175] [068/133] (545s left) kms_chamelium_frames (hdmi-frame-dump)
[476.505806] Subtest hdmi-frame-dump: SKIP (0.000s)
[477.295398] [069/133] (544s left) syncobj_timeline (multi-wait-all-signaled)
[477.359911] Starting subtest: multi-wait-all-signaled
[477.362338] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[477.461334] [070/133] (544s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[477.559081] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[477.563354] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[477.653359] [071/133] (544s left) gem_exec_flush (basic-uc-ro-default)
[477.722691] Starting subtest: basic-uc-ro-default
[483.183244] Subtest basic-uc-ro-default: SUCCESS (5.460s)
[483.374273] [072/133] (538s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[483.428819] Starting subtest: invalid-multi-wait-all-unsubmitted
[483.431078] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[483.517867] [073/133] (538s left) kms_color (invalid-ctm-matrix-sizes)
[483.609690] Starting subtest: invalid-ctm-matrix-sizes
[483.611996] Starting dynamic subtest: pipe-A
[483.614303] Dynamic subtest pipe-A: SUCCESS (0.002s)
[483.623356] Starting dynamic subtest: pipe-B
[483.625649] Dynamic subtest pipe-B: SUCCESS (0.003s)
[483.633411] Starting dynamic subtest: pipe-C
[483.635333] Dynamic subtest pipe-C: SUCCESS (0.004s)
[483.643467] Starting dynamic subtest: pipe-D
[483.645699] Dynamic subtest pipe-D: SUCCESS (0.004s)
[483.648019] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[483.706654] [074/133] (538s left) gem_exec_big (single)
[483.783739] Starting subtest: single
[487.471491] Subtest single: FAIL (3.628s)
[487.517522] [075/133] (534s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[487.672222] Starting subtest: fbc-modesetfrombusy
[491.394222] Subtest fbc-modesetfrombusy: SUCCESS (3.726s)
[492.578866] [076/133] (529s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[492.677067] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[492.678894] Starting dynamic subtest: pipe-A-eDP-1
[493.422163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[493.431533] Starting dynamic subtest: pipe-B-eDP-1
[495.198476] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.774s)
[495.208404] Starting dynamic subtest: pipe-C-eDP-1
[497.035736] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.836s)
[497.044092] Starting dynamic subtest: pipe-D-eDP-1
[498.880340] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.843s)
[498.882346] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.196s)
[500.007667] [077/133] (522s left) kms_atomic (plane-invalid-params)
[500.116390] Starting subtest: plane-invalid-params
[500.118722] Starting dynamic subtest: pipe-A-eDP-1
[500.559985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[500.562373] Subtest plane-invalid-params: SUCCESS (0.445s)
[501.432488] [078/133] (520s left) gem_spin_batch (resubmit-all)
[501.505663] Starting subtest: resubmit-all
[501.508111] Starting dynamic subtest: rcs0
[501.518427] Dynamic subtest rcs0: SUCCESS (0.012s)
[501.533173] Starting dynamic subtest: bcs0
[501.535557] Dynamic subtest bcs0: SUCCESS (0.003s)
[501.543928] Starting dynamic subtest: vcs0
[501.545806] Dynamic subtest vcs0: SUCCESS (0.003s)
[501.553878] Starting dynamic subtest: vcs1
[501.555704] Dynamic subtest vcs1: SUCCESS (0.003s)
[501.563635] Starting dynamic subtest: vecs0
[501.565525] Dynamic subtest vecs0: SUCCESS (0.002s)
[501.573526] Starting dynamic subtest: ccs0
[501.575419] Dynamic subtest ccs0: SUCCESS (0.002s)
[501.577315] Subtest resubmit-all: SUCCESS (0.032s)
[502.980952] [079/133] (519s left) gem_exec_params (invalid-fence-in-submit)
[503.039072] Starting subtest: invalid-fence-in-submit
[503.044766] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[503.166655] [080/133] (519s left) kms_psr (fbc-pr-cursor-blt)
[503.254933] Starting subtest: fbc-pr-cursor-blt
[503.259120] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[503.328470] [081/133] (518s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[503.422045] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[503.426165] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[503.509950] [082/133] (518s left) kms_flip (absolute-wf_vblank-interruptible)
[503.613960] Starting subtest: absolute-wf_vblank-interruptible
[503.616181] Starting dynamic subtest: A-eDP1
[512.289898] Dynamic subtest A-eDP1: SUCCESS (8.673s)
[512.301424] Starting dynamic subtest: B-eDP1
[521.028075] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[521.037934] Starting dynamic subtest: C-eDP1
[529.747198] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[529.759573] Starting dynamic subtest: D-eDP1
[538.474984] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[538.480157] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.864s)
[539.699319] [083/133] (482s left) kms_vrr (flip-basic)
[539.794750] Starting subtest: flip-basic
[539.801401] Subtest flip-basic: SKIP (0.000s)
[539.867975] [084/133] (482s left) kms_flip (2x-flip-vs-expired-vblank)
[539.964196] Starting subtest: 2x-flip-vs-expired-vblank
[539.973027] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[540.054906] [085/133] (482s left) syncobj_wait (invalid-reset-one-illegal-handle)
[540.121673] Starting subtest: invalid-reset-one-illegal-handle
[540.124069] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[540.208555] [086/133] (482s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[540.262924] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[540.370063] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[540.459455] [087/133] (482s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[540.561529] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[540.566019] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[540.646732] [088/133] (481s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[540.748076] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[540.750252] Starting dynamic subtest: pipe-A-eDP-1
[540.759260] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[540.768789] Starting dynamic subtest: pipe-B-eDP-1
[540.777723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[540.787162] Starting dynamic subtest: pipe-C-eDP-1
[540.795527] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[540.803696] Starting dynamic subtest: pipe-D-eDP-1
[540.812055] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[540.816051] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[543.076816] [089/133] (479s left) i915_hangman (engine-engine-hang)
[543.139334] Starting subtest: engine-engine-hang
[543.141705] Starting dynamic subtest: rcs0
[544.886211] Dynamic subtest rcs0: SUCCESS (1.746s)
[544.898643] Starting dynamic subtest: bcs0
[546.868332] Dynamic subtest bcs0: SUCCESS (1.979s)
[546.880606] Starting dynamic subtest: vcs0
[548.851255] Dynamic subtest vcs0: SUCCESS (1.980s)
[548.863189] Starting dynamic subtest: vcs1
[550.835897] Dynamic subtest vcs1: SUCCESS (1.982s)
[550.848030] Starting dynamic subtest: vecs0
[552.884647] Dynamic subtest vecs0: SUCCESS (2.046s)
[552.896764] Starting dynamic subtest: ccs0
[554.868028] Dynamic subtest ccs0: SUCCESS (1.980s)
[554.871072] Subtest engine-engine-hang: SUCCESS (11.730s)
[554.965558] [090/133] (467s left) gem_mmap_gtt (basic-small-copy-odd)
[555.029442] Subtest basic-small-copy-odd: SKIP (0.000s)
[555.085366] [091/133] (467s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[555.200705] Starting subtest: y-tiled-32bpp-rotate-90
[555.205222] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[555.301307] [092/133] (467s left) kms_psr (fbc-psr-sprite-blt)
[555.397187] Starting subtest: fbc-psr-sprite-blt
[555.399433] Starting dynamic subtest: eDP-1
[555.403440] Dynamic subtest eDP-1: SKIP (0.000s)
[555.407530] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[555.472357] [093/133] (467s left) gem_lmem_swapping (massive-random)
[555.520420] Subtest massive-random: SKIP (0.000s)
[555.570144] [094/133] (467s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[555.685864] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[555.690418] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[555.788357] [095/133] (467s left) gem_mmap_gtt (big-copy)
[555.841740] Subtest big-copy: SKIP (0.000s)
[555.906839] [096/133] (467s left) gem_exec_reloc (basic-gtt-cpu-active)
[555.970256] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[556.042344] [097/133] (466s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[556.151051] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[557.141669] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.991s)
[557.275197] [098/133] (465s left) gem_exec_reloc (basic-wc-cpu-active)
[557.341675] Subtest basic-wc-cpu-active: SKIP (0.000s)
[557.426611] [099/133] (465s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[557.511861] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[561.491914] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.983s)
[562.673409] [100/133] (460s left) syncobj_wait (wait-all-interrupted)
[562.732539] Starting subtest: wait-all-interrupted
[562.834081] Subtest wait-all-interrupted: SUCCESS (0.102s)
[562.911670] [101/133] (460s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[563.000642] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[563.005031] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[563.097223] [102/133] (460s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[563.204037] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[563.208115] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[563.321408] [103/133] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[563.421702] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[570.723880] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.306s)
[570.863291] [104/133] (452s left) gem_create (hog-create)
[570.921913] Starting subtest: hog-create
[570.924096] Starting dynamic subtest: smem0
[604.884856] Dynamic subtest smem0: SUCCESS (33.961s)
[604.887355] Subtest hog-create: SUCCESS (33.962s)
[605.076102] [105/133] (418s left) i915_pm_rps (fence-order)
[605.126743] Starting subtest: fence-order
[608.602116] Subtest fence-order: SUCCESS (3.474s)
[608.717412] [106/133] (414s left) kms_psr (psr-primary-blt)
[608.835127] Starting subtest: psr-primary-blt
[608.837449] Starting dynamic subtest: eDP-1
[610.567695] Dynamic subtest eDP-1: SUCCESS (1.730s)
[610.569820] Subtest psr-primary-blt: SUCCESS (1.731s)
[611.436430] [107/133] (411s left) gem_exec_schedule (pi-common)
[611.614672] Starting subtest: pi-common
[611.616774] Starting dynamic subtest: rcs0
[611.652705] Dynamic subtest rcs0: SUCCESS (0.039s)
[611.661963] Starting dynamic subtest: bcs0
[611.693994] Dynamic subtest bcs0: SUCCESS (0.040s)
[611.703137] Starting dynamic subtest: vcs0
[611.728222] Dynamic subtest vcs0: SUCCESS (0.033s)
[611.737237] Starting dynamic subtest: vcs1
[611.758934] Dynamic subtest vcs1: SUCCESS (0.030s)
[611.771142] Starting dynamic subtest: vecs0
[611.788400] Dynamic subtest vecs0: SUCCESS (0.029s)
[611.801269] Starting dynamic subtest: ccs0
[611.816576] Dynamic subtest ccs0: SUCCESS (0.027s)
[611.818723] Subtest pi-common: SUCCESS (0.204s)
[612.045560] [108/133] (411s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[612.162303] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[612.166211] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[612.246388] [109/133] (411s left) gem_exec_store (dword)
[612.307062] Starting subtest: dword
[612.308916] Starting dynamic subtest: rcs0
[612.372597] Dynamic subtest rcs0: SUCCESS (0.067s)
[612.384828] Starting dynamic subtest: bcs0
[612.413519] Dynamic subtest bcs0: SUCCESS (0.038s)
[612.429401] Starting dynamic subtest: vcs0
[612.459053] Dynamic subtest vcs0: SUCCESS (0.043s)
[612.470681] Starting dynamic subtest: vcs1
[612.500466] Dynamic subtest vcs1: SUCCESS (0.039s)
[612.510530] Starting dynamic subtest: vecs0
[612.541092] Dynamic subtest vecs0: SUCCESS (0.039s)
[612.551078] Starting dynamic subtest: ccs0
[612.583868] Dynamic subtest ccs0: SUCCESS (0.040s)
[612.586231] Subtest dword: SUCCESS (0.279s)
[612.774588] [110/133] (410s left) kms_pm_dc (dc5-dpms-negative)
[613.868854] Starting subtest: dc5-dpms-negative
[613.873089] Subtest dc5-dpms-negative: SKIP (0.000s)
[613.953097] [111/133] (409s left) gem_mmap_gtt (basic-read-write-distinct)
[614.018445] Subtest basic-read-write-distinct: SKIP (0.000s)
[614.081063] [112/133] (409s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[614.182677] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[614.186653] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[614.264427] [113/133] (409s left) gem_render_copy (yf-tiled)
[614.312526] Starting subtest: yf-tiled
[614.316828] Subtest yf-tiled: SKIP (0.000s)
[614.496019] [114/133] (409s left) kms_pm_rpm (legacy-planes)
[616.013975] Starting subtest: legacy-planes
[616.016047] Starting dynamic subtest: plane-65
[624.318869] Dynamic subtest plane-65: SUCCESS (8.306s)
[624.331708] Starting dynamic subtest: plane-95
[632.737219] Dynamic subtest plane-95: SUCCESS (8.416s)
[632.749149] Starting dynamic subtest: plane-125
[641.034504] Dynamic subtest plane-125: SUCCESS (8.295s)
[641.045166] Starting dynamic subtest: plane-135
[649.345494] Dynamic subtest plane-135: SUCCESS (8.309s)
[649.348451] Subtest legacy-planes: SUCCESS (33.334s)
[649.743428] [115/133] (374s left) perf_pmu (gt-awake)
[649.785957] Starting subtest: gt-awake
[658.904115] Subtest gt-awake: SUCCESS (9.116s)
[659.002086] [116/133] (364s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[659.124669] Starting subtest: 2x-long-cursor-vs-flip-legacy
[659.129336] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[659.296556] [117/133] (364s left) kms_psr (pr-sprite-mmap-gtt)
[659.390246] Starting subtest: pr-sprite-mmap-gtt
[659.394573] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[659.464603] [118/133] (364s left) kms_psr (fbc-psr2-no-drrs)
[659.557086] Starting subtest: fbc-psr2-no-drrs
[659.559410] Starting dynamic subtest: eDP-1
[659.563733] Dynamic subtest eDP-1: SKIP (0.000s)
[659.568147] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[659.634333] [119/133] (364s left) i915_drm_fdinfo (virtual-busy)
[659.677143] Starting subtest: virtual-busy
[659.681597] Subtest virtual-busy: SKIP (0.000s)
[659.745460] [120/133] (364s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[659.840376] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[659.844512] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[659.942578] [121/133] (364s left) kms_vblank (query-busy-hang)
[660.039236] Starting subtest: query-busy-hang
[660.041075] Starting dynamic subtest: pipe-A-eDP-1
[686.678819] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.637s)
[686.693616] Starting dynamic subtest: pipe-D-eDP-1
[711.713656] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.031s)
[711.715885] Subtest query-busy-hang: SUCCESS (51.672s)
[712.602183] [122/133] (311s left) gem_ctx_shared (single-timeline)
[712.671782] Starting subtest: single-timeline
[712.693143] Subtest single-timeline: SUCCESS (0.015s)
[712.938907] [123/133] (311s left) kms_psr (psr2-primary-page-flip)
[713.035887] Starting subtest: psr2-primary-page-flip
[713.038211] Starting dynamic subtest: eDP-1
[714.783573] Dynamic subtest eDP-1: SUCCESS (1.746s)
[714.785548] Subtest psr2-primary-page-flip: SUCCESS (1.747s)
[715.655717] [124/133] (308s left) syncobj_timeline (wait-zero-handles)
[715.713945] Starting subtest: wait-zero-handles
[715.716252] Subtest wait-zero-handles: SUCCESS (0.000s)
[715.831478] [125/133] (308s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[715.919626] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[723.336299] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.420s)
[723.474730] [126/133] (300s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[723.875568] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[724.688773] [127/133] (299s left) dumb_buffer (map-uaf)
[724.747296] Starting subtest: map-uaf
[724.749526] Subtest map-uaf: SUCCESS (0.005s)
[724.854321] [128/133] (299s left) kms_atomic_transition (plane-all-modeset-transition)
[724.954381] Starting subtest: plane-all-modeset-transition
[724.958786] Subtest plane-all-modeset-transition: SKIP (0.000s)
[725.027427] [129/133] (299s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[725.083247] Starting subtest: yf-tiled-ccs-to-y-tiled
[725.087472] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[725.271549] [130/133] (299s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[725.323841] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[725.325940] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[725.415567] [131/133] (299s left) syncobj_timeline (wait-all-for-submit-complex)
[725.461584] Starting subtest: wait-all-for-submit-complex
[725.675033] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[725.766662] [132/133] (298s left) gem_pxp (fail-invalid-protected-context)
[725.891888] Starting subtest: fail-invalid-protected-context
[725.894190] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[726.009873] [133/133] (298s left) gem_mmap_gtt (fault-concurrent-x)
[726.067065] Subtest fault-concurrent-X: SKIP (0.000s)
[726.130504] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_partial_pwrite_pread
results: parsing output: 6/ for test: kms_invalid_mode
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_fenced_exec_thrash
results: parsing output: 9/ for test: kms_content_protection
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: core_setmaster
results: parsing output: 13/ for test: i915_selftest
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: gen7_exec_parse
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_rmfb
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_pipe_stress
results: parsing output: 23/ for test: gem_mmap_offset
results: parsing output: 24/ for test: gen7_exec_parse
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_basic
results: parsing output: 28/ for test: gem_flink_race
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_legacy_colorkey
results: parsing output: 34/ for test: kms_dsc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: gem_madvise
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_vrr
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: kms_properties
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_exec_suspend
results: parsing output: 67/ for test: kms_chamelium_frames
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_exec_flush
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: gem_exec_big
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: gem_spin_batch
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: i915_hangman
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_create
results: parsing output: 104/ for test: i915_pm_rps
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_store
results: parsing output: 109/ for test: kms_pm_dc
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: gem_ctx_shared
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: dumb_buffer
results: parsing output: 127/ for test: kms_atomic_transition
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: gem_mmap_gtt
Done.