[56.655025] Initializing watchdogs
[56.655075]   /dev/watchdog0
[56.670490] [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.675146] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.677512] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.680831] [001/156] (960s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[56.802587] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[56.806715] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[56.908750] [002/156] (960s left) sw_sync (sync_multi_producer_single_consumer)
[56.939846] Starting subtest: sync_multi_producer_single_consumer
[58.015665] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[58.078047] [003/156] (959s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[58.172218] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[58.174484] Starting dynamic subtest: pipe-A-eDP-1
[59.098265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s)
[59.108445] Starting dynamic subtest: pipe-B-eDP-1
[60.769789] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.668s)
[60.778210] Starting dynamic subtest: pipe-C-eDP-1
[62.308245] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.539s)
[62.318815] Starting dynamic subtest: pipe-D-eDP-1
[63.842426] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[63.844909] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.663s)
[65.293033] [004/156] (951s left) gem_fence_thrash (bo-write-verify-x)
[65.330844] Starting subtest: bo-write-verify-x
[65.349129] Subtest bo-write-verify-x: SKIP (0.015s)
[65.411012] [005/156] (951s left) gem_pxp (reject-modify-context-protection-on)
[65.547577] Starting subtest: reject-modify-context-protection-on
[65.550281] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[65.664905] [006/156] (951s left) kms_psr (fbc-psr-primary-blt)
[65.753027] Starting subtest: fbc-psr-primary-blt
[65.755427] Starting dynamic subtest: eDP-1
[65.759777] Dynamic subtest eDP-1: SKIP (0.000s)
[65.764296] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[65.835989] [007/156] (951s left) gem_ctx_persistence (hostile)
[65.888976] Starting subtest: hostile
[76.033706] Subtest hostile: SUCCESS (10.140s)
[76.153151] [008/156] (941s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[76.263869] Starting subtest: psr-rgb101010-draw-mmap-cpu
[83.401197] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.143s)
[83.502288] [009/156] (933s left) i915_drm_fdinfo (busy)
[83.549766] Starting subtest: busy
[83.551938] Starting dynamic subtest: rcs0
[83.580181] Dynamic subtest rcs0: SKIP (0.030s)
[83.588148] Starting dynamic subtest: bcs0
[83.592583] Dynamic subtest bcs0: SKIP (0.001s)
[83.600074] Starting dynamic subtest: vcs0
[83.604221] Dynamic subtest vcs0: SKIP (0.001s)
[83.611478] Starting dynamic subtest: vcs1
[83.615983] Dynamic subtest vcs1: SKIP (0.000s)
[83.623169] Starting dynamic subtest: vecs0
[83.627645] Dynamic subtest vecs0: SKIP (0.000s)
[83.634874] Starting dynamic subtest: ccs0
[83.639340] Dynamic subtest ccs0: SKIP (0.000s)
[83.643850] Subtest busy: SKIP (0.035s)
[83.677193] [010/156] (933s left) gem_exec_whisper (basic-fds-forked)
[83.732615] Starting subtest: basic-fds-forked
[107.837913] Subtest basic-fds-forked: SUCCESS (24.102s)
[108.022977] [011/156] (909s left) kms_addfb_basic (addfb25-4-tiled)
[108.136108] Starting subtest: addfb25-4-tiled
[108.138082] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[108.238846] [012/156] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[108.338701] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[115.801993] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.468s)
[115.899646] [013/156] (901s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[116.006644] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[116.010641] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[116.107098] [014/156] (901s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[116.216666] Starting subtest: fbc-rgb565-draw-mmap-cpu
[120.349746] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.139s)
[121.484739] [015/156] (896s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[121.598096] Starting subtest: y-tiled-64bpp-rotate-0
[121.602245] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[121.707779] [016/156] (896s left) kms_flip (2x-flip-vs-wf_vblank)
[121.810056] Starting subtest: 2x-flip-vs-wf_vblank
[121.819805] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[121.892766] [017/156] (895s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[121.997872] Starting subtest: fbcpsr-shrfb-scaledprimary
[127.789419] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.797s)
[127.931418] [018/156] (889s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[128.033383] Starting subtest: psr2-overlay-plane-move-continuous-sf
[128.035616] Starting dynamic subtest: pipe-A-eDP-1
[134.012391] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.981s)
[134.020391] Starting dynamic subtest: pipe-B-eDP-1
[140.694592] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.682s)
[140.696492] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.665s)
[141.565149] [019/156] (876s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[141.617891] Starting subtest: invalid-single-wait-unsubmitted
[141.620152] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[141.707172] [020/156] (876s left) kms_rmfb (rmfb-ioctl)
[141.798150] Starting subtest: rmfb-ioctl
[141.800099] Starting dynamic subtest: pipe-A-eDP-1
[141.904756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[141.915181] Starting dynamic subtest: pipe-B-eDP-1
[143.133101] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.228s)
[143.150475] Starting dynamic subtest: pipe-C-eDP-1
[144.364317] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.228s)
[144.374860] Starting dynamic subtest: pipe-D-eDP-1
[145.588488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[145.590615] Subtest rmfb-ioctl: SUCCESS (3.793s)
[146.812168] [021/156] (871s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[146.911592] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[146.915915] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[147.006950] [022/156] (870s left) gem_exec_fence (basic-wait-all)
[147.075277] Starting subtest: basic-wait-all
[147.159049] Subtest basic-wait-all: SUCCESS (0.084s)
[149.393632] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[149.398046] [023/156] (868s left) gem_exec_reloc (basic-active)
[149.466975] Subtest basic-active: SKIP (0.000s)
[149.547073] [024/156] (868s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[149.655611] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[156.677500] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.025s)
[156.814579] [025/156] (861s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[156.902934] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[156.905216] Starting dynamic subtest: pipe-A-eDP-1
[156.927608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.937991] Starting dynamic subtest: pipe-B-eDP-1
[156.958919] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.966940] Starting dynamic subtest: pipe-C-eDP-1
[156.987716] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.998336] Starting dynamic subtest: pipe-D-eDP-1
[157.020554] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[157.024679] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[159.192244] [026/156] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[159.284960] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[159.289214] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[159.390207] [027/156] (858s left) kms_force_connector_basic (force-edid)
[159.469942] Starting subtest: force-edid
[159.785650] Subtest force-edid: SUCCESS (0.318s)
[159.930357] [028/156] (858s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[160.025342] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[160.027596] Starting dynamic subtest: pipe-A-eDP-1
[160.085885] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[160.093825] Starting dynamic subtest: pipe-B-eDP-1
[160.145831] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[160.154024] Starting dynamic subtest: pipe-C-eDP-1
[160.198111] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[160.205416] Starting dynamic subtest: pipe-D-eDP-1
[160.250061] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[160.253322] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[162.320359] [029/156] (855s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[162.417754] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[162.422226] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[162.516965] [030/156] (855s left) gem_exec_params (rsvd2-dirt)
[162.575707] Starting subtest: rsvd2-dirt
[162.579690] Subtest rsvd2-dirt: SKIP (0.000s)
[162.668741] [031/156] (855s left) gem_ctx_isolation (preservation-s3)
[162.743957] Starting subtest: preservation-S3
[162.746297] Starting dynamic subtest: rcs0
[179.349961] Dynamic subtest rcs0: SUCCESS (1.441s)
[179.361469] Starting dynamic subtest: bcs0
[195.348014] Dynamic subtest bcs0: SUCCESS (1.275s)
[195.359435] Starting dynamic subtest: vcs0
[211.342541] Dynamic subtest vcs0: SUCCESS (2.895s)
[211.354179] Starting dynamic subtest: vcs1
[229.347340] Dynamic subtest vcs1: SUCCESS (4.999s)
[229.357380] Starting dynamic subtest: vecs0
[247.359243] Dynamic subtest vecs0: SUCCESS (4.986s)
[247.368546] Starting dynamic subtest: ccs0
[265.342441] Dynamic subtest ccs0: SUCCESS (3.195s)
[265.344683] Subtest preservation-S3: SUCCESS (18.797s)
[265.568186] [032/156] (752s left) gem_exec_schedule (pi-shared-iova)
[265.758294] Starting subtest: pi-shared-iova
[265.760303] Starting dynamic subtest: rcs0
[265.843194] Dynamic subtest rcs0: SUCCESS (0.087s)
[265.855174] Starting dynamic subtest: vcs0
[265.910006] Dynamic subtest vcs0: SUCCESS (0.065s)
[265.922073] Starting dynamic subtest: vcs1
[265.970041] Dynamic subtest vcs1: SUCCESS (0.058s)
[265.984856] Starting dynamic subtest: vecs0
[266.020275] Dynamic subtest vecs0: SUCCESS (0.050s)
[266.032447] Starting dynamic subtest: ccs0
[266.080996] Dynamic subtest ccs0: SUCCESS (0.060s)
[266.083480] Subtest pi-shared-iova: SUCCESS (0.326s)
[267.218191] [033/156] (751s left) prime_mmap_kms (buffer-sharing)
[267.316282] Starting subtest: buffer-sharing
[267.775902] Subtest buffer-sharing: SUCCESS (0.458s)
[268.614344] [034/156] (749s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[268.710924] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[268.715198] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[268.801574] [035/156] (749s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[268.888745] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[268.891129] Starting dynamic subtest: pipe-A
[269.237531] Dynamic subtest pipe-A: SUCCESS (0.351s)
[269.248023] Starting dynamic subtest: pipe-B
[270.703750] Dynamic subtest pipe-B: SUCCESS (1.464s)
[270.713905] Starting dynamic subtest: pipe-C
[272.084214] Dynamic subtest pipe-C: SUCCESS (1.379s)
[272.093749] Starting dynamic subtest: pipe-D
[273.480634] Dynamic subtest pipe-D: SUCCESS (1.394s)
[273.482920] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.592s)
[274.717145] [036/156] (743s left) kms_psr (fbc-pr-cursor-plane-onoff)
[274.822855] Starting subtest: fbc-pr-cursor-plane-onoff
[274.827350] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[274.898143] [037/156] (743s left) vgem_basic (bad-handle)
[274.939251] Starting subtest: bad-handle
[274.941459] Subtest bad-handle: SUCCESS (0.000s)
[275.002088] [038/156] (743s left) gem_exec_reloc (basic-cpu-read)
[275.066600] Subtest basic-cpu-read: SKIP (0.000s)
[275.140284] [039/156] (743s left) kms_cursor_edge_walk (128x128-top-bottom)
[275.230457] Starting subtest: 128x128-top-bottom
[275.232695] Starting dynamic subtest: pipe-A-eDP-1
[278.664100] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.431s)
[278.676431] Starting dynamic subtest: pipe-D-eDP-1
[281.853686] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.188s)
[281.856085] Subtest 128x128-top-bottom: SUCCESS (6.622s)
[282.726439] [040/156] (736s left) kms_psr (psr2-cursor-plane-move)
[282.828447] Starting subtest: psr2-cursor-plane-move
[282.830558] Starting dynamic subtest: eDP-1
[284.593721] Dynamic subtest eDP-1: SUCCESS (1.762s)
[284.595623] Subtest psr2-cursor-plane-move: SUCCESS (1.763s)
[285.427559] [041/156] (733s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[285.521413] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[285.525783] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[285.615541] [042/156] (733s left) gem_create (create-ext-placement-each)
[285.785448] Starting subtest: create-ext-placement-each
[285.787695] Subtest create-ext-placement-each: SUCCESS (0.000s)
[285.897160] [043/156] (732s left) gem_exec_reloc (basic-cpu-gtt)
[285.950749] Subtest basic-cpu-gtt: SKIP (0.000s)
[286.022791] [044/156] (732s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[286.073242] Starting subtest: invalid-bsd2-flag-on-vebox
[286.075609] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[286.185104] [045/156] (732s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[286.284814] Starting subtest: hdr-indfb-scaledprimary
[286.289013] Subtest hdr-indfb-scaledprimary: SKIP (0.000s)
[286.381733] [046/156] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[286.489195] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[286.493665] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[286.596707] [047/156] (732s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[286.720836] Starting subtest: flip-vs-cursor-busy-crc-legacy
[287.445030] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.723s)
[288.323668] [048/156] (730s left) core_setmaster (master-drop-set-user)
[288.410979] Starting subtest: master-drop-set-user
[288.433509] Subtest master-drop-set-user: SUCCESS (0.025s)
[288.473548] [049/156] (730s left) gem_lmem_swapping (parallel-random-verify)
[288.512590] Subtest parallel-random-verify: SKIP (0.000s)
[288.558178] [050/156] (730s left) perf (gen12-oa-tlb-invalidate)
[288.673943] Starting subtest: gen12-oa-tlb-invalidate
[288.676188] Starting dynamic subtest: 0-rcs0
[298.726013] Dynamic subtest 0-rcs0: SUCCESS (10.050s)
[298.735750] Starting dynamic subtest: 1-vecs0
[308.771821] Dynamic subtest 1-vecs0: SUCCESS (10.050s)
[308.774408] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.103s)
[308.818336] [051/156] (710s left) gem_mmap_offset (clear-via-pagefault)
[308.877924] Starting subtest: clear-via-pagefault
[308.880124] Starting dynamic subtest: smem0
[344.823877] Dynamic subtest smem0: SUCCESS (35.941s)
[344.825937] Subtest clear-via-pagefault: SUCCESS (35.942s)
[344.954585] [052/156] (674s left) kms_invalid_mode (clock-too-high)
[345.059577] Starting subtest: clock-too-high
[345.061853] Starting dynamic subtest: pipe-A-eDP-1
[345.350714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[345.359712] Starting dynamic subtest: pipe-B-eDP-1
[345.363583] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[345.372551] Starting dynamic subtest: pipe-C-eDP-1
[345.376905] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[345.385973] Starting dynamic subtest: pipe-D-eDP-1
[345.390371] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[345.392620] Subtest clock-too-high: SUCCESS (0.298s)
[346.205777] [053/156] (673s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[346.299284] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[347.378247] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.079s)
[347.523586] [054/156] (671s left) gem_wait (busy)
[347.586337] Starting subtest: busy
[347.588408] Starting dynamic subtest: all-engines
[349.070039] Dynamic subtest all-engines: SUCCESS (1.481s)
[349.083604] Starting dynamic subtest: rcs0
[349.611584] Dynamic subtest rcs0: SUCCESS (0.540s)
[349.623308] Starting dynamic subtest: bcs0
[350.150919] Dynamic subtest bcs0: SUCCESS (0.538s)
[350.161910] Starting dynamic subtest: vcs0
[352.078660] Dynamic subtest vcs0: SUCCESS (1.925s)
[352.091166] Starting dynamic subtest: vcs1
[354.060997] Dynamic subtest vcs1: SUCCESS (1.980s)
[354.072676] Starting dynamic subtest: vecs0
[356.109090] Dynamic subtest vecs0: SUCCESS (2.045s)
[356.120346] Starting dynamic subtest: ccs0
[356.651695] Dynamic subtest ccs0: SUCCESS (0.541s)
[356.654282] Subtest busy: SUCCESS (9.064s)
[356.853694] [055/156] (662s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[356.903531] Starting subtest: invalid-single-wait-all-unsubmitted
[356.905913] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[357.009681] [056/156] (662s left) syncobj_wait (multi-wait-signaled)
[357.059611] Starting subtest: multi-wait-signaled
[357.061968] Subtest multi-wait-signaled: SUCCESS (0.000s)
[357.171151] [057/156] (662s left) gem_workarounds (reset-context)
[357.236027] Starting subtest: reset-context
[357.398070] Subtest reset-context: SUCCESS (0.162s)
[357.537665] [058/156] (661s left) kms_vblank (ts-continuation-modeset-rpm)
[357.631329] Starting subtest: ts-continuation-modeset-rpm
[357.633210] Starting dynamic subtest: pipe-A-eDP-1
[360.172768] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.541s)
[360.187120] Starting dynamic subtest: pipe-D-eDP-1
[362.352220] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.177s)
[362.354507] Subtest ts-continuation-modeset-rpm: SUCCESS (4.722s)
[363.222333] [059/156] (656s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[363.330062] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[363.334243] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[363.414046] [060/156] (656s left) syncobj_wait (reset-during-wait-for-submit)
[363.469695] Starting subtest: reset-during-wait-for-submit
[363.573220] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[363.664274] [061/156] (655s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[363.760575] Starting subtest: 4-tiled-64bpp-rotate-180
[365.440115] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.680s)
[365.596661] [062/156] (654s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[365.644074] Starting subtest: etime-multi-wait-all-for-submit-submitted
[365.744577] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[365.820821] [063/156] (653s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[365.963752] Starting subtest: dp-mst-lic-type-0-hdcp14
[365.967721] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[366.094716] [064/156] (653s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[366.223592] Starting subtest: cursorA-vs-flipB-varying-size
[366.227590] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[366.368605] [065/156] (653s left) kms_cursor_crc (cursor-sliding-256x256)
[366.613510] Starting subtest: cursor-sliding-256x256
[366.617582] Starting dynamic subtest: pipe-A-eDP-1
[370.625158] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.001s)
[370.660463] Starting dynamic subtest: pipe-D-eDP-1
[374.079626] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.428s)
[374.081487] Subtest cursor-sliding-256x256: SUCCESS (7.461s)
[374.924189] [066/156] (644s left) gem_exec_balancer (smoke)
[374.982126] Starting subtest: smoke
[397.576609] Subtest smoke: SUCCESS (22.590s)
[399.167702] [067/156] (620s left) gem_userptr_blits (stress-mm-invalidate-close)
[399.238784] Starting subtest: stress-mm-invalidate-close
[401.385898] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[401.515631] [068/156] (618s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[401.614939] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[405.184145] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.574s)
[406.329913] [069/156] (613s left) kms_flip (flip-vs-expired-vblank-interruptible)
[406.433379] Starting subtest: flip-vs-expired-vblank-interruptible
[406.435658] Starting dynamic subtest: A-eDP1
[415.090700] Dynamic subtest A-eDP1: SUCCESS (8.655s)
[415.103646] Starting dynamic subtest: B-eDP1
[423.784580] Dynamic subtest B-eDP1: SUCCESS (8.691s)
[423.798450] Starting dynamic subtest: C-eDP1
[432.466165] Dynamic subtest C-eDP1: SUCCESS (8.678s)
[432.478553] Starting dynamic subtest: D-eDP1
[441.167532] Dynamic subtest D-eDP1: SUCCESS (8.700s)
[441.172520] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.736s)
[442.426754] [070/156] (577s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[442.538955] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite
[442.543389] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[442.634977] [071/156] (577s left) prime_mmap (test_errors)
[442.678398] Starting subtest: test_errors
[442.680729] Starting dynamic subtest: test_errors-smem
[442.779838] Dynamic subtest test_errors-smem: SUCCESS (0.101s)
[442.782370] Subtest test_errors: SUCCESS (0.102s)
[442.868966] [072/156] (577s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[442.956403] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[442.958566] Starting dynamic subtest: pipe-A-default-mode
[445.678345] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[445.680574] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.723s)
[446.502962] [073/156] (573s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[446.597215] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[446.601504] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[446.697875] [074/156] (573s left) kms_plane_alpha_blend (constant-alpha-min)
[446.786703] Starting subtest: constant-alpha-min
[447.081058] Starting dynamic subtest: pipe-A-eDP-1
[447.785341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[447.795142] Starting dynamic subtest: pipe-D-eDP-1
[449.262941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.476s)
[449.265140] Subtest constant-alpha-min: SUCCESS (2.475s)
[450.110676] [075/156] (570s left) api_intel_bb (lot-of-buffers)
[450.178813] Starting subtest: lot-of-buffers
[451.186362] Subtest lot-of-buffers: SUCCESS (1.007s)
[451.722136] [076/156] (568s left) gem_exec_schedule (u-lateslice)
[451.787502] Starting subtest: u-lateslice
[451.789787] Starting dynamic subtest: rcs0
[451.797649] Dynamic subtest rcs0: SUCCESS (0.021s)
[451.809422] Starting dynamic subtest: bcs0
[451.816103] Dynamic subtest bcs0: SUCCESS (0.018s)
[451.825732] Starting dynamic subtest: vcs0
[451.836008] Dynamic subtest vcs0: SUCCESS (0.019s)
[451.845582] Starting dynamic subtest: vcs1
[451.855269] Dynamic subtest vcs1: SUCCESS (0.019s)
[451.865298] Starting dynamic subtest: vecs0
[451.875942] Dynamic subtest vecs0: SUCCESS (0.019s)
[451.885467] Starting dynamic subtest: ccs0
[451.895615] Dynamic subtest ccs0: SUCCESS (0.019s)
[451.897927] Subtest u-lateslice: SUCCESS (0.119s)
[453.159020] [077/156] (567s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[453.259791] Starting subtest: basic-max-pipe-crc-check
[453.264271] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[453.307066] [078/156] (567s left) kms_color (invalid-ctm-matrix-sizes)
[453.397387] Starting subtest: invalid-ctm-matrix-sizes
[453.399682] Starting dynamic subtest: pipe-A
[453.401581] Dynamic subtest pipe-A: SUCCESS (0.002s)
[453.411869] Starting dynamic subtest: pipe-B
[453.414189] Dynamic subtest pipe-B: SUCCESS (0.003s)
[453.424000] Starting dynamic subtest: pipe-C
[453.426332] Dynamic subtest pipe-C: SUCCESS (0.003s)
[453.436390] Starting dynamic subtest: pipe-D
[453.438320] Dynamic subtest pipe-D: SUCCESS (0.004s)
[453.440201] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[453.494951] [079/156] (566s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[453.598307] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[453.602736] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[453.706566] [080/156] (566s left) kms_scaling_modes (scaling-mode-center)
[453.799444] Starting subtest: scaling-mode-center
[453.801356] Starting dynamic subtest: pipe-A-eDP-1
[453.895508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[453.906488] Starting dynamic subtest: pipe-B-eDP-1
[455.100673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.204s)
[455.111846] Starting dynamic subtest: pipe-C-eDP-1
[456.274946] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.173s)
[456.285341] Starting dynamic subtest: pipe-D-eDP-1
[457.472478] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.196s)
[457.474844] Subtest scaling-mode-center: SUCCESS (3.676s)
[458.708814] [081/156] (561s left) kms_psr (psr-cursor-blt)
[458.806646] Starting subtest: psr-cursor-blt
[458.808882] Starting dynamic subtest: eDP-1
[460.577807] Dynamic subtest eDP-1: SUCCESS (1.771s)
[460.580109] Subtest psr-cursor-blt: SUCCESS (1.772s)
[461.408962] [082/156] (559s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[461.512208] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[461.516528] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[461.605346] [083/156] (558s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[461.662816] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[461.667005] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[461.861575] [084/156] (558s left) gem_softpin (softpin)
[461.913900] Starting subtest: softpin
[494.227039] Subtest softpin: SUCCESS (32.304s)
[494.339712] [085/156] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[494.448198] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[494.452461] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[494.550642] [086/156] (526s left) kms_chamelium_frames (dp-crc-multiple)
[494.933782] Subtest dp-crc-multiple: SKIP (0.000s)
[495.796529] [087/156] (524s left) gem_exec_balancer (bonded-false-hang)
[496.064129] Starting subtest: bonded-false-hang
[496.068924] Subtest bonded-false-hang: SKIP (0.000s)
[496.184357] [088/156] (524s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render)
[496.285098] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render
[496.289244] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[496.403669] [089/156] (524s left) gem_linear_blits (basic)
[496.821113] Starting subtest: basic
[496.832420] Subtest basic: SUCCESS (0.013s)
[496.962802] [090/156] (523s left) gem_exec_fence (submit)
[497.192704] Starting subtest: submit
[497.196852] Subtest submit: SKIP (0.000s)
[499.174824] [091/156] (521s left) gem_mmap (bad-size)
[499.233323] Subtest bad-size: SKIP (0.000s)
[499.304017] [092/156] (521s left) i915_drm_fdinfo (virtual-busy-idle-all)
[499.347960] Starting subtest: virtual-busy-idle-all
[499.352609] Subtest virtual-busy-idle-all: SKIP (0.000s)
[499.415688] [093/156] (521s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[499.474784] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[499.477142] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[499.551269] [094/156] (521s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[499.651107] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[499.653368] Starting dynamic subtest: pipe-A-eDP-1
[499.675718] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.689360] Starting dynamic subtest: pipe-B-eDP-1
[499.710699] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.720354] Starting dynamic subtest: pipe-C-eDP-1
[499.741933] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.751370] Starting dynamic subtest: pipe-D-eDP-1
[499.773433] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.777467] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[501.911432] [095/156] (519s left) kms_atomic (atomic-plane-damage)
[502.014541] Starting subtest: atomic-plane-damage
[502.111816] Starting dynamic subtest: pipe-A-eDP-1
[502.669897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[502.671847] Subtest atomic-plane-damage: SUCCESS (0.657s)
[503.511141] [096/156] (517s left) kms_cdclk (plane-scaling)
[503.618147] Starting subtest: plane-scaling
[503.620429] Starting dynamic subtest: pipe-A-eDP-1
[503.909793] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[503.925496] Starting dynamic subtest: pipe-B-eDP-1
[503.930318] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[503.940418] Starting dynamic subtest: pipe-C-eDP-1
[503.944876] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[503.954311] Starting dynamic subtest: pipe-D-eDP-1
[503.958417] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[503.962469] Subtest plane-scaling: SKIP (0.296s)
[504.711805] [097/156] (516s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[504.802468] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[504.828741] Starting dynamic subtest: pipe-A-plane-0
[505.119431] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[505.133965] Starting dynamic subtest: pipe-A-plane-3
[505.350678] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[505.364372] Starting dynamic subtest: pipe-A-plane-5
[505.368845] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[506.465176] Starting dynamic subtest: pipe-B-plane-0
[506.768312] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[506.778515] Starting dynamic subtest: pipe-B-plane-3
[507.000572] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[507.012956] Starting dynamic subtest: pipe-B-plane-5
[507.017338] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[507.317781] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.515s)
[508.208800] [098/156] (512s left) gem_shrink (reclaim)
[508.276737] Starting subtest: reclaim
[510.759790] Subtest reclaim: SUCCESS (2.484s)
[510.867080] [099/156] (510s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[510.975709] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[517.810658] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.838s)
[517.934758] [100/156] (503s left) kms_cursor_legacy (torture-bo)
[518.060836] Starting subtest: torture-bo
[518.063201] Starting dynamic subtest: pipe-A
[524.491734] Dynamic subtest pipe-A: SUCCESS (6.427s)
[524.506073] Starting dynamic subtest: pipe-B
[531.312932] Dynamic subtest pipe-B: SUCCESS (6.821s)
[531.330968] Starting dynamic subtest: pipe-C
[539.008772] Dynamic subtest pipe-C: SUCCESS (7.693s)
[539.035807] Starting dynamic subtest: pipe-D
[544.935391] Dynamic subtest pipe-D: SUCCESS (5.926s)
[544.948798] Starting dynamic subtest: all-pipes
[551.416333] Dynamic subtest all-pipes: SUCCESS (6.478s)
[551.418868] Subtest torture-bo: SUCCESS (33.356s)
[551.577956] [101/156] (469s left) gem_ctx_shared (exec-shared-gtt)
[551.631911] Starting subtest: exec-shared-gtt
[551.634315] Starting dynamic subtest: rcs0
[551.641126] Dynamic subtest rcs0: SUCCESS (0.009s)
[551.651559] Starting dynamic subtest: bcs0
[551.653834] Dynamic subtest bcs0: SUCCESS (0.009s)
[551.663766] Starting dynamic subtest: vcs0
[551.665666] Dynamic subtest vcs0: SUCCESS (0.006s)
[551.675307] Starting dynamic subtest: vcs1
[551.677502] Dynamic subtest vcs1: SUCCESS (0.007s)
[551.687335] Starting dynamic subtest: vecs0
[551.689552] Dynamic subtest vecs0: SUCCESS (0.007s)
[551.699067] Starting dynamic subtest: ccs0
[551.701270] Dynamic subtest ccs0: SUCCESS (0.010s)
[551.703536] Subtest exec-shared-gtt: SUCCESS (0.053s)
[551.886676] [102/156] (469s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[551.987389] Starting subtest: fbcpsrhdr-suspend
[551.991640] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[552.074577] [103/156] (469s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[552.165332] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[552.169551] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[552.262364] [104/156] (469s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[552.362380] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[552.366470] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[552.464463] [105/156] (469s left) kms_prop_blob (invalid-get-prop)
[552.512904] Starting subtest: invalid-get-prop
[552.514920] Subtest invalid-get-prop: SUCCESS (0.000s)
[552.640078] [106/156] (468s left) api_intel_allocator (alloc-simple)
[552.688379] Starting subtest: alloc-simple
[552.692231] Subtest alloc-simple: SUCCESS (0.003s)
[552.821131] [107/156] (468s left) kms_plane_scaling (2x-scaler-multi-pipe)
[552.921325] Starting subtest: 2x-scaler-multi-pipe
[552.924926] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[553.032099] [108/156] (468s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[553.125079] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[553.128490] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[553.230835] [109/156] (468s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-move)
[553.331543] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-move
[553.335104] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[553.443633] [110/156] (468s left) kms_feature_discovery (display-2x)
[553.528735] Starting subtest: display-2x
[553.532294] Subtest display-2x: SKIP (0.000s)
[553.617190] [111/156] (468s left) gem_ppgtt (shrink-vs-evict-pinned)
[553.668302] Starting subtest: shrink-vs-evict-pinned
[559.075892] Subtest shrink-vs-evict-pinned: SUCCESS (5.405s)
[559.171751] [112/156] (462s left) kms_pm_dc (dc6-psr)
[560.289020] Starting subtest: dc6-psr
[563.167755] Subtest dc6-psr: SUCCESS (2.878s)
[564.010806] [113/156] (457s left) syncobj_timeline (wait-all-complex)
[564.065427] Starting subtest: wait-all-complex
[564.279228] Subtest wait-all-complex: SUCCESS (0.213s)
[564.369370] [114/156] (457s left) perf_pmu (semaphore-busy)
[564.406488] Starting subtest: semaphore-busy
[564.408727] Starting dynamic subtest: rcs0
[566.046092] Dynamic subtest rcs0: SUCCESS (1.638s)
[566.059325] Starting dynamic subtest: bcs0
[567.680874] Dynamic subtest bcs0: SUCCESS (1.632s)
[567.694061] Starting dynamic subtest: vcs0
[571.593211] Dynamic subtest vcs0: SUCCESS (3.910s)
[571.606334] Starting dynamic subtest: vcs1
[577.609222] Dynamic subtest vcs1: SUCCESS (6.013s)
[577.622155] Starting dynamic subtest: vecs0
[583.625172] Dynamic subtest vecs0: SUCCESS (6.013s)
[583.638079] Starting dynamic subtest: ccs0
[586.700945] Dynamic subtest ccs0: SUCCESS (3.073s)
[586.703129] Subtest semaphore-busy: SUCCESS (22.294s)
[586.819224] [115/156] (435s left) i915_power (sanity)
[586.876093] Starting subtest: sanity
[586.880428] Subtest sanity: SKIP (0.000s)
[586.968297] [116/156] (434s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[587.060516] Starting subtest: sprite-rotation-90-pos-100-0
[587.065095] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[587.137046] [117/156] (434s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[587.248661] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[587.252833] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[587.347181] [118/156] (434s left) kms_psr (fbc-psr2-no-drrs)
[587.443106] Starting subtest: fbc-psr2-no-drrs
[587.445398] Starting dynamic subtest: eDP-1
[587.449551] Dynamic subtest eDP-1: SKIP (0.000s)
[587.453727] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[587.518844] [119/156] (434s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[587.618477] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[587.620737] Starting dynamic subtest: pipe-A-default-mode
[588.828549] Dynamic subtest pipe-A-default-mode: SKIP (1.209s)
[588.832858] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.210s)
[588.962860] [120/156] (433s left) gem_mmap (basic)
[589.017416] Subtest basic: SKIP (0.000s)
[589.072750] [121/156] (433s left) kms_setmode (basic)
[589.123490] Starting subtest: basic
[589.445786] Starting dynamic subtest: pipe-A-eDP-1
[591.589016] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.139s)
[591.939592] Starting dynamic subtest: pipe-B-eDP-1
[594.002774] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.067s)
[594.312392] Subtest basic: SUCCESS (5.186s)
[595.193879] [122/156] (426s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[595.287142] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[595.291379] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[595.380841] [123/156] (426s left) kms_big_fb (linear-16bpp-rotate-270)
[595.484835] Starting subtest: linear-16bpp-rotate-270
[595.504609] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[595.612653] [124/156] (426s left) kms_frontbuffer_tracking (fbchdr-stridechange)
[595.701325] Starting subtest: fbchdr-stridechange
[595.705337] Subtest fbchdr-stridechange: SKIP (0.000s)
[595.809994] [125/156] (426s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[595.902078] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[595.906436] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[595.991980] [126/156] (426s left) kms_flip (plain-flip-fb-recreate-interruptible)
[596.086661] Starting subtest: plain-flip-fb-recreate-interruptible
[596.088950] Starting dynamic subtest: A-eDP1
[604.948476] Dynamic subtest A-eDP1: SUCCESS (8.860s)
[604.959078] Starting dynamic subtest: B-eDP1
[613.767607] Dynamic subtest B-eDP1: SUCCESS (8.817s)
[613.781834] Starting dynamic subtest: C-eDP1
[622.645208] Dynamic subtest C-eDP1: SUCCESS (8.874s)
[622.656331] Starting dynamic subtest: D-eDP1
[631.452742] Dynamic subtest D-eDP1: SUCCESS (8.806s)
[631.457284] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.367s)
[632.603999] [127/156] (389s left) gem_exec_reloc (basic-cpu-wc)
[632.662111] Subtest basic-cpu-wc: SKIP (0.000s)
[632.750901] [128/156] (389s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-wc)
[632.845534] Starting subtest: psrhdr-rgb565-draw-mmap-wc
[632.849355] Subtest psrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[632.946146] [129/156] (389s left) kms_cursor_crc (cursor-offscreen-64x21)
[633.143648] Starting subtest: cursor-offscreen-64x21
[633.192425] Subtest cursor-offscreen-64x21: SKIP (0.043s)
[633.435733] [130/156] (389s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[633.525961] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[633.529559] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[633.618557] [131/156] (388s left) kms_atomic_interruptible (atomic-setmode)
[633.708082] Starting subtest: atomic-setmode
[633.710006] Starting dynamic subtest: pipe-A-eDP-1
[640.641035] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.930s)
[640.643389] Subtest atomic-setmode: SUCCESS (6.932s)
[641.515183] [132/156] (381s left) gem_exec_reloc (basic-gtt-noreloc)
[641.573471] Subtest basic-gtt-noreloc: SKIP (0.000s)
[641.666370] [133/156] (380s left) gem_userptr_blits (map-fixed-invalidate)
[641.740925] Starting subtest: map-fixed-invalidate
[641.745089] Subtest map-fixed-invalidate: SKIP (0.000s)
[641.870552] [134/156] (380s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[641.969248] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[648.951746] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.988s)
[649.100662] [135/156] (373s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[649.193434] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[649.197396] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[649.309347] [136/156] (373s left) fbdev (info)
[649.345511] Starting subtest: info
[649.347837] Subtest info: SUCCESS (0.000s)
[649.428012] [137/156] (373s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[649.520819] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[649.525002] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[649.642598] [138/156] (373s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[649.736339] Starting subtest: primary-x-tiled-reflect-x-180
[656.652626] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.918s)
[657.883538] [139/156] (365s left) kms_sequence (get-forked-busy)
[657.980422] Starting subtest: get-forked-busy
[657.982737] Starting dynamic subtest: pipe-A-eDP-1
[659.915845] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[659.927335] Starting dynamic subtest: pipe-B-eDP-1
[662.557048] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.640s)
[662.568894] Starting dynamic subtest: pipe-C-eDP-1
[665.138608] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.580s)
[665.150198] Starting dynamic subtest: pipe-D-eDP-1
[667.737952] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.599s)
[667.740332] Subtest get-forked-busy: SUCCESS (9.758s)
[668.591302] [140/156] (354s left) gem_spin_batch (resubmit-all)
[668.655131] Starting subtest: resubmit-all
[668.657326] Starting dynamic subtest: rcs0
[668.662689] Dynamic subtest rcs0: SUCCESS (0.010s)
[668.673618] Starting dynamic subtest: bcs0
[668.675890] Dynamic subtest bcs0: SUCCESS (0.002s)
[668.686320] Starting dynamic subtest: vcs0
[668.688238] Dynamic subtest vcs0: SUCCESS (0.002s)
[668.698867] Starting dynamic subtest: vcs1
[668.700787] Dynamic subtest vcs1: SUCCESS (0.002s)
[668.711977] Starting dynamic subtest: vecs0
[668.713856] Dynamic subtest vecs0: SUCCESS (0.002s)
[668.723630] Starting dynamic subtest: ccs0
[668.725568] Dynamic subtest ccs0: SUCCESS (0.002s)
[668.727388] Subtest resubmit-all: SUCCESS (0.024s)
[670.147465] [141/156] (352s left) prime_vgem (wait)
[670.222820] Starting subtest: wait
[670.225203] Starting dynamic subtest: rcs0
[670.284860] Dynamic subtest rcs0: SUCCESS (0.062s)
[670.295990] Starting dynamic subtest: bcs0
[670.360288] Dynamic subtest bcs0: SUCCESS (0.074s)
[670.370798] Starting dynamic subtest: vcs0
[670.403976] Dynamic subtest vcs0: SUCCESS (0.043s)
[670.414308] Starting dynamic subtest: vcs1
[670.446786] Dynamic subtest vcs1: SUCCESS (0.042s)
[670.457332] Starting dynamic subtest: vecs0
[670.493431] Dynamic subtest vecs0: SUCCESS (0.046s)
[670.503865] Starting dynamic subtest: ccs0
[670.540350] Dynamic subtest ccs0: SUCCESS (0.046s)
[670.542650] Subtest wait: SUCCESS (0.318s)
[670.679960] [142/156] (352s left) kms_invalid_mode (bad-hsync-end)
[670.783250] Starting subtest: bad-hsync-end
[670.785546] Starting dynamic subtest: pipe-A-eDP-1
[671.067661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[671.078761] Starting dynamic subtest: pipe-B-eDP-1
[671.080617] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[671.091583] Starting dynamic subtest: pipe-C-eDP-1
[671.093693] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[671.104030] Starting dynamic subtest: pipe-D-eDP-1
[671.106099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[671.108162] Subtest bad-hsync-end: SUCCESS (0.292s)
[671.891055] [143/156] (351s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[671.998504] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[672.002391] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[672.112841] [144/156] (351s left) syncobj_timeline (reset-signaled)
[672.173119] Starting subtest: reset-signaled
[672.175554] Subtest reset-signaled: SUCCESS (0.001s)
[672.287775] [145/156] (350s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[672.393715] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[672.398147] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[672.500285] [146/156] (350s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[672.593141] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[672.597601] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[672.705234] [147/156] (350s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[672.809722] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[672.813062] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[672.912092] [148/156] (350s left) kms_plane_scaling (planes-upscale-factor-0-25)
[673.005757] Starting subtest: planes-upscale-factor-0-25
[673.007953] Starting dynamic subtest: pipe-A
[673.067755] Dynamic subtest pipe-A: SUCCESS (0.064s)
[673.080141] Starting dynamic subtest: pipe-B
[674.180199] Dynamic subtest pipe-B: SUCCESS (1.110s)
[674.192481] Starting dynamic subtest: pipe-C
[675.372231] Dynamic subtest pipe-C: SUCCESS (1.190s)
[675.383830] Starting dynamic subtest: pipe-D
[676.491096] Dynamic subtest pipe-D: SUCCESS (1.118s)
[676.493400] Subtest planes-upscale-factor-0-25: SUCCESS (3.487s)
[677.688830] [149/156] (345s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[677.785175] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[677.789504] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[677.864373] [150/156] (345s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[677.972606] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[677.977117] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[678.065970] [151/156] (345s left) kms_prop_blob (invalid-set-prop)
[678.120813] Starting subtest: invalid-set-prop
[678.122942] Subtest invalid-set-prop: SUCCESS (0.000s)
[678.245076] [152/156] (345s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[678.641081] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[679.470435] [153/156] (344s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[679.579295] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[686.543847] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.970s)
[686.658694] [154/156] (336s left) gen7_exec_parse (bitmasks)
[686.725022] Subtest bitmasks: SKIP (0.000s)
[686.803717] [155/156] (336s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[686.910090] Starting subtest: x-tiled-addfb-size-offset-overflow
[686.912384] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[687.014855] [156/156] (336s left) i915_pm_rps (engine-order)
[687.076285] Starting subtest: engine-order
[691.943806] Subtest engine-order: SUCCESS (4.866s)
[692.057557] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: sw_sync
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_fence_thrash
results: parsing output: 4/ for test: gem_pxp
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_ctx_persistence
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_rmfb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_force_connector_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: gem_ctx_isolation
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: prime_mmap_kms
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: vgem_basic
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: core_setmaster
results: parsing output: 48/ for test: gem_lmem_swapping
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_wait
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_workarounds
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: prime_mmap
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_plane_alpha_blend
results: parsing output: 74/ for test: api_intel_bb
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_multipipe_modeset
results: parsing output: 77/ for test: kms_color
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_scaling_modes
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_chamelium_frames
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_linear_blits
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: gem_mmap
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_atomic
results: parsing output: 95/ for test: kms_cdclk
results: parsing output: 96/ for test: kms_plane
results: parsing output: 97/ for test: gem_shrink
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_ctx_shared
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_frontbuffer_tracking
results: parsing output: 104/ for test: kms_prop_blob
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_feature_discovery
results: parsing output: 110/ for test: gem_ppgtt
results: parsing output: 111/ for test: kms_pm_dc
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: i915_power
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_mmap
results: parsing output: 120/ for test: kms_setmode
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_atomic_interruptible
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: gem_userptr_blits
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: fbdev
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_rotation_crc
results: parsing output: 138/ for test: kms_sequence
results: parsing output: 139/ for test: gem_spin_batch
results: parsing output: 140/ for test: prime_vgem
results: parsing output: 141/ for test: kms_invalid_mode
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: syncobj_timeline
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_plane_scaling
results: parsing output: 148/ for test: kms_plane
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_prop_blob
results: parsing output: 151/ for test: kms_chamelium_hpd
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gen7_exec_parse
results: parsing output: 154/ for test: kms_big_fb
results: parsing output: 155/ for test: i915_pm_rps
Done.