[52.123973] Initializing watchdogs
[52.124095]   /dev/watchdog0
[52.137411] [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]
[52.141738] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.144011] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.147163] [001/131] (960s left) gem_mmap_gtt (big-bo)
[52.229341] Subtest big-bo: SKIP (0.000s)
[52.285879] [002/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[52.384017] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[75.106270] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.805s)
[75.238269] [003/131] (937s left) gem_ppgtt (blt-vs-render-ctxn)
[75.306072] Starting subtest: blt-vs-render-ctxN
[108.253989] Subtest blt-vs-render-ctxN: SUCCESS (32.946s)
[108.423519] [004/131] (904s left) gem_wait (write-busy)
[108.533712] Starting subtest: write-busy
[108.536171] Starting dynamic subtest: all-engines
[109.245544] Dynamic subtest all-engines: SUCCESS (0.712s)
[109.260261] Starting dynamic subtest: rcs0
[109.795942] Dynamic subtest rcs0: SUCCESS (0.549s)
[109.810512] Starting dynamic subtest: bcs0
[110.344299] Dynamic subtest bcs0: SUCCESS (0.547s)
[110.357989] Starting dynamic subtest: vcs0
[111.894397] Dynamic subtest vcs0: SUCCESS (1.547s)
[111.908369] Starting dynamic subtest: vcs1
[113.877517] Dynamic subtest vcs1: SUCCESS (1.982s)
[113.890545] Starting dynamic subtest: vecs0
[115.925070] Dynamic subtest vecs0: SUCCESS (2.046s)
[115.938612] Starting dynamic subtest: ccs0
[116.474440] Dynamic subtest ccs0: SUCCESS (0.550s)
[116.476956] Subtest write-busy: SUCCESS (7.941s)
[116.688890] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[116.692685] [005/131] (896s left) kms_lease (atomic-implicit-crtc)
[116.803929] Starting subtest: atomic-implicit-crtc
[116.806342] Starting dynamic subtest: pipe-A-eDP-1
[116.817983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[116.826334] Starting dynamic subtest: pipe-B-eDP-1
[116.838691] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[116.848276] Starting dynamic subtest: pipe-C-eDP-1
[116.858881] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[116.865929] Starting dynamic subtest: pipe-D-eDP-1
[116.876662] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[116.878876] Subtest atomic-implicit-crtc: SUCCESS (0.031s)
[116.958807] [006/131] (895s left) i915_pm_freq_api (freq-reset)
[117.026824] Starting subtest: freq-reset
[117.029073] Starting dynamic subtest: gt0
[117.202899] Dynamic subtest gt0: SUCCESS (0.176s)
[117.209870] Starting dynamic subtest: gt1
[117.360892] Dynamic subtest gt1: SUCCESS (0.158s)
[117.363484] Subtest freq-reset: SUCCESS (0.336s)
[117.454902] [007/131] (895s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[117.557173] Starting subtest: cursorA-vs-flipA-legacy
[128.732589] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.174s)
[129.552879] [008/131] (883s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[129.618266] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[129.678757] [009/131] (883s left) i915_drm_fdinfo (memory-info-purgeable)
[129.719360] Starting subtest: memory-info-purgeable
[129.721717] Starting dynamic subtest: smem0
[132.939276] Dynamic subtest smem0: SUCCESS (3.222s)
[132.941394] Subtest memory-info-purgeable: SUCCESS (3.222s)
[133.038247] [010/131] (879s left) gem_partial_pwrite_pread (write)
[133.104290] Subtest write: SKIP (0.000s)
[133.192399] [011/131] (879s left) gem_ctx_exec (basic-invalid-context)
[133.247267] Starting subtest: basic-invalid-context
[133.254362] Subtest basic-invalid-context: SUCCESS (0.008s)
[133.414498] [012/131] (879s left) kms_atomic_transition (plane-toggle-modeset-transition)
[133.515036] Starting subtest: plane-toggle-modeset-transition
[133.516817] Starting dynamic subtest: pipe-A-eDP-1
[146.248989] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.733s)
[146.260162] Starting dynamic subtest: pipe-B-eDP-1
[158.677296] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.424s)
[158.680040] Subtest plane-toggle-modeset-transition: SUCCESS (25.163s)
[159.513990] [013/131] (853s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[159.717741] Starting subtest: cursor-rapid-movement-64x21
[159.767662] Subtest cursor-rapid-movement-64x21: SKIP (0.045s)
[160.034139] [014/131] (853s left) gem_exec_reloc (basic-scanout)
[160.092467] Subtest basic-scanout: SKIP (0.000s)
[160.184300] [015/131] (852s left) kms_dsc (dsc-with-bpc)
[160.270320] Starting subtest: dsc-with-bpc
[160.301488] Subtest dsc-with-bpc: SKIP (0.001s)
[160.365940] [016/131] (852s left) kms_chamelium_color (ctm-green-to-red)
[160.470498] Subtest ctm-green-to-red: SKIP (0.000s)
[160.512932] [017/131] (852s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[160.605902] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[164.716958] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.113s)
[165.930456] [018/131] (847s left) gem_exec_reloc (basic-wc-cpu-active)
[165.998258] Subtest basic-wc-cpu-active: SKIP (0.000s)
[166.079889] [019/131] (847s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[166.169769] Starting subtest: x-tiled-8bpp-rotate-180
[167.327125] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.156s)
[167.486409] [020/131] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[167.592171] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[167.595750] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[167.719181] [021/131] (845s left) gem_exec_fence (syncobj-channel)
[168.140198] Starting subtest: syncobj-channel
[169.158666] Subtest syncobj-channel: SUCCESS (1.015s)
[170.010532] [022/131] (843s left) gem_busy (extended)
[170.201494] Starting subtest: extended
[170.203943] Starting dynamic subtest: rcs0
[170.321308] Dynamic subtest rcs0: SUCCESS (0.120s)
[170.331897] Starting dynamic subtest: bcs0
[170.364712] Dynamic subtest bcs0: SUCCESS (0.042s)
[170.375452] Starting dynamic subtest: vcs0
[171.927565] Dynamic subtest vcs0: SUCCESS (1.559s)
[171.938558] Starting dynamic subtest: vcs1
[173.910478] Dynamic subtest vcs1: SUCCESS (1.981s)
[173.921663] Starting dynamic subtest: vecs0
[175.894485] Dynamic subtest vecs0: SUCCESS (1.982s)
[175.905904] Starting dynamic subtest: ccs0
[175.939031] Dynamic subtest ccs0: SUCCESS (0.044s)
[175.941424] Subtest extended: SUCCESS (5.739s)
[176.222569] [023/131] (837s left) gem_exec_flush (basic-uc-rw-default)
[176.294808] Starting subtest: basic-uc-rw-default
[181.760858] Subtest basic-uc-rw-default: SUCCESS (5.466s)
[181.977550] [024/131] (831s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[182.357531] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[183.206120] [025/131] (830s left) kms_lease (setcrtc-implicit-plane)
[183.300276] Starting subtest: setcrtc-implicit-plane
[183.302710] Starting dynamic subtest: pipe-A-eDP-1
[183.755617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s)
[183.765216] Starting dynamic subtest: pipe-B-eDP-1
[184.866973] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.110s)
[184.875893] Starting dynamic subtest: pipe-C-eDP-1
[185.979575] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[185.987450] Starting dynamic subtest: pipe-D-eDP-1
[187.125200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[187.127427] Subtest setcrtc-implicit-plane: SUCCESS (3.825s)
[187.991467] [026/131] (825s left) kms_frontbuffer_tracking (fbc-tiling-y)
[188.101789] Starting subtest: fbc-tiling-y
[188.105741] Subtest fbc-tiling-y: SKIP (0.000s)
[188.214511] [027/131] (825s left) kms_prop_blob (blob-prop-validate)
[188.275327] Starting subtest: blob-prop-validate
[188.277658] Subtest blob-prop-validate: SUCCESS (0.000s)
[188.416287] [028/131] (825s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[188.521856] Starting subtest: flip-vs-dpms-on-nop-interruptible
[188.524227] Starting dynamic subtest: A-eDP1
[190.363175] Dynamic subtest A-eDP1: SUCCESS (1.840s)
[190.376448] Starting dynamic subtest: B-eDP1
[192.190319] Dynamic subtest B-eDP1: SUCCESS (1.826s)
[192.200873] Starting dynamic subtest: C-eDP1
[194.018527] Dynamic subtest C-eDP1: SUCCESS (1.827s)
[194.034798] Starting dynamic subtest: D-eDP1
[195.851830] Dynamic subtest D-eDP1: SUCCESS (1.830s)
[195.854647] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.333s)
[197.047336] [029/131] (816s left) kms_psr (psr2-sprite-plane-onoff)
[197.151258] Starting subtest: psr2-sprite-plane-onoff
[197.153633] Starting dynamic subtest: eDP-1
[198.925409] Dynamic subtest eDP-1: SUCCESS (1.773s)
[198.927319] Subtest psr2-sprite-plane-onoff: SUCCESS (1.774s)
[199.802138] [030/131] (813s left) syncobj_wait (multi-wait-signaled)
[199.857590] Starting subtest: multi-wait-signaled
[199.859933] Subtest multi-wait-signaled: SUCCESS (0.000s)
[199.982911] [031/131] (813s left) gem_ctx_shared (q-promotion)
[200.043608] Starting subtest: Q-promotion
[200.046123] Starting dynamic subtest: rcs0
[200.147070] Dynamic subtest rcs0: SUCCESS (0.103s)
[200.164344] Starting dynamic subtest: vcs0
[200.227609] Dynamic subtest vcs0: SUCCESS (0.080s)
[200.242069] Starting dynamic subtest: vcs1
[200.302632] Dynamic subtest vcs1: SUCCESS (0.074s)
[200.317828] Starting dynamic subtest: vecs0
[200.378897] Dynamic subtest vecs0: SUCCESS (0.075s)
[200.393751] Starting dynamic subtest: ccs0
[200.447208] Dynamic subtest ccs0: SUCCESS (0.068s)
[200.449862] Subtest Q-promotion: SUCCESS (0.404s)
[202.078299] [032/131] (811s left) tools_test (tools_test)
[202.133320] Starting subtest: tools_test
[202.189948] Subtest tools_test: SUCCESS (0.071s)
[202.272309] [033/131] (811s left) gem_softpin (evict-active-interruptible)
[202.325270] Starting subtest: evict-active-interruptible
[202.336024] Subtest evict-active-interruptible: SUCCESS (0.011s)
[202.502666] [034/131] (811s left) sw_sync (alloc_timeline)
[202.544722] Starting subtest: alloc_timeline
[202.547205] Subtest alloc_timeline: SUCCESS (0.000s)
[202.626313] [035/131] (811s left) gem_eio (in-flight-1us)
[202.866275] Starting subtest: in-flight-1us
[211.942210] Subtest in-flight-1us: SUCCESS (9.076s)
[212.086522] [036/131] (801s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[212.187411] Starting subtest: 4-tiled-64bpp-rotate-270
[212.209237] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.018s)
[212.356223] [037/131] (801s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[212.449255] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[212.453316] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[212.587579] [038/131] (801s left) gem_mmap_offset (partial-mmap)
[212.644941] Starting subtest: partial-mmap
[212.647307] Starting dynamic subtest: smem0
[212.649577] Dynamic subtest smem0: SUCCESS (0.003s)
[212.651462] Subtest partial-mmap: SUCCESS (0.004s)
[212.808373] [039/131] (801s left) i915_selftest (perf)
[216.283093] Starting subtest: perf
[216.285556] Starting dynamic subtest: engine_cs
[220.729277] Dynamic subtest engine_cs: SUCCESS (4.445s)
[220.737908] Starting dynamic subtest: request
[228.110632] Dynamic subtest request: SUCCESS (7.380s)
[228.118701] Starting dynamic subtest: migrate
[231.128993] Dynamic subtest migrate: SUCCESS (3.017s)
[231.138086] Starting dynamic subtest: region
[235.542819] Dynamic subtest region: SUCCESS (4.412s)
[235.545372] Subtest perf: SUCCESS (19.260s)
[235.573681] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[235.574378] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[235.577482] [040/131] (778s left) kms_content_protection (dp-mst-type-1)
[237.204049] Starting subtest: dp-mst-type-1
[237.208743] Subtest dp-mst-type-1: SKIP (0.000s)
[237.316397] [FACT kms_content_protection (dp-mst-type-1)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[237.317559] [FACT kms_content_protection (dp-mst-type-1)] new: kernel.kmod_is_loaded.i915: true
[237.321189] [041/131] (776s left) gem_exec_alignment (single)
[237.395130] Starting subtest: single
[237.400692] Subtest single: SUCCESS (0.004s)
[237.561317] [042/131] (776s left) api_intel_bb (object-noreloc-keep-cache-simple)
[237.621038] Starting subtest: object-noreloc-keep-cache-simple
[237.625680] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[237.792281] [043/131] (776s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[237.848991] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[237.953954] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[238.051797] [044/131] (776s left) prime_vgem (basic-read)
[238.147506] Starting subtest: basic-read
[238.154543] Subtest basic-read: SKIP (0.005s)
[238.299423] [045/131] (776s left) perf_pmu (most-busy-idle-check-all)
[238.343697] Starting subtest: most-busy-idle-check-all
[238.346070] Starting dynamic subtest: rcs0
[239.896953] Dynamic subtest rcs0: SUCCESS (1.551s)
[239.906330] Starting dynamic subtest: bcs0
[241.880065] Dynamic subtest bcs0: SUCCESS (1.980s)
[241.891081] Starting dynamic subtest: vcs0
[243.926595] Dynamic subtest vcs0: SUCCESS (2.043s)
[243.937191] Starting dynamic subtest: vcs1
[245.910374] Dynamic subtest vcs1: SUCCESS (1.981s)
[245.921449] Starting dynamic subtest: vecs0
[247.894866] Dynamic subtest vecs0: SUCCESS (1.981s)
[247.905854] Starting dynamic subtest: ccs0
[249.880372] Dynamic subtest ccs0: SUCCESS (1.982s)
[249.883344] Subtest most-busy-idle-check-all: SUCCESS (11.536s)
[250.020650] [046/131] (764s left) kms_flip (flip-vs-blocking-wf-vblank)
[250.128327] Starting subtest: flip-vs-blocking-wf-vblank
[250.130244] Starting dynamic subtest: A-eDP1
[259.080823] Dynamic subtest A-eDP1: SUCCESS (8.954s)
[259.093263] Starting dynamic subtest: B-eDP1
[268.006157] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[268.017325] Starting dynamic subtest: C-eDP1
[276.935058] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[276.943827] Starting dynamic subtest: D-eDP1
[285.868817] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[285.871116] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.741s)
[287.115939] [047/131] (727s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[287.231234] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[287.235578] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[287.377391] [048/131] (727s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[287.445725] Starting subtest: multi-wait-all-for-submit-available-submitted
[287.448167] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[287.590188] [049/131] (726s left) api_intel_allocator (execbuf-with-allocator)
[287.661346] Starting subtest: execbuf-with-allocator
[287.663712] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[287.826936] [050/131] (726s left) gem_lmem_swapping (parallel-random)
[287.874990] Subtest parallel-random: SKIP (0.000s)
[287.914213] [051/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[288.027701] Starting subtest: fbcpsr-1p-rte
[294.980027] Subtest fbcpsr-1p-rte: SUCCESS (6.955s)
[295.150389] [052/131] (719s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[295.252897] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[295.257399] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[295.381651] [053/131] (719s left) gem_exec_schedule (preempt-engines)
[295.457488] Starting subtest: preempt-engines
[295.459725] Starting dynamic subtest: rcs0
[297.667617] Dynamic subtest rcs0: SUCCESS (2.217s)
[297.677759] Starting dynamic subtest: bcs0
[299.922067] Dynamic subtest bcs0: SUCCESS (2.252s)
[299.930725] Starting dynamic subtest: vcs0
[302.166818] Dynamic subtest vcs0: SUCCESS (2.242s)
[302.174814] Starting dynamic subtest: vcs1
[304.432487] Dynamic subtest vcs1: SUCCESS (2.263s)
[304.444439] Starting dynamic subtest: vecs0
[306.672077] Dynamic subtest vecs0: SUCCESS (2.238s)
[306.683286] Starting dynamic subtest: ccs0
[308.944644] Dynamic subtest ccs0: SUCCESS (2.271s)
[308.947067] Subtest preempt-engines: SUCCESS (13.495s)
[309.273423] [054/131] (705s left) gen9_exec_parse (secure-batches)
[309.332237] Subtest secure-batches: SKIP (0.000s)
[309.420471] [055/131] (705s left) kms_getfb (getfb-addfb-different-handles)
[309.522101] Starting subtest: getfb-addfb-different-handles
[309.524334] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[309.659481] [056/131] (705s left) kms_pm_rpm (modeset-lpsp)
[311.188057] Starting subtest: modeset-lpsp
[312.656665] Subtest modeset-lpsp: SUCCESS (1.471s)
[312.767985] [057/131] (702s left) kms_atomic_interruptible (universal-setplane-cursor)
[312.862386] Starting subtest: universal-setplane-cursor
[312.864710] Starting dynamic subtest: pipe-A-eDP-1
[320.226129] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.364s)
[320.228513] Subtest universal-setplane-cursor: SUCCESS (7.365s)
[321.095127] [058/131] (693s left) i915_query (query-topology-kernel-writes)
[321.176974] Starting subtest: query-topology-kernel-writes
[321.179679] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[321.313285] [059/131] (693s left) gem_tiled_wb
[321.443577] [060/131] (693s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[321.538485] Starting subtest: yf-tiled-8bpp-rotate-180
[321.542998] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[321.672663] [061/131] (693s left) kms_plane_scaling (planes-downscale-factor-0-5)
[321.764297] Starting subtest: planes-downscale-factor-0-5
[321.766651] Starting dynamic subtest: pipe-A
[321.784324] Dynamic subtest pipe-A: SKIP (0.017s)
[321.792637] Starting dynamic subtest: pipe-B
[321.817864] Dynamic subtest pipe-B: SKIP (0.031s)
[321.826115] Starting dynamic subtest: pipe-C
[321.848215] Dynamic subtest pipe-C: SKIP (0.029s)
[321.855760] Starting dynamic subtest: pipe-D
[321.875875] Dynamic subtest pipe-D: SKIP (0.029s)
[321.880121] Subtest planes-downscale-factor-0-5: SKIP (0.110s)
[322.000281] [062/131] (693s left) gem_exec_schedule (preempt-queue-contexts-chain)
[322.070144] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[322.378440] [063/131] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[322.484115] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[326.094610] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.614s)
[327.304110] [064/131] (687s left) kms_invalid_mode (bad-vtotal)
[327.401071] Starting subtest: bad-vtotal
[327.403211] Starting dynamic subtest: pipe-A-eDP-1
[327.686399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[327.694308] Starting dynamic subtest: pipe-B-eDP-1
[327.696178] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[327.703240] Starting dynamic subtest: pipe-C-eDP-1
[327.705098] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[327.712477] Starting dynamic subtest: pipe-D-eDP-1
[327.714593] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[327.716721] Subtest bad-vtotal: SUCCESS (0.290s)
[328.522073] [065/131] (686s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[328.617052] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[328.619390] Starting dynamic subtest: pipe-A-eDP-1
[328.640830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[328.654762] Starting dynamic subtest: pipe-B-eDP-1
[328.673857] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[328.682783] Starting dynamic subtest: pipe-C-eDP-1
[328.702116] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[328.710928] Starting dynamic subtest: pipe-D-eDP-1
[328.730393] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[328.732596] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[330.797294] [066/131] (684s left) gem_exec_balancer (invalid-balancer)
[330.864318] Starting subtest: invalid-balancer
[331.712267] Subtest invalid-balancer: SUCCESS (0.849s)
[332.039114] [067/131] (683s left) kms_plane_scaling (planes-upscale-20x20)
[332.145858] Starting subtest: planes-upscale-20x20
[332.147990] Starting dynamic subtest: pipe-A
[332.207351] Dynamic subtest pipe-A: SUCCESS (0.063s)
[332.219610] Starting dynamic subtest: pipe-B
[333.299937] Dynamic subtest pipe-B: SUCCESS (1.091s)
[333.310078] Starting dynamic subtest: pipe-C
[334.415931] Dynamic subtest pipe-C: SUCCESS (1.115s)
[334.425685] Starting dynamic subtest: pipe-D
[335.547776] Dynamic subtest pipe-D: SUCCESS (1.131s)
[335.550099] Subtest planes-upscale-20x20: SUCCESS (3.406s)
[336.740687] [068/131] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[336.849717] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[336.854268] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[336.967707] [069/131] (678s left) gem_mmap_wc (read-write)
[337.016506] Subtest read-write: SKIP (0.000s)
[337.068342] [070/131] (678s left) gem_pxp (create-regular-context-1)
[337.182057] Starting subtest: create-regular-context-1
[337.184493] Subtest create-regular-context-1: SUCCESS (0.002s)
[337.338452] [071/131] (678s left) kms_addfb_basic (invalid-get-prop)
[337.400618] Starting subtest: invalid-get-prop
[337.403033] Subtest invalid-get-prop: SUCCESS (0.000s)
[337.560610] [072/131] (677s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[337.655427] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[342.110785] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.458s)
[343.247318] [073/131] (672s left) syncobj_timeline (wait-all-complex)
[343.308550] Starting subtest: wait-all-complex
[343.521443] Subtest wait-all-complex: SUCCESS (0.213s)
[343.623878] [074/131] (671s left) gem_softpin (zero)
[343.677556] Starting subtest: zero
[343.684822] Subtest zero: SUCCESS (0.005s)
[343.841273] [075/131] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[343.941521] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[343.945940] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[344.059262] [076/131] (671s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[344.155154] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[344.157432] Starting dynamic subtest: pipe-A-eDP-1
[344.180896] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[344.191723] Starting dynamic subtest: pipe-B-eDP-1
[344.214035] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[344.221414] Starting dynamic subtest: pipe-C-eDP-1
[344.242343] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[344.249467] Starting dynamic subtest: pipe-D-eDP-1
[344.270721] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[344.274990] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[346.401539] [077/131] (669s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[346.524329] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[347.959779] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.435s)
[348.782227] [078/131] (666s left) kms_vrr (negative-basic)
[348.880169] Starting subtest: negative-basic
[348.886892] Starting dynamic subtest: pipe-A-eDP-1
[354.302629] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.415s)
[354.592891] Subtest negative-basic: SUCCESS (5.714s)
[355.413593] [079/131] (660s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[355.512144] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[355.514054] Starting dynamic subtest: pipe-A-default-mode
[355.814712] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[355.819202] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.302s)
[356.640399] [080/131] (659s left) syncobj_timeline (single-wait-all-available-signaled)
[356.702355] Starting subtest: single-wait-all-available-signaled
[356.704626] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[356.832984] [081/131] (658s left) gem_reg_read (bad-register)
[356.892035] Starting subtest: bad-register
[356.894351] Subtest bad-register: SUCCESS (0.000s)
[357.021916] [082/131] (658s left) gem_exec_fence (basic-wait-all)
[357.089875] Starting subtest: basic-wait-all
[357.194121] Subtest basic-wait-all: SUCCESS (0.105s)
[358.985423] [083/131] (656s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[359.093514] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[359.097697] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[359.238559] [084/131] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[359.347555] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[359.351923] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[359.486941] [085/131] (656s left) gem_ctx_persistence (engines-queued)
[359.544473] Starting subtest: engines-queued
[359.546936] Starting dynamic subtest: rcs0
[359.654594] Dynamic subtest rcs0: SUCCESS (0.109s)
[359.665817] Starting dynamic subtest: bcs0
[359.676293] Dynamic subtest bcs0: SUCCESS (0.020s)
[359.683796] Starting dynamic subtest: vcs0
[360.884943] Dynamic subtest vcs0: SUCCESS (1.206s)
[360.896151] Starting dynamic subtest: vcs1
[362.867275] Dynamic subtest vcs1: SUCCESS (1.979s)
[362.878161] Starting dynamic subtest: vecs0
[364.851743] Dynamic subtest vecs0: SUCCESS (1.982s)
[364.862606] Starting dynamic subtest: ccs0
[365.034147] Dynamic subtest ccs0: SUCCESS (0.181s)
[365.036495] Subtest engines-queued: SUCCESS (5.491s)
[365.200469] [086/131] (650s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[365.312056] Starting subtest: fbcpsr-rgb565-draw-render
[372.298502] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.988s)
[372.456465] [087/131] (643s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[372.558139] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[372.562747] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[372.676439] [088/131] (643s left) gem_create (create-ext-placement-each)
[372.852742] Starting subtest: create-ext-placement-each
[372.855366] Subtest create-ext-placement-each: SUCCESS (0.000s)
[372.991950] [089/131] (643s left) kms_psr2_su (page_flip-p010)
[373.053873] Subtest page_flip-P010: SKIP (0.000s)
[373.120418] [090/131] (643s left) kms_plane_multiple (tiling-x)
[373.217644] Starting subtest: tiling-x
[373.219914] Starting dynamic subtest: pipe-A-eDP-1
[376.854682] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.636s)
[376.863328] Starting dynamic subtest: pipe-B-eDP-1
[381.289414] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.435s)
[381.297742] Starting dynamic subtest: pipe-C-eDP-1
[385.613739] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.321s)
[385.624177] Starting dynamic subtest: pipe-D-eDP-1
[390.039552] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.426s)
[390.041883] Subtest tiling-x: SUCCESS (16.824s)
[390.884078] [091/131] (625s left) kms_frontbuffer_tracking (fbc-tiling-4)
[390.986667] Starting subtest: fbc-tiling-4
[395.161222] Subtest fbc-tiling-4: SUCCESS (4.178s)
[396.398345] [092/131] (619s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[396.501243] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[396.503626] Starting dynamic subtest: pipe-A-eDP-1
[398.610205] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[398.618553] Starting dynamic subtest: pipe-B-eDP-1
[400.770933] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.159s)
[400.779054] Starting dynamic subtest: pipe-C-eDP-1
[402.791649] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.020s)
[402.801410] Starting dynamic subtest: pipe-D-eDP-1
[404.823375] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.031s)
[404.825728] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.325s)
[406.096520] [093/131] (610s left) prime_mmap (test_aperture_limit)
[406.161866] Starting subtest: test_aperture_limit
[406.164029] Starting dynamic subtest: test_aperture_limit-smem
[406.182515] Dynamic subtest test_aperture_limit-smem: SKIP (0.020s)
[406.187458] Subtest test_aperture_limit: SKIP (0.021s)
[406.286422] [094/131] (610s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[406.374347] Starting subtest: addfb25-yf-tiled-legacy
[406.376246] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[406.510285] [095/131] (609s left) perf (gen12-group-concurrent-oa-buffer-read)
[406.653778] Starting subtest: gen12-group-concurrent-oa-buffer-read
[416.679327] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.024s)
[416.724118] [096/131] (599s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[416.822413] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[416.826766] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[416.947562] [097/131] (599s left) kms_psr (pr-no-drrs)
[417.030958] Starting subtest: pr-no-drrs
[417.035169] Subtest pr-no-drrs: SKIP (0.000s)
[417.130122] [098/131] (599s left) kms_cursor_crc (cursor-offscreen-128x128)
[417.346804] Starting subtest: cursor-offscreen-128x128
[417.354489] Starting dynamic subtest: pipe-A-eDP-1
[419.282722] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[419.311870] Starting dynamic subtest: pipe-D-eDP-1
[421.866772] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[421.869106] Subtest cursor-offscreen-128x128: SUCCESS (4.518s)
[422.741883] [099/131] (593s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[422.847932] Starting subtest: primary-x-tiled-reflect-x-180
[429.986708] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.141s)
[431.194061] [100/131] (585s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[431.252282] Starting subtest: etime-multi-wait-for-submit-submitted
[431.352182] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[431.452539] [101/131] (585s left) gem_exec_balancer (parallel-out-fence)
[431.712914] Starting subtest: parallel-out-fence
[432.841915] Subtest parallel-out-fence: SUCCESS (1.129s)
[432.991303] [102/131] (583s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[433.098258] Starting subtest: fbc-rgb101010-draw-pwrite
[438.379208] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.283s)
[439.569861] [103/131] (577s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[439.643765] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[439.648265] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[439.848308] [104/131] (576s left) i915_pm_rpm (gem-idle)
[442.077984] Starting subtest: gem-idle
[448.281225] Subtest gem-idle: SUCCESS (6.203s)
[448.628721] [105/131] (568s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[449.849556] Starting subtest: framebuffer-vs-set-tiling
[449.854522] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[450.012680] [106/131] (566s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[450.403418] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[451.218071] [107/131] (565s left) gem_pxp (verify-pxp-stale-ctx-execution)
[451.329678] Starting subtest: verify-pxp-stale-ctx-execution
[452.399203] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.068s)
[452.566387] [108/131] (564s left) gem_exec_whisper (basic-normal)
[452.640070] Starting subtest: basic-normal
[457.038567] Subtest basic-normal: SUCCESS (4.399s)
[457.251335] [109/131] (559s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[457.345980] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[457.347913] Starting dynamic subtest: pipe-A-eDP-1
[457.368040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[457.377924] Starting dynamic subtest: pipe-B-eDP-1
[457.397380] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[457.405832] Starting dynamic subtest: pipe-C-eDP-1
[457.425698] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[457.434207] Starting dynamic subtest: pipe-D-eDP-1
[457.454191] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[457.456430] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s)
[459.632603] [110/131] (557s left) kms_flip (modeset-vs-vblank-race-interruptible)
[459.739391] Starting subtest: modeset-vs-vblank-race-interruptible
[459.741703] Starting dynamic subtest: A-eDP1
[464.437810] Dynamic subtest A-eDP1: SUCCESS (4.698s)
[464.448845] Starting dynamic subtest: B-eDP1
[469.073696] Dynamic subtest B-eDP1: SUCCESS (4.633s)
[469.084786] Starting dynamic subtest: C-eDP1
[473.591747] Dynamic subtest C-eDP1: SUCCESS (4.516s)
[473.601173] Starting dynamic subtest: D-eDP1
[478.116297] Dynamic subtest D-eDP1: SUCCESS (4.523s)
[478.121327] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.380s)
[479.298494] [111/131] (537s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[484.371079] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[484.373391] Starting dynamic subtest: pipe-A-eDP-1
[496.065661] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.692s)
[496.075239] Starting dynamic subtest: pipe-B-eDP-1
[507.813202] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.746s)
[507.815736] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.442s)
[508.679531] [112/131] (508s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[508.795655] Starting subtest: fbcpsr-shrfb-scaledprimary
[514.571036] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.777s)
[514.742931] [113/131] (502s left) kms_psr (fbc-psr-sprite-plane-onoff)
[514.834191] Starting subtest: fbc-psr-sprite-plane-onoff
[514.836505] Starting dynamic subtest: eDP-1
[514.840848] Dynamic subtest eDP-1: SKIP (0.000s)
[514.845185] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[514.938956] [114/131] (502s left) gem_partial_pwrite_pread (writes-after-reads)
[515.011146] Subtest writes-after-reads: SKIP (0.000s)
[515.108891] [115/131] (502s left) kms_selftest (drm_format)
[515.144091] Starting subtest: drm_format
[515.176425] Starting dynamic subtest: drm_test_format_block_width_invalid
[515.305224] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.128s)
[515.315385] Starting dynamic subtest: drm_test_format_block_width_one_plane
[515.440493] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.134s)
[515.448370] Starting dynamic subtest: drm_test_format_block_width_two_plane
[515.571079] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.130s)
[515.580938] Starting dynamic subtest: drm_test_format_block_width_three_plane
[515.722953] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.151s)
[515.731820] Starting dynamic subtest: drm_test_format_block_width_tiled
[515.856292] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.133s)
[515.865127] Starting dynamic subtest: drm_test_format_block_height_invalid
[515.986536] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.130s)
[515.994831] Starting dynamic subtest: drm_test_format_block_height_one_plane
[516.109492] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.121s)
[516.124069] Starting dynamic subtest: drm_test_format_block_height_two_plane
[516.265049] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.155s)
[516.274536] Starting dynamic subtest: drm_test_format_block_height_three_plane
[516.402210] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.136s)
[516.412099] Starting dynamic subtest: drm_test_format_block_height_tiled
[516.530867] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.129s)
[516.538590] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[516.669958] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.138s)
[516.677906] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[516.808121] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.137s)
[516.816334] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[516.941199] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.132s)
[516.950590] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[517.094346] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.153s)
[517.102057] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[517.203159] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.108s)
[517.211136] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[517.327822] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.123s)
[517.335982] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[517.456892] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.130s)
[517.464561] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[517.587175] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.128s)
[517.589511] Subtest drm_format: SUCCESS (2.441s)
[517.760209] [116/131] (499s left) kms_vblank (invalid)
[517.856786] Starting subtest: invalid
[517.858921] Starting dynamic subtest: pipe-A-eDP-1
[518.253782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[518.256265] Subtest invalid: SUCCESS (0.398s)
[519.142672] [117/131] (498s left) gem_exec_reloc (basic-cpu-wc-active)
[519.214223] Subtest basic-cpu-wc-active: SKIP (0.000s)
[519.298066] [118/131] (498s left) gem_tiled_partial_pwrite_pread (reads)
[519.350329] Subtest reads: SKIP (0.000s)
[519.440247] [119/131] (497s left) kms_big_fb (linear-8bpp-rotate-180)
[519.538112] Starting subtest: linear-8bpp-rotate-180
[520.706508] Subtest linear-8bpp-rotate-180: SUCCESS (1.168s)
[520.873963] [120/131] (496s left) kms_dp_aux_dev
[521.259610] [121/131] (496s left) syncobj_eventfd (binary-wait-signaled)
[521.322628] Starting subtest: binary-wait-signaled
[521.325049] Subtest binary-wait-signaled: SUCCESS (0.000s)
[521.444510] [122/131] (496s left) gem_softpin (evict-snoop-interruptible)
[521.505689] Starting subtest: evict-snoop-interruptible
[521.510353] Subtest evict-snoop-interruptible: SKIP (0.000s)
[521.663927] [123/131] (495s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[526.688622] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[526.690910] Starting dynamic subtest: pipe-A-eDP-1
[527.477337] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[527.486923] Starting dynamic subtest: pipe-B-eDP-1
[528.598328] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[528.602812] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.909s)
[529.815382] [124/131] (487s left) sysfs_timeslice_duration (invalid)
[529.881030] Starting subtest: invalid
[529.883337] Starting dynamic subtest: vecs0
[529.885715] Dynamic subtest vecs0: SUCCESS (0.000s)
[529.898877] Starting dynamic subtest: ccs0
[529.901243] Dynamic subtest ccs0: SUCCESS (0.000s)
[529.909089] Starting dynamic subtest: vcs0
[529.911227] Dynamic subtest vcs0: SUCCESS (0.000s)
[529.918948] Starting dynamic subtest: bcs0
[529.921112] Dynamic subtest bcs0: SUCCESS (0.000s)
[529.928846] Starting dynamic subtest: rcs0
[529.931062] Dynamic subtest rcs0: SUCCESS (0.000s)
[529.938790] Starting dynamic subtest: vcs1
[529.941062] Dynamic subtest vcs1: SUCCESS (0.000s)
[529.943278] Subtest invalid: SUCCESS (0.005s)
[530.028131] [125/131] (487s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[530.121609] Starting subtest: fbc-psr2-sprite-mmap-cpu
[530.123646] Starting dynamic subtest: eDP-1
[530.127844] Dynamic subtest eDP-1: SKIP (0.000s)
[530.132096] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[530.219949] [126/131] (487s left) drm_read (fault-buffer)
[530.368961] Starting subtest: fault-buffer
[530.371470] Subtest fault-buffer: SUCCESS (0.001s)
[530.545102] [127/131] (487s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[530.657756] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[531.292663] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.636s)
[531.586428] [128/131] (486s left) kms_cursor_crc (cursor-sliding-128x128)
[531.824703] Starting subtest: cursor-sliding-128x128
[531.830091] Starting dynamic subtest: pipe-A-eDP-1
[535.095072] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.264s)
[535.119751] Starting dynamic subtest: pipe-D-eDP-1
[539.013594] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.899s)
[539.016059] Subtest cursor-sliding-128x128: SUCCESS (7.187s)
[539.874595] [129/131] (477s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[539.976656] Starting subtest: fbc-indfb-scaledprimary
[542.975060] Subtest fbc-indfb-scaledprimary: SUCCESS (3.001s)
[544.164589] [130/131] (473s left) kms_atomic (plane-invalid-params-fence)
[544.259368] Starting subtest: plane-invalid-params-fence
[544.261774] Starting dynamic subtest: pipe-A-eDP-1
[544.616352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[544.618649] Subtest plane-invalid-params-fence: SUCCESS (0.356s)
[545.498774] [131/131] (472s left) core_setmaster (master-drop-set-shared-fd)
[545.607634] Starting subtest: master-drop-set-shared-fd
[545.626338] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[545.663129] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_ppgtt
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: i915_pm_freq_api
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_partial_pwrite_pread
results: parsing output: 10/ for test: gem_ctx_exec
results: parsing output: 11/ for test: kms_atomic_transition
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_dsc
results: parsing output: 15/ for test: kms_chamelium_color
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_busy
results: parsing output: 22/ for test: gem_exec_flush
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_prop_blob
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_ctx_shared
results: parsing output: 31/ for test: tools_test
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: sw_sync
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: i915_selftest
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: gem_exec_alignment
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: prime_vgem
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_getfb
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: kms_atomic_interruptible
results: parsing output: 57/ for test: i915_query
results: parsing output: 58/ for test: gem_tiled_wb
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_invalid_mode
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_vrr
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_reg_read
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_create
results: parsing output: 88/ for test: kms_psr2_su
results: parsing output: 89/ for test: kms_plane_multiple
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: prime_mmap
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_chamelium_edid
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: kms_selftest
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_dp_aux_dev
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: sysfs_timeslice_duration
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: drm_read
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_atomic
results: parsing output: 130/ for test: core_setmaster
Done.