[59.091713] Initializing watchdogs
[59.091757]   /dev/watchdog0
[59.107383] [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]
[59.111996] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.114466] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.116656] [001/156] (960s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[59.224311] Starting subtest: fbchdr-modesetfrombusy
[59.225981] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[59.313383] [002/156] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[59.403153] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[59.405126] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[59.500205] [003/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[59.598523] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[59.600192] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[59.692058] [004/156] (960s left) i915_pm_rps (thresholds-idle)
[59.757312] Starting subtest: thresholds-idle
[59.759412] Subtest thresholds-idle: SKIP (0.001s)
[59.862747] [005/156] (959s left) gem_ctx_engines (execute-one)
[59.915606] Starting subtest: execute-one
[62.214734] Subtest execute-one: SUCCESS (2.270s)
[62.394707] [006/156] (957s left) kms_vblank (ts-continuation-modeset-rpm)
[62.485888] Starting subtest: ts-continuation-modeset-rpm
[62.486845] Starting dynamic subtest: pipe-A-eDP-1
[65.008203] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[65.018920] Starting dynamic subtest: pipe-D-eDP-1
[67.273243] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.249s)
[67.274356] Subtest ts-continuation-modeset-rpm: SUCCESS (4.750s)
[68.164716] [007/156] (951s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[68.265500] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[68.267484] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[68.359681] [008/156] (951s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[68.445327] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[68.447074] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[68.551368] [009/156] (951s left) kms_setmode (clone-exclusive-crtc)
[68.595113] Starting subtest: clone-exclusive-crtc
[68.598215] Subtest clone-exclusive-crtc: SKIP (0.000s)
[68.706853] [010/156] (951s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[68.793953] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[68.794940] Starting dynamic subtest: pipe-A
[68.858614] Dynamic subtest pipe-A: SUCCESS (0.065s)
[68.867286] Starting dynamic subtest: pipe-B
[70.005092] Dynamic subtest pipe-B: SUCCESS (1.141s)
[70.012728] Starting dynamic subtest: pipe-C
[71.114720] Dynamic subtest pipe-C: SUCCESS (1.105s)
[71.122680] Starting dynamic subtest: pipe-D
[72.272036] Dynamic subtest pipe-D: SUCCESS (1.153s)
[72.272976] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.466s)
[73.518459] [011/156] (946s left) gem_exec_params (larger-than-life-batch)
[73.618057] Starting subtest: larger-than-life-batch
[76.105381] Subtest larger-than-life-batch: SUCCESS (2.482s)
[77.384106] [012/156] (942s left) gem_exec_async (forked-writes)
[77.493979] Starting subtest: forked-writes
[77.494905] Starting dynamic subtest: rcs0
[77.526657] Dynamic subtest rcs0: SUCCESS (0.032s)
[77.535844] Starting dynamic subtest: bcs0
[77.555665] Dynamic subtest bcs0: SUCCESS (0.028s)
[77.564274] Starting dynamic subtest: vcs0
[77.576956] Dynamic subtest vcs0: SUCCESS (0.021s)
[77.588657] Starting dynamic subtest: vcs1
[77.601618] Dynamic subtest vcs1: SUCCESS (0.025s)
[77.609148] Starting dynamic subtest: vecs0
[77.625448] Dynamic subtest vecs0: SUCCESS (0.023s)
[77.632660] Starting dynamic subtest: ccs0
[77.648256] Dynamic subtest ccs0: SUCCESS (0.023s)
[77.649158] Subtest forked-writes: SUCCESS (0.155s)
[77.870209] [013/156] (942s left) kms_plane (planar-pixel-format-settings)
[77.970109] Starting subtest: planar-pixel-format-settings
[78.045074] Subtest planar-pixel-format-settings: SUCCESS (0.075s)
[78.160362] [014/156] (941s left) gem_eio (in-flight-10ms)
[78.394784] Starting subtest: in-flight-10ms
[87.310980] Subtest in-flight-10ms: SUCCESS (8.908s)
[87.435910] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[87.437660] [015/156] (932s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[87.525240] Starting subtest: psr2-cursor-plane-move-continuous-sf
[87.526214] Starting dynamic subtest: pipe-A-eDP-1
[97.885756] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.355s)
[97.894147] Starting dynamic subtest: pipe-B-eDP-1
[109.025879] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.134s)
[109.027374] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.491s)
[109.906874] [016/156] (910s left) kms_psr (psr2-dpms)
[109.998175] Starting subtest: psr2-dpms
[109.999080] Starting dynamic subtest: eDP-1
[112.941562] Dynamic subtest eDP-1: SUCCESS (2.941s)
[112.942570] Subtest psr2-dpms: SUCCESS (2.942s)
[113.803102] [017/156] (906s left) prime_vgem (basic-fence-flip)
[113.867790] Starting subtest: basic-fence-flip
[114.161314] Subtest basic-fence-flip: SUCCESS (0.293s)
[114.269864] [018/156] (905s left) gem_exec_flush (basic-uc-ro-default)
[114.338814] Starting subtest: basic-uc-ro-default
[119.803660] Subtest basic-uc-ro-default: SUCCESS (5.464s)
[119.981216] [019/156] (900s left) fbdev (unaligned-read)
[120.017792] Starting subtest: unaligned-read
[120.033094] Subtest unaligned-read: SUCCESS (0.016s)
[120.084655] [020/156] (900s left) kms_feature_discovery (psr2)
[120.172139] Starting subtest: psr2
[120.173055] Subtest psr2: SUCCESS (0.000s)
[120.248852] [021/156] (900s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[120.330582] Starting subtest: fbc-psr2-sprite-mmap-cpu
[120.331563] Starting dynamic subtest: eDP-1
[120.333373] Dynamic subtest eDP-1: SKIP (0.000s)
[120.335193] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[120.402815] [022/156] (899s left) gen9_exec_parse (bb-start-out)
[120.472914] Subtest bb-start-out: SKIP (0.000s)
[120.535679] [023/156] (899s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[120.593636] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[120.715589] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.110s)
[120.777793] [024/156] (899s left) api_intel_allocator (reserve-simple)
[120.824572] Starting subtest: reserve-simple
[120.828726] Subtest reserve-simple: SUCCESS (0.005s)
[120.964150] [025/156] (899s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[121.055089] Starting subtest: fbchdr-farfromfence-mmap-gtt
[121.056938] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[121.172183] [026/156] (899s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[121.270075] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[121.272334] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[121.358158] [027/156] (899s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[121.459177] Starting subtest: y-tiled-addfb-size-offset-overflow
[121.461121] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[121.544624] [028/156] (898s left) gem_spin_batch (engines)
[121.601222] Starting subtest: engines
[121.602415] Starting dynamic subtest: rcs0
[124.849667] Dynamic subtest rcs0: SUCCESS (3.236s)
[124.858710] Starting dynamic subtest: bcs0
[128.121403] Dynamic subtest bcs0: SUCCESS (3.234s)
[128.131353] Starting dynamic subtest: vcs0
[131.358932] Dynamic subtest vcs0: SUCCESS (3.236s)
[131.370435] Starting dynamic subtest: vcs1
[134.598860] Dynamic subtest vcs1: SUCCESS (3.238s)
[134.609054] Starting dynamic subtest: vecs0
[137.835636] Dynamic subtest vecs0: SUCCESS (3.236s)
[137.845902] Starting dynamic subtest: ccs0
[141.071861] Dynamic subtest ccs0: SUCCESS (3.234s)
[141.073285] Subtest engines: SUCCESS (19.421s)
[141.260266] [029/156] (879s left) gem_exec_reloc (basic-gtt-read-active)
[141.320806] Subtest basic-gtt-read-active: SKIP (0.000s)
[141.398163] [030/156] (879s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[141.497834] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[141.499154] Starting dynamic subtest: pipe-A-default-mode
[144.277648] Dynamic subtest pipe-A-default-mode: SUCCESS (2.778s)
[144.278861] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.779s)
[145.132735] [031/156] (875s left) dumb_buffer (create-valid-dumb)
[145.185597] Starting subtest: create-valid-dumb
[145.186529] Subtest create-valid-dumb: SUCCESS (0.000s)
[145.283360] [032/156] (875s left) perf_pmu (pmu-read)
[145.320674] Starting subtest: pmu-read
[145.323181] Subtest pmu-read: SUCCESS (0.003s)
[145.428559] [033/156] (875s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[145.514128] Starting subtest: plane-all-modeset-transition-fencing
[145.515736] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[145.594925] [034/156] (875s left) kms_flip (flip-vs-suspend)
[145.684961] Starting subtest: flip-vs-suspend
[145.685938] Starting dynamic subtest: A-eDP1
[258.774675] Dynamic subtest A-eDP1: SUCCESS (12.659s)
[258.776719] Subtest flip-vs-suspend: SUCCESS (12.661s)
[264.931696] [035/156] (761s left) kms_lease (multimaster-lease)
[265.040396] Starting subtest: multimaster-lease
[265.043582] Subtest multimaster-lease: SUCCESS (0.004s)
[265.169519] [036/156] (761s left) kms_hdr (static-toggle-dpms)
[265.256648] Starting subtest: static-toggle-dpms
[265.257640] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[265.259549] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[265.269190] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[265.271024] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[265.272945] Subtest static-toggle-dpms: SKIP (0.002s)
[265.346345] [037/156] (761s left) gem_userptr_blits (unsync-unmap-cycles)
[265.408620] Subtest unsync-unmap-cycles: SKIP (0.000s)
[265.539297] [038/156] (761s left) i915_pm_rpm (reg-read-ioctl)
[267.076948] Starting subtest: reg-read-ioctl
[269.474750] Subtest reg-read-ioctl: SUCCESS (2.328s)
[269.885214] [039/156] (757s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff)
[269.981873] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff
[269.983711] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[270.083884] [040/156] (756s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[270.176478] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[270.178051] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[270.292432] [041/156] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[270.389698] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[270.391373] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[270.501950] [042/156] (756s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[270.625368] Starting subtest: cursor-vs-flip-varying-size
[302.225640] Subtest cursor-vs-flip-varying-size: SUCCESS (31.425s)
[303.085105] [043/156] (723s left) gem_exec_balancer (parallel-keep-in-fence)
[303.358856] Starting subtest: parallel-keep-in-fence
[304.571622] Subtest parallel-keep-in-fence: SUCCESS (1.212s)
[304.671802] [044/156] (722s left) kms_psr (psr2-sprite-blt)
[304.760851] Starting subtest: psr2-sprite-blt
[304.762000] Starting dynamic subtest: eDP-1
[306.500516] Dynamic subtest eDP-1: SUCCESS (1.737s)
[306.501621] Subtest psr2-sprite-blt: SUCCESS (1.738s)
[307.359105] [045/156] (719s left) syncobj_wait (multi-wait-submitted)
[307.408749] Starting subtest: multi-wait-submitted
[307.510969] Subtest multi-wait-submitted: SUCCESS (0.101s)
[307.581793] [046/156] (719s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[307.672925] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[307.673808] Starting dynamic subtest: pipe-A-eDP-1
[307.682433] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[307.691560] Starting dynamic subtest: pipe-B-eDP-1
[307.699923] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[307.709048] Starting dynamic subtest: pipe-C-eDP-1
[307.717294] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[307.726743] Starting dynamic subtest: pipe-D-eDP-1
[307.734751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[307.736418] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[309.939430] [047/156] (717s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[309.972334] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[310.009527] [048/156] (717s left) gem_userptr_blits (usage-restrictions)
[310.061123] Starting subtest: usage-restrictions
[310.062109] Subtest usage-restrictions: SUCCESS (0.000s)
[310.186763] [049/156] (717s left) kms_prop_blob (blob-prop-core)
[310.232396] Starting subtest: blob-prop-core
[310.233558] Subtest blob-prop-core: SUCCESS (0.000s)
[310.322409] [050/156] (717s left) gem_pxp (fail-invalid-protected-context)
[310.432046] Starting subtest: fail-invalid-protected-context
[310.433584] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[310.534389] [051/156] (716s left) gem_reg_read (bad-register)
[310.581230] Starting subtest: bad-register
[310.582367] Subtest bad-register: SUCCESS (0.000s)
[310.671956] [052/156] (716s left) gem_exec_whisper (basic-contexts)
[310.721529] Starting subtest: basic-contexts
[317.185712] Subtest basic-contexts: SUCCESS (6.459s)
[317.367738] [053/156] (710s left) gem_mmap_wc (write)
[317.421174] Subtest write: SKIP (0.000s)
[317.480175] [054/156] (709s left) gem_mmap_offset (bad-object)
[317.525930] Starting subtest: bad-object
[317.527164] Subtest bad-object: SUCCESS (0.001s)
[317.594086] [055/156] (709s left) gem_fenced_exec_thrash (too-many-fences)
[317.650415] Subtest too-many-fences: SKIP (0.000s)
[317.718054] [056/156] (709s left) gem_ctx_bad_destroy (double-destroy)
[317.765273] Starting subtest: double-destroy
[317.766647] Subtest double-destroy: SUCCESS (0.000s)
[317.833733] [057/156] (709s left) kms_force_connector_basic (force-edid)
[317.913765] Starting subtest: force-edid
[318.291061] Subtest force-edid: SUCCESS (0.377s)
[318.429333] [058/156] (709s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[318.516864] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[318.518356] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[318.615754] [059/156] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[318.699757] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[318.701374] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[318.794440] [060/156] (708s left) perf_pmu (busy-double-start)
[318.827555] Starting subtest: busy-double-start
[318.828683] Starting dynamic subtest: rcs0
[322.437640] Dynamic subtest rcs0: FAIL (3.586s)
[322.448369] Starting dynamic subtest: bcs0
[325.988940] Dynamic subtest bcs0: SUCCESS (3.569s)
[326.000296] Starting dynamic subtest: vcs0
[330.284174] Dynamic subtest vcs0: SUCCESS (4.290s)
[330.298754] Starting dynamic subtest: vcs1
[334.264520] Dynamic subtest vcs1: SUCCESS (3.979s)
[334.277322] Starting dynamic subtest: vecs0
[338.287924] Dynamic subtest vecs0: SUCCESS (4.020s)
[338.300632] Starting dynamic subtest: ccs0
[341.887191] Dynamic subtest ccs0: FAIL (3.565s)
[341.888032] Subtest busy-double-start: FAIL (23.016s)
[341.961586] [061/156] (685s left) kms_psr (fbc-pr-dpms)
[342.054393] Starting subtest: fbc-pr-dpms
[342.056303] Subtest fbc-pr-dpms: SKIP (0.000s)
[342.124738] [062/156] (685s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[342.209484] Starting subtest: primary-4-tiled-reflect-x-180
[349.172740] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.960s)
[350.379906] [063/156] (677s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[350.489896] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[350.491782] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[350.592629] [064/156] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[350.699565] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[358.022057] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.320s)
[358.165017] [065/156] (669s left) kms_plane_alpha_blend (alpha-7efc)
[358.268650] Starting subtest: alpha-7efc
[358.561622] Starting dynamic subtest: pipe-A-eDP-1
[359.171451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[359.202216] Starting dynamic subtest: pipe-D-eDP-1
[360.490203] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[360.491686] Subtest alpha-7efc: SUCCESS (2.223s)
[361.374756] [066/156] (666s left) kms_flip (plain-flip-ts-check)
[361.467019] Starting subtest: plain-flip-ts-check
[361.469095] Starting dynamic subtest: A-eDP1
[370.358425] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[370.368763] Starting dynamic subtest: B-eDP1
[379.266297] Dynamic subtest B-eDP1: SUCCESS (8.909s)
[379.277458] Starting dynamic subtest: C-eDP1
[388.159998] Dynamic subtest C-eDP1: SUCCESS (8.880s)
[388.170236] Starting dynamic subtest: D-eDP1
[397.010789] Dynamic subtest D-eDP1: SUCCESS (8.882s)
[397.014062] Subtest plain-flip-ts-check: SUCCESS (35.551s)
[398.266999] [067/156] (629s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[398.354719] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[405.059689] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.706s)
[405.210725] [068/156] (622s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[405.300660] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[405.302467] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[405.390620] [069/156] (622s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[405.439322] Starting subtest: invalid-single-wait-unsubmitted
[405.440197] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[405.544464] [070/156] (622s left) kms_pm_rpm (dpms-lpsp)
[407.066500] Starting subtest: dpms-lpsp
[407.714244] Subtest dpms-lpsp: SUCCESS (0.650s)
[407.810286] [071/156] (620s left) gem_mmap_wc (read-write-distinct)
[407.857373] Subtest read-write-distinct: SKIP (0.000s)
[407.911629] [072/156] (620s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[408.002398] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[408.003968] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[408.107299] [073/156] (620s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[408.195094] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[408.196849] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[408.294152] [074/156] (619s left) kms_cursor_edge_walk (256x256-top-edge)
[408.395591] Starting subtest: 256x256-top-edge
[408.396460] Starting dynamic subtest: pipe-A-eDP-1
[411.892616] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[411.902243] Starting dynamic subtest: pipe-D-eDP-1
[415.098535] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.205s)
[415.099339] Subtest 256x256-top-edge: SUCCESS (6.702s)
[415.960919] [075/156] (612s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[416.060158] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[416.061919] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[416.154980] [076/156] (612s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[416.265615] Starting subtest: short-busy-flip-before-cursor-toggle
[416.267667] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[416.417907] [077/156] (611s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[416.503824] Starting subtest: psr-rgb565-draw-mmap-wc
[423.354012] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.850s)
[423.477336] [078/156] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[423.580454] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[423.582279] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[423.673400] [079/156] (604s left) gem_userptr_blits (probe)
[423.730224] Starting subtest: probe
[423.811609] Subtest probe: SUCCESS (0.081s)
[423.920612] [080/156] (604s left) gem_exec_balancer (full-pulse)
[423.973770] Starting subtest: full-pulse
[428.680662] Subtest full-pulse: SUCCESS (4.706s)
[429.025798] [081/156] (599s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[429.139243] Starting subtest: hdr-rgb565-draw-mmap-wc
[429.140940] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[429.220647] [082/156] (599s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move)
[429.321322] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move
[429.323010] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[429.416856] [083/156] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[429.518523] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[429.521406] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[429.614180] [084/156] (598s left) kms_cursor_crc (cursor-offscreen-32x32)
[429.769661] Starting subtest: cursor-offscreen-32x32
[429.816232] Subtest cursor-offscreen-32x32: SKIP (0.045s)
[430.115434] [085/156] (598s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[430.163579] Starting subtest: single-wait-all-for-submit-available-signaled
[430.164649] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[430.268321] [086/156] (598s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[430.361924] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[430.363529] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[430.476826] [087/156] (598s left) kms_busy (extended-pageflip-hang-newfb)
[430.580070] Starting subtest: extended-pageflip-hang-newfb
[430.581117] Starting dynamic subtest: pipe-A
[456.529377] Dynamic subtest pipe-A: SUCCESS (25.941s)
[456.540703] Starting dynamic subtest: pipe-D
[471.628177] Dynamic subtest pipe-D: SUCCESS (15.091s)
[471.629343] Subtest extended-pageflip-hang-newfb: SUCCESS (41.037s)
[472.464294] [088/156] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[472.560557] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[472.562382] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[472.643406] [089/156] (556s left) prime_vgem (basic-fence-blt)
[472.710026] Starting subtest: basic-fence-blt
[472.801548] Subtest basic-fence-blt: SUCCESS (0.092s)
[472.922772] [090/156] (555s left) gem_pxp (verify-pxp-stale-buf-execution)
[473.017632] Starting subtest: verify-pxp-stale-buf-execution
[474.082871] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[474.223004] [091/156] (554s left) kms_invalid_mode (zero-vdisplay)
[474.317516] Starting subtest: zero-vdisplay
[474.318371] Starting dynamic subtest: pipe-A-eDP-1
[474.614233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[474.623507] Starting dynamic subtest: pipe-B-eDP-1
[474.624302] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[474.633218] Starting dynamic subtest: pipe-C-eDP-1
[474.634101] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[474.643278] Starting dynamic subtest: pipe-D-eDP-1
[474.644191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[474.645215] Subtest zero-vdisplay: SUCCESS (0.303s)
[475.466503] [092/156] (553s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[475.558722] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[475.561828] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[475.629185] [093/156] (553s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[475.722303] Starting subtest: 4-tiled-32bpp-rotate-0
[477.071615] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.349s)
[477.222056] [094/156] (551s left) gem_ctx_param (invalid-param-get)
[477.276921] Starting subtest: invalid-param-get
[477.277945] Subtest invalid-param-get: SUCCESS (0.001s)
[477.382662] [095/156] (551s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[477.434882] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[477.490099] [096/156] (551s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[477.578179] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[477.588849] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[477.679219] [097/156] (551s left) kms_async_flips (crc-atomic)
[477.772136] Starting subtest: crc-atomic
[478.158056] Starting dynamic subtest: pipe-A-eDP-1
[481.045904] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.887s)
[481.434726] Starting dynamic subtest: pipe-B-eDP-1
[484.375796] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.949s)
[484.764900] Starting dynamic subtest: pipe-C-eDP-1
[487.638139] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.889s)
[488.004305] Starting dynamic subtest: pipe-D-eDP-1
[490.956773] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.963s)
[490.957765] Subtest crc-atomic: SUCCESS (13.184s)
[492.167059] [098/156] (536s left) gem_userptr_blits (input-checking)
[492.226675] Starting subtest: input-checking
[492.227746] Subtest input-checking: SUCCESS (0.000s)
[492.364592] [099/156] (536s left) i915_drm_fdinfo (memory-info-shared)
[492.396833] Starting subtest: memory-info-shared
[492.397751] Starting dynamic subtest: smem0
[492.444124] Dynamic subtest smem0: SUCCESS (0.047s)
[492.445188] Subtest memory-info-shared: SUCCESS (0.047s)
[492.513033] [100/156] (536s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[492.885202] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[493.750926] [101/156] (535s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[493.847756] Starting subtest: fbchdr-1p-rte
[493.849506] Subtest fbchdr-1p-rte: SKIP (0.000s)
[493.952041] [102/156] (535s left) kms_psr (fbc-psr-sprite-plane-onoff)
[494.044214] Starting subtest: fbc-psr-sprite-plane-onoff
[494.045944] Starting dynamic subtest: eDP-1
[494.047998] Dynamic subtest eDP-1: SKIP (0.000s)
[494.049617] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[494.114778] [103/156] (535s left) gem_ctx_freq (sysfs)
[494.176587] Starting subtest: sysfs
[494.177847] Starting dynamic subtest: gt0
[499.684005] Dynamic subtest gt0: SUCCESS (5.509s)
[499.699199] Starting dynamic subtest: gt1
[541.748152] Dynamic subtest gt1: SUCCESS (42.059s)
[541.749889] Subtest sysfs: SUCCESS (47.571s)
[541.863678] [104/156] (487s left) syncobj_wait (invalid-reset-zero-handles)
[541.913300] Starting subtest: invalid-reset-zero-handles
[541.914200] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[542.014296] [105/156] (487s left) kms_frontbuffer_tracking (psr-1p-rte)
[542.117409] Starting subtest: psr-1p-rte
[547.516235] Subtest psr-1p-rte: SUCCESS (5.403s)
[547.660482] [106/156] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[547.752032] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[557.563983] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.811s)
[557.708344] [107/156] (471s left) kms_color (ctm-negative)
[557.801740] Starting subtest: ctm-negative
[557.802683] Starting dynamic subtest: pipe-A-eDP-1
[558.520815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[558.532093] Starting dynamic subtest: pipe-B-eDP-1
[559.932797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.411s)
[559.943557] Starting dynamic subtest: pipe-C-eDP-1
[561.289563] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.354s)
[561.299596] Starting dynamic subtest: pipe-D-eDP-1
[562.686113] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s)
[562.687087] Subtest ctm-negative: SUCCESS (4.885s)
[563.552469] [108/156] (465s left) kms_flip (2x-plain-flip-interruptible)
[563.643290] Starting subtest: 2x-plain-flip-interruptible
[563.654477] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[563.725417] [109/156] (465s left) core_getstats (basic)
[563.767747] Starting subtest: basic
[563.768699] Subtest basic: SUCCESS (0.000s)
[563.894591] [110/156] (465s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[563.951233] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[563.952994] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[564.145108] [111/156] (465s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[564.232612] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[564.233438] Starting dynamic subtest: pipe-A
[565.371966] Dynamic subtest pipe-A: SUCCESS (1.139s)
[565.382319] Starting dynamic subtest: pipe-B
[567.637871] Dynamic subtest pipe-B: SUCCESS (2.265s)
[567.647976] Starting dynamic subtest: pipe-C
[568.802079] Dynamic subtest pipe-C: SUCCESS (1.163s)
[568.811690] Starting dynamic subtest: pipe-D
[569.996383] Dynamic subtest pipe-D: SUCCESS (1.194s)
[569.997377] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.765s)
[571.150017] [112/156] (458s left) i915_hangman (gt-engine-hang)
[571.221999] Starting subtest: gt-engine-hang
[571.223078] Starting dynamic subtest: rcs0
[572.755428] Dynamic subtest rcs0: SUCCESS (1.524s)
[572.781819] Starting dynamic subtest: bcs0
[574.737788] Dynamic subtest bcs0: SUCCESS (1.978s)
[574.751503] Starting dynamic subtest: vcs0
[576.722350] Dynamic subtest vcs0: SUCCESS (1.983s)
[576.737945] Starting dynamic subtest: vcs1
[578.708214] Dynamic subtest vcs1: SUCCESS (1.983s)
[578.724588] Starting dynamic subtest: vecs0
[580.753622] Dynamic subtest vecs0: SUCCESS (2.043s)
[580.768104] Starting dynamic subtest: ccs0
[582.674088] Dynamic subtest ccs0: SUCCESS (1.917s)
[582.675680] Subtest gt-engine-hang: SUCCESS (11.443s)
[582.781864] [113/156] (446s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[582.881599] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[582.883368] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[582.986063] [114/156] (446s left) kms_atomic_transition (modeset-transition)
[583.067294] Starting subtest: modeset-transition
[583.068225] Starting dynamic subtest: 1x-outputs
[593.922729] Dynamic subtest 1x-outputs: SUCCESS (10.852s)
[593.924458] Subtest modeset-transition: SUCCESS (10.854s)
[594.756690] [115/156] (434s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[594.856817] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[594.858635] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[594.991232] [116/156] (434s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[595.048795] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[595.049937] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[595.132548] [117/156] (434s left) kms_vblank (query-busy-hang)
[595.233518] Starting subtest: query-busy-hang
[595.234387] Starting dynamic subtest: pipe-A-eDP-1
[621.483266] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.243s)
[621.496565] Starting dynamic subtest: pipe-D-eDP-1
[636.524735] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.036s)
[636.525588] Subtest query-busy-hang: SUCCESS (41.284s)
[637.371178] [118/156] (392s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[637.462087] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[637.462985] Starting dynamic subtest: pipe-A-eDP-1
[637.470535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[637.481710] Starting dynamic subtest: pipe-B-eDP-1
[637.489698] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[637.501280] Starting dynamic subtest: pipe-C-eDP-1
[637.516674] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[637.526581] Starting dynamic subtest: pipe-D-eDP-1
[637.534440] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[637.535328] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[639.758448] [119/156] (390s left) kms_flip (flip-vs-wf_vblank-interruptible)
[639.853318] Starting subtest: flip-vs-wf_vblank-interruptible
[639.856024] Starting dynamic subtest: A-eDP1
[641.780726] Dynamic subtest A-eDP1: SUCCESS (1.924s)
[641.795517] Starting dynamic subtest: B-eDP1
[643.678598] Dynamic subtest B-eDP1: SUCCESS (1.896s)
[643.691302] Starting dynamic subtest: C-eDP1
[645.573951] Dynamic subtest C-eDP1: SUCCESS (1.893s)
[645.589414] Starting dynamic subtest: D-eDP1
[647.463072] Dynamic subtest D-eDP1: SUCCESS (1.886s)
[647.468899] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.613s)
[648.649972] [120/156] (381s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[648.743131] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[648.744948] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[648.841764] [121/156] (381s left) sw_sync (sync_multi_producer_single_consumer)
[648.871593] Starting subtest: sync_multi_producer_single_consumer
[649.955460] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[650.004938] [122/156] (380s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[650.101362] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[650.102947] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[650.200072] [123/156] (379s left) kms_cursor_crc (cursor-random-128x42)
[650.412807] Starting subtest: cursor-random-128x42
[650.460089] Subtest cursor-random-128x42: SKIP (0.044s)
[650.658660] [124/156] (379s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[650.751422] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[650.753269] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[650.844166] [125/156] (379s left) gem_exec_schedule (u-independent)
[650.900582] Starting subtest: u-independent
[650.901602] Starting dynamic subtest: rcs0
[652.788856] Dynamic subtest rcs0: SUCCESS (1.878s)
[652.799165] Starting dynamic subtest: vcs0
[654.777731] Dynamic subtest vcs0: SUCCESS (1.986s)
[654.790557] Starting dynamic subtest: vcs1
[656.763064] Dynamic subtest vcs1: SUCCESS (1.983s)
[656.780774] Starting dynamic subtest: vecs0
[658.738844] Dynamic subtest vecs0: SUCCESS (1.972s)
[658.752400] Starting dynamic subtest: ccs0
[660.787323] Dynamic subtest ccs0: SUCCESS (2.047s)
[660.788938] Subtest u-independent: SUCCESS (9.876s)
[661.077944] [126/156] (369s left) gem_exec_reloc (basic-gtt-cpu-active)
[661.130506] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[661.197425] [127/156] (369s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[661.301308] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[661.303105] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[661.394347] [128/156] (368s left) gem_mmap_gtt (bad-object)
[661.452066] Subtest bad-object: SKIP (0.000s)
[661.518982] [129/156] (368s left) gem_workarounds (suspend-resume)
[661.579834] Starting subtest: suspend-resume
[677.741124] Subtest suspend-resume: SUCCESS (1.564s)
[684.896721] [130/156] (352s left) kms_addfb_basic (bad-pitch-256)
[684.948538] Starting subtest: bad-pitch-256
[684.949386] Subtest bad-pitch-256: SUCCESS (0.000s)
[685.083733] [131/156] (352s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[685.174216] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[685.202153] Starting dynamic subtest: pipe-A-plane-0
[685.601887] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s)
[685.612350] Starting dynamic subtest: pipe-A-plane-3
[685.941430] Dynamic subtest pipe-A-plane-3: SUCCESS (0.332s)
[687.062627] Starting dynamic subtest: pipe-B-plane-0
[687.502602] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[687.514316] Starting dynamic subtest: pipe-B-plane-3
[687.826429] Dynamic subtest pipe-B-plane-3: SUCCESS (0.310s)
[688.146653] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.877s)
[688.981178] [132/156] (348s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[689.092241] Starting subtest: x-tiled-16bpp-rotate-180
[690.409059] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.279s)
[690.532613] [133/156] (346s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[690.638328] Starting subtest: fbc-rgb101010-draw-blt
[693.213681] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.520s)
[694.400517] [134/156] (343s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[694.494721] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[694.496661] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[694.610983] [135/156] (342s left) gem_exec_params (cliprects-invalid)
[694.661868] Starting subtest: cliprects-invalid
[694.662651] Subtest cliprects-invalid: SUCCESS (0.000s)
[694.765962] [136/156] (342s left) gem_exec_fence (parallel)
[694.960218] Starting subtest: parallel
[694.961410] Starting dynamic subtest: rcs0
[697.133224] Dynamic subtest rcs0: SUCCESS (2.154s)
[697.147583] Starting dynamic subtest: bcs0
[699.302952] Dynamic subtest bcs0: SUCCESS (2.148s)
[699.313771] Starting dynamic subtest: vcs0
[701.471517] Dynamic subtest vcs0: SUCCESS (2.152s)
[701.483874] Starting dynamic subtest: vcs1
[703.633984] Dynamic subtest vcs1: SUCCESS (2.149s)
[703.646650] Starting dynamic subtest: vecs0
[705.796230] Dynamic subtest vecs0: SUCCESS (2.152s)
[705.810089] Starting dynamic subtest: ccs0
[707.952914] Dynamic subtest ccs0: SUCCESS (2.149s)
[707.953984] Subtest parallel: SUCCESS (12.908s)
[708.522290] [137/156] (329s left) gem_mmap_wc (close)
[708.571847] Subtest close: SKIP (0.000s)
[708.638663] [138/156] (329s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[708.732124] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[708.733618] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[709.894701] [139/156] (327s left) kms_big_fb (linear-8bpp-rotate-180)
[709.997065] Starting subtest: linear-8bpp-rotate-180
[711.226791] Subtest linear-8bpp-rotate-180: SUCCESS (1.227s)
[711.349277] [140/156] (326s left) gem_ctx_persistence (legacy-engines-persistence)
[711.414441] Starting subtest: legacy-engines-persistence
[711.415536] Starting dynamic subtest: render
[712.241411] Dynamic subtest render: SUCCESS (0.824s)
[712.255636] Starting dynamic subtest: bsd1
[713.001190] Dynamic subtest bsd1: SUCCESS (0.756s)
[713.014898] Starting dynamic subtest: bsd2
[713.754289] Dynamic subtest bsd2: SUCCESS (0.748s)
[713.767755] Starting dynamic subtest: blt
[714.543566] Dynamic subtest blt: SUCCESS (0.786s)
[714.557022] Starting dynamic subtest: vebox
[715.311575] Dynamic subtest vebox: SUCCESS (0.764s)
[715.316161] Subtest legacy-engines-persistence: SUCCESS (3.892s)
[715.413975] [141/156] (322s left) kms_content_protection (dp-mst-lic-type-1)
[715.548095] Starting subtest: dp-mst-lic-type-1
[715.550355] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[715.656243] [142/156] (322s left) kms_chamelium_frames (dp-crc-single)
[716.031381] Subtest dp-crc-single: SKIP (0.000s)
[716.884239] [143/156] (320s left) gem_exec_schedule (noreorder-corked)
[717.059378] Starting subtest: noreorder-corked
[717.060425] Starting dynamic subtest: rcs0
[718.194193] Dynamic subtest rcs0: SUCCESS (1.136s)
[718.207506] Starting dynamic subtest: vcs0
[719.346581] Dynamic subtest vcs0: SUCCESS (1.149s)
[719.362163] Starting dynamic subtest: vcs1
[721.339765] Dynamic subtest vcs1: SUCCESS (1.981s)
[721.352352] Starting dynamic subtest: vecs0
[723.396361] Dynamic subtest vecs0: SUCCESS (2.054s)
[723.408970] Starting dynamic subtest: ccs0
[724.535525] Dynamic subtest ccs0: SUCCESS (1.145s)
[724.537202] Subtest noreorder-corked: SUCCESS (7.477s)
[724.737160] [144/156] (313s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-plflip-blt)
[724.836994] Starting subtest: psrhdr-1p-primscrn-shrfb-plflip-blt
[724.838664] Subtest psrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[724.944503] [145/156] (312s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[724.989535] Starting subtest: multi-wait-available-unsubmitted-signaled
[724.990486] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[725.090671] [146/156] (312s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[725.187816] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[725.991095] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s)
[726.138689] [147/156] (311s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[726.232848] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[726.234622] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[726.332711] [148/156] (311s left) gem_workarounds (basic-read)
[726.389336] Starting subtest: basic-read
[726.398757] Subtest basic-read: SUCCESS (0.010s)
[726.509080] [149/156] (311s left) gem_exec_reloc (basic-gtt-noreloc)
[726.566409] Subtest basic-gtt-noreloc: SKIP (0.000s)
[726.632451] [150/156] (311s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[726.719558] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[726.721468] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[726.832605] [151/156] (311s left) i915_query (query-topology-unsupported)
[726.886710] Starting subtest: query-topology-unsupported
[726.888574] Subtest query-topology-unsupported: SKIP (0.000s)
[726.980912] [152/156] (311s left) kms_chamelium_color (ctm-negative)
[727.061485] Subtest ctm-negative: SKIP (0.000s)
[727.106594] [153/156] (311s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[727.200536] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[727.202370] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[727.301015] [154/156] (310s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[727.388260] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[727.389188] Starting dynamic subtest: pipe-A-eDP-1
[727.399014] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[727.409761] Starting dynamic subtest: pipe-B-eDP-1
[727.421981] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[727.434876] Starting dynamic subtest: pipe-C-eDP-1
[727.444516] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[727.455721] Starting dynamic subtest: pipe-D-eDP-1
[727.465229] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[727.467012] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[729.610289] [155/156] (308s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[729.707390] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[729.709054] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[729.801912] [156/156] (308s left) sysfs_preempt_timeout (idempotent)
[729.855429] Starting subtest: idempotent
[729.856645] Starting dynamic subtest: vecs0
[729.857786] Dynamic subtest vecs0: SUCCESS (0.000s)
[729.869649] Starting dynamic subtest: ccs0
[729.870667] Dynamic subtest ccs0: SUCCESS (0.000s)
[729.880697] Starting dynamic subtest: vcs0
[729.881641] Dynamic subtest vcs0: SUCCESS (0.000s)
[729.891413] Starting dynamic subtest: bcs0
[729.892295] Dynamic subtest bcs0: SUCCESS (0.000s)
[729.901950] Starting dynamic subtest: rcs0
[729.902785] Dynamic subtest rcs0: SUCCESS (0.000s)
[729.912841] Starting dynamic subtest: vcs1
[729.914061] Dynamic subtest vcs1: SUCCESS (0.000s)
[729.915078] Subtest idempotent: SUCCESS (0.007s)
[729.978868] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: i915_pm_rps
results: parsing output: 4/ for test: gem_ctx_engines
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_setmode
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: gem_exec_async
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_exec_flush
results: parsing output: 18/ for test: fbdev
results: parsing output: 19/ for test: kms_feature_discovery
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: gen9_exec_parse
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_spin_batch
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: dumb_buffer
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: kms_hdr
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: i915_pm_rpm
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: kms_prop_blob
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: gem_reg_read
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: gem_mmap_offset
results: parsing output: 54/ for test: gem_fenced_exec_thrash
results: parsing output: 55/ for test: gem_ctx_bad_destroy
results: parsing output: 56/ for test: kms_force_connector_basic
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_plane_alpha_blend
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_edge_walk
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_busy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: prime_vgem
results: parsing output: 89/ for test: gem_pxp
results: parsing output: 90/ for test: kms_invalid_mode
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_ctx_param
results: parsing output: 94/ for test: kms_pipe_b_c_ivb
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_ctx_freq
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_color
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: core_getstats
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: sw_sync
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: kms_addfb_basic
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_exec_params
results: parsing output: 135/ for test: gem_exec_fence
results: parsing output: 136/ for test: gem_mmap_wc
results: parsing output: 137/ for test: kms_ccs
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: gem_ctx_persistence
results: parsing output: 140/ for test: kms_content_protection
results: parsing output: 141/ for test: kms_chamelium_frames
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_workarounds
results: parsing output: 148/ for test: gem_exec_reloc
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: i915_query
results: parsing output: 151/ for test: kms_chamelium_color
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: sysfs_preempt_timeout
Done.