[60.549830] Initializing watchdogs
[60.549875]   /dev/watchdog0
[60.565380] [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]
[60.570328] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.572617] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.576319] [001/156] (960s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[60.676139] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[60.678510] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[60.784908] [002/156] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[60.895287] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[61.952638] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.046s)
[62.071917] [003/156] (959s left) syncobj_timeline (multi-wait-available-submitted)
[62.130611] Starting subtest: multi-wait-available-submitted
[62.132478] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[62.236007] [004/156] (958s left) dumb_buffer (create-clear)
[62.290082] Starting subtest: create-clear
[96.792793] Subtest create-clear: SUCCESS (34.422s)
[96.917189] [005/156] (924s left) syncobj_basic (bad-pad-handle-to-fd)
[96.977796] Starting subtest: bad-pad-handle-to-fd
[96.979740] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[97.074240] [006/156] (924s left) kms_dp_linktrain_fallback (dp-fallback)
[97.166686] Starting subtest: dp-fallback
[97.173093] Subtest dp-fallback: SKIP (0.000s)
[97.235446] [007/156] (924s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[97.352273] Starting subtest: cursorB-vs-flipB-legacy
[97.356868] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[97.500058] [008/156] (923s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[97.588832] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[97.591226] Starting dynamic subtest: pipe-A-default-mode
[98.715515] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[98.719811] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.122s)
[98.842294] [009/156] (922s left) kms_addfb_basic (unused-handle)
[98.907557] Starting subtest: unused-handle
[98.909890] Subtest unused-handle: SUCCESS (0.000s)
[99.035069] [010/156] (922s left) i915_selftest (live)
[100.707839] Starting subtest: live
[100.710674] Starting dynamic subtest: sanitycheck
[105.074704] Dynamic subtest sanitycheck: SUCCESS (4.365s)
[105.083540] Starting dynamic subtest: uncore
[107.757104] Dynamic subtest uncore: SUCCESS (2.680s)
[107.766308] Starting dynamic subtest: workarounds
[110.885930] Dynamic subtest workarounds: SUCCESS (3.127s)
[110.894648] Starting dynamic subtest: gt_engines
[113.954902] Dynamic subtest gt_engines: SUCCESS (3.068s)
[113.961458] Starting dynamic subtest: gt_timelines
[131.691349] Dynamic subtest gt_timelines: SUCCESS (17.731s)
[131.700109] Starting dynamic subtest: gt_contexts
[136.066832] Dynamic subtest gt_contexts: SUCCESS (4.374s)
[136.076661] Starting dynamic subtest: gt_lrc
[140.467659] Dynamic subtest gt_lrc: SUCCESS (4.398s)
[140.478766] Starting dynamic subtest: gt_mocs
[144.926775] Dynamic subtest gt_mocs: SUCCESS (4.458s)
[144.936070] Starting dynamic subtest: gt_pm
[151.722216] Dynamic subtest gt_pm: SUCCESS (6.794s)
[151.731134] Starting dynamic subtest: gt_heartbeat
[156.090275] Dynamic subtest gt_heartbeat: SUCCESS (4.368s)
[156.102018] Starting dynamic subtest: gt_tlb
[165.358944] Dynamic subtest gt_tlb: SUCCESS (9.269s)
[165.367927] Starting dynamic subtest: requests
[176.851959] Dynamic subtest requests: SUCCESS (11.493s)
[176.861473] Starting dynamic subtest: migrate
[184.627290] Dynamic subtest migrate: SUCCESS (7.774s)
[184.635327] Starting dynamic subtest: active
[188.934439] Dynamic subtest active: SUCCESS (4.306s)
[188.944651] Starting dynamic subtest: objects
[193.638020] Dynamic subtest objects: SUCCESS (4.703s)
[193.646334] Starting dynamic subtest: mman
[196.930063] Dynamic subtest mman: SUCCESS (3.290s)
[196.939293] Starting dynamic subtest: dmabuf
[201.375250] Dynamic subtest dmabuf: SUCCESS (4.444s)
[201.385046] Starting dynamic subtest: vma
[205.746474] Dynamic subtest vma: SUCCESS (4.370s)
[205.755722] Starting dynamic subtest: coherency
[209.806040] Dynamic subtest coherency: SUCCESS (4.057s)
[209.815423] Starting dynamic subtest: gtt
[221.707378] Dynamic subtest gtt: SUCCESS (11.899s)
[221.716458] Starting dynamic subtest: gem
[229.982390] Dynamic subtest gem: SUCCESS (8.274s)
[229.991813] Starting dynamic subtest: evict
[234.006783] Dynamic subtest evict: SUCCESS (4.023s)
[234.020672] Starting dynamic subtest: hugepages
[244.804722] Dynamic subtest hugepages: SUCCESS (10.795s)
[244.815629] Starting dynamic subtest: gem_contexts
[273.288416] Dynamic subtest gem_contexts: SUCCESS (28.480s)
[273.302500] Starting dynamic subtest: client
[277.633688] Dynamic subtest client: SUCCESS (4.343s)
[277.643459] Starting dynamic subtest: gem_migrate
[282.040757] Dynamic subtest gem_migrate: SUCCESS (4.407s)
[282.048905] Starting dynamic subtest: reset
[286.378230] Dynamic subtest reset: SUCCESS (4.336s)
[286.387651] Starting dynamic subtest: memory_region
[290.692056] Dynamic subtest memory_region: SUCCESS (4.313s)
[290.700882] Starting dynamic subtest: hangcheck
[303.689775] Dynamic subtest hangcheck: SUCCESS (12.996s)
[303.702785] Starting dynamic subtest: execlists
[308.056797] Dynamic subtest execlists: SUCCESS (4.366s)
[308.065851] Starting dynamic subtest: ring_submission
[312.430758] Dynamic subtest ring_submission: SUCCESS (4.372s)
[312.440271] Starting dynamic subtest: perf
[315.263398] Dynamic subtest perf: SUCCESS (2.832s)
[315.273177] Starting dynamic subtest: slpc
[327.273347] Dynamic subtest slpc: SUCCESS (12.008s)
[327.280876] Starting dynamic subtest: guc
[331.193348] Dynamic subtest guc: SUCCESS (3.919s)
[331.204938] Starting dynamic subtest: guc_multi_lrc
[335.499563] Dynamic subtest guc_multi_lrc: SUCCESS (4.304s)
[335.507553] Starting dynamic subtest: guc_hang
[340.343416] Dynamic subtest guc_hang: SUCCESS (4.841s)
[340.350908] Starting dynamic subtest: late_gt_pm
[344.638556] Dynamic subtest late_gt_pm: SUCCESS (4.293s)
[344.641552] Subtest live: SUCCESS (243.915s)
[344.669949] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[344.674115] [011/156] (676s left) gem_render_copy (yf-tiled-ccs-to-linear)
[346.242531] Starting subtest: yf-tiled-ccs-to-linear
[346.246898] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[346.393920] [FACT gem_render_copy (yf-tiled-ccs-to-linear)] new: kernel.kmod_is_loaded.i915: true
[346.397550] [012/156] (675s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[346.513747] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[346.516041] Starting dynamic subtest: pipe-A-eDP-1
[346.574992] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[346.583697] Starting dynamic subtest: pipe-B-eDP-1
[346.642315] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[346.652191] Starting dynamic subtest: pipe-C-eDP-1
[346.709266] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[346.717644] Starting dynamic subtest: pipe-D-eDP-1
[346.771866] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[346.775988] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[348.843201] [013/156] (672s left) gem_exec_balancer (noheartbeat)
[349.116768] Starting subtest: noheartbeat
[349.121368] Subtest noheartbeat: SKIP (0.000s)
[349.225009] [014/156] (672s left) kms_async_flips (crc)
[349.314831] Starting subtest: crc
[349.706216] Starting dynamic subtest: pipe-A-eDP-1
[352.682584] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.974s)
[353.065933] Starting dynamic subtest: pipe-B-eDP-1
[356.009480] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.953s)
[356.400278] Starting dynamic subtest: pipe-C-eDP-1
[359.336060] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.945s)
[359.709821] Starting dynamic subtest: pipe-D-eDP-1
[362.577353] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.875s)
[362.579615] Subtest crc: SUCCESS (13.264s)
[363.751182] [015/156] (657s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[363.852916] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[363.855259] Starting dynamic subtest: pipe-A-eDP-1
[363.878495] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.888456] Starting dynamic subtest: pipe-B-eDP-1
[363.910281] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.918854] Starting dynamic subtest: pipe-C-eDP-1
[363.940741] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.951042] Starting dynamic subtest: pipe-D-eDP-1
[363.973346] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.977446] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[366.115819] [016/156] (655s left) kms_psr (psr2-dpms)
[366.206831] Starting subtest: psr2-dpms
[366.209119] Starting dynamic subtest: eDP-1
[369.149615] Dynamic subtest eDP-1: SUCCESS (2.942s)
[369.151506] Subtest psr2-dpms: SUCCESS (2.943s)
[370.018421] [017/156] (651s left) kms_flip (2x-nonexisting-fb)
[370.104889] Starting subtest: 2x-nonexisting-fb
[370.114538] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[370.193909] [018/156] (651s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[370.290261] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[370.294743] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[370.393820] [019/156] (651s left) kms_legacy_colorkey (invalid-plane)
[370.484858] Starting subtest: invalid-plane
[370.487194] Starting dynamic subtest: zero-id
[370.489071] Dynamic subtest zero-id: SUCCESS (0.000s)
[370.497390] Starting dynamic subtest: outrange-id
[370.499704] Dynamic subtest outrange-id: SUCCESS (0.000s)
[370.501924] Subtest invalid-plane: SUCCESS (0.001s)
[370.552950] [020/156] (651s left) perf_pmu (init-wait)
[370.594055] Starting subtest: init-wait
[370.596362] Starting dynamic subtest: rcs0
[370.598729] Dynamic subtest rcs0: SUCCESS (0.002s)
[370.609349] Starting dynamic subtest: bcs0
[370.611618] Dynamic subtest bcs0: SUCCESS (0.000s)
[370.619662] Starting dynamic subtest: vcs0
[370.621952] Dynamic subtest vcs0: SUCCESS (0.001s)
[370.630093] Starting dynamic subtest: vcs1
[370.632325] Dynamic subtest vcs1: SUCCESS (0.001s)
[370.640306] Starting dynamic subtest: vecs0
[370.642222] Dynamic subtest vecs0: SUCCESS (0.001s)
[370.650128] Starting dynamic subtest: ccs0
[370.652254] Dynamic subtest ccs0: SUCCESS (0.000s)
[370.654410] Subtest init-wait: SUCCESS (0.009s)
[370.692306] [021/156] (651s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[370.789926] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[370.794199] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[370.885930] [022/156] (650s left) kms_vrr (flip-dpms)
[370.978441] Starting subtest: flip-dpms
[370.984013] Subtest flip-dpms: SKIP (0.000s)
[371.046602] [023/156] (650s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[371.096169] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[371.097958] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[371.189131] [024/156] (650s left) kms_psr (fbc-psr2-sprite-render)
[371.272345] Starting subtest: fbc-psr2-sprite-render
[371.274247] Starting dynamic subtest: eDP-1
[371.277616] Dynamic subtest eDP-1: SKIP (0.000s)
[371.280973] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[371.342786] [025/156] (650s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[371.435827] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[371.448477] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[371.522087] [026/156] (650s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[371.607442] Starting subtest: bad-rotation-90-yf-tiled-ccs
[371.609224] Starting dynamic subtest: pipe-A-eDP-1
[371.627461] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[371.636413] Starting dynamic subtest: pipe-B-eDP-1
[371.654193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[371.662274] Starting dynamic subtest: pipe-C-eDP-1
[371.679827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[371.689226] Starting dynamic subtest: pipe-D-eDP-1
[371.707155] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[371.710534] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[373.888544] [027/156] (648s left) kms_properties (crtc-properties-legacy)
[373.978626] Starting subtest: crtc-properties-legacy
[373.980856] Starting dynamic subtest: pipe-A-eDP-1
[374.424710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[374.434414] Starting dynamic subtest: pipe-B-eDP-1
[375.550805] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.123s)
[375.561063] Starting dynamic subtest: pipe-C-eDP-1
[376.687074] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.137s)
[376.696817] Starting dynamic subtest: pipe-D-eDP-1
[377.820591] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[377.822726] Subtest crtc-properties-legacy: SUCCESS (3.841s)
[378.630372] [028/156] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[378.722910] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[383.102675] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.386s)
[384.243403] [029/156] (637s left) kms_chamelium_color (ctm-negative)
[384.340461] Subtest ctm-negative: SKIP (0.000s)
[384.385967] [030/156] (637s left) gem_pwrite (basic-random)
[384.445931] Subtest basic-random: SKIP (0.000s)
[384.505044] [031/156] (637s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[384.622459] Starting subtest: cursorA-vs-flipA-varying-size
[395.772449] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.147s)
[396.661106] [032/156] (625s left) kms_psr (psr-cursor-plane-move)
[396.755185] Starting subtest: psr-cursor-plane-move
[396.757547] Starting dynamic subtest: eDP-1
[398.459337] Dynamic subtest eDP-1: SUCCESS (1.705s)
[398.461669] Subtest psr-cursor-plane-move: SUCCESS (1.706s)
[399.322659] [033/156] (622s left) gem_exec_gttfill (multigpu-basic)
[399.499224] Starting subtest: multigpu-basic
[411.471076] Subtest multigpu-basic: SUCCESS (11.972s)
[411.526998] [034/156] (610s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[411.673555] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[411.677823] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[411.772124] [035/156] (610s left) gen9_exec_parse (bb-start-param)
[411.832664] Subtest bb-start-param: SKIP (0.000s)
[411.913947] [036/156] (610s left) sysfs_preempt_timeout (invalid)
[411.973631] Starting subtest: invalid
[411.976057] Starting dynamic subtest: vecs0
[411.978456] Dynamic subtest vecs0: SUCCESS (0.000s)
[411.989433] Starting dynamic subtest: ccs0
[411.991507] Dynamic subtest ccs0: SUCCESS (0.000s)
[412.000096] Starting dynamic subtest: vcs0
[412.001963] Dynamic subtest vcs0: SUCCESS (0.000s)
[412.010057] Starting dynamic subtest: bcs0
[412.011938] Dynamic subtest bcs0: SUCCESS (0.000s)
[412.020092] Starting dynamic subtest: rcs0
[412.021983] Dynamic subtest rcs0: SUCCESS (0.000s)
[412.030779] Starting dynamic subtest: vcs1
[412.032991] Dynamic subtest vcs1: SUCCESS (0.000s)
[412.035216] Subtest invalid: SUCCESS (0.006s)
[412.087542] [037/156] (610s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[412.187566] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[412.192082] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[412.296927] [038/156] (610s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[412.450298] Starting subtest: cursor-rapid-movement-32x10
[412.498361] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[412.757425] [039/156] (609s left) kms_force_connector_basic (force-load-detect)
[412.833019] Starting subtest: force-load-detect
[412.837035] Subtest force-load-detect: SKIP (0.000s)
[412.957154] [040/156] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[413.050495] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[413.053904] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[413.145223] [041/156] (609s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[413.282936] Starting subtest: cursor-vs-flip-toggle
[444.612873] Subtest cursor-vs-flip-toggle: SUCCESS (31.325s)
[445.448558] [042/156] (577s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[445.550721] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[445.555207] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[445.657099] [043/156] (577s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[445.761584] Starting subtest: 4-tiled-8bpp-rotate-270
[445.784075] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[445.885760] [044/156] (576s left) gem_exec_whisper (basic-forked)
[445.950634] Starting subtest: basic-forked
[452.862332] Subtest basic-forked: SUCCESS (6.909s)
[453.058158] [045/156] (569s left) syncobj_wait (multi-wait-all-signaled)
[453.105890] Starting subtest: multi-wait-all-signaled
[453.108339] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[453.202508] [046/156] (569s left) kms_plane_multiple (2x-tiling-x)
[453.291019] Starting subtest: 2x-tiling-x
[453.295397] Subtest 2x-tiling-x: SKIP (0.000s)
[453.378410] [047/156] (569s left) gem_exec_flush (basic-wb-prw-default)
[453.440603] Starting subtest: basic-wb-prw-default
[458.936971] Subtest basic-wb-prw-default: SUCCESS (5.495s)
[459.127505] [048/156] (563s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-blt)
[459.244869] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-blt
[459.249554] Subtest hdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[459.347132] [049/156] (563s left) kms_atomic (crtc-invalid-params-fence)
[459.453365] Starting subtest: crtc-invalid-params-fence
[459.455509] Starting dynamic subtest: pipe-A-eDP-1
[459.867435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[459.869725] Subtest crtc-invalid-params-fence: SUCCESS (0.416s)
[460.698670] [050/156] (562s left) kms_psr (psr-sprite-plane-move)
[460.797506] Starting subtest: psr-sprite-plane-move
[460.799651] Starting dynamic subtest: eDP-1
[462.512690] Dynamic subtest eDP-1: SUCCESS (1.712s)
[462.514811] Subtest psr-sprite-plane-move: SUCCESS (1.713s)
[463.386451] [051/156] (559s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[463.474908] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[463.477307] Starting dynamic subtest: pipe-A-eDP-1
[463.500256] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.511013] Starting dynamic subtest: pipe-B-eDP-1
[463.531686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.541498] Starting dynamic subtest: pipe-C-eDP-1
[463.562630] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.571937] Starting dynamic subtest: pipe-D-eDP-1
[463.594033] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.598080] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[465.729340] [052/156] (557s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[465.826963] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[465.830990] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[465.920949] [053/156] (557s left) kms_universal_plane (disable-primary-vs-flip)
[466.008132] Starting subtest: disable-primary-vs-flip
[466.010426] Starting dynamic subtest: pipe-A-eDP-1
[467.605927] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.597s)
[467.616373] Starting dynamic subtest: pipe-B-eDP-1
[469.888455] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.280s)
[469.898892] Starting dynamic subtest: pipe-C-eDP-1
[472.072855] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.185s)
[472.082941] Starting dynamic subtest: pipe-D-eDP-1
[474.252682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.176s)
[474.255071] Subtest disable-primary-vs-flip: SUCCESS (8.245s)
[475.141585] [054/156] (548s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[475.239611] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[475.244124] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[475.344283] [055/156] (547s left) gem_exec_schedule (u-lateslice)
[475.412528] Starting subtest: u-lateslice
[475.414740] Starting dynamic subtest: rcs0
[475.426783] Dynamic subtest rcs0: SUCCESS (0.025s)
[475.437590] Starting dynamic subtest: bcs0
[475.444825] Dynamic subtest bcs0: SUCCESS (0.017s)
[475.454955] Starting dynamic subtest: vcs0
[475.464488] Dynamic subtest vcs0: SUCCESS (0.019s)
[475.474830] Starting dynamic subtest: vcs1
[475.484576] Dynamic subtest vcs1: SUCCESS (0.019s)
[475.494132] Starting dynamic subtest: vecs0
[475.504199] Dynamic subtest vecs0: SUCCESS (0.019s)
[475.513936] Starting dynamic subtest: ccs0
[475.523546] Dynamic subtest ccs0: SUCCESS (0.019s)
[475.525847] Subtest u-lateslice: SUCCESS (0.123s)
[477.420631] [056/156] (545s left) kms_cursor_crc (cursor-offscreen-64x64)
[477.593547] Starting subtest: cursor-offscreen-64x64
[477.596195] Starting dynamic subtest: pipe-A-eDP-1
[479.527644] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[479.561118] Starting dynamic subtest: pipe-D-eDP-1
[482.148817] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.596s)
[482.150804] Subtest cursor-offscreen-64x64: SUCCESS (4.553s)
[483.009431] [057/156] (540s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[483.114396] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[483.118373] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[483.208665] [058/156] (540s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[483.303765] Starting subtest: plane-upscale-20x20-with-rotation
[483.305970] Starting dynamic subtest: pipe-A
[483.528859] Dynamic subtest pipe-A: SUCCESS (0.227s)
[483.544689] Starting dynamic subtest: pipe-B
[484.797435] Dynamic subtest pipe-B: SUCCESS (1.267s)
[484.807200] Starting dynamic subtest: pipe-C
[486.137309] Dynamic subtest pipe-C: SUCCESS (1.338s)
[486.147205] Starting dynamic subtest: pipe-D
[487.464279] Dynamic subtest pipe-D: SUCCESS (1.325s)
[487.466602] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.163s)
[488.654460] [059/156] (534s left) kms_pm_rpm (modeset-lpsp)
[490.503038] Starting subtest: modeset-lpsp
[491.992818] Subtest modeset-lpsp: SUCCESS (1.493s)
[492.126459] [060/156] (531s left) kms_feature_discovery (display-2x)
[492.227066] Starting subtest: display-2x
[492.231269] Subtest display-2x: SKIP (0.000s)
[492.299128] [061/156] (531s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[492.389599] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[492.393921] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[492.485350] [062/156] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[492.592203] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[492.596410] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[492.675501] [063/156] (530s left) gem_ctx_param (invalid-size-get)
[492.738289] Starting subtest: invalid-size-get
[492.740740] Subtest invalid-size-get: SUCCESS (0.001s)
[492.850287] [064/156] (530s left) kms_content_protection (legacy)
[492.984709] Starting subtest: legacy
[492.989508] Subtest legacy: SKIP (0.000s)
[493.115823] [065/156] (530s left) gem_readwrite (new-obj)
[493.166845] Subtest new-obj: SKIP (0.000s)
[493.221659] [066/156] (530s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render)
[493.313589] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render
[493.317151] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[493.393033] [067/156] (530s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[493.485953] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[493.489587] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[493.588695] [068/156] (530s left) api_intel_bb (object-reloc-keep-cache)
[493.638130] Starting subtest: object-reloc-keep-cache
[493.643931] Subtest object-reloc-keep-cache: SKIP (0.003s)
[493.727945] [069/156] (530s left) syncobj_wait (single-wait-signaled)
[493.771060] Starting subtest: single-wait-signaled
[493.773074] Subtest single-wait-signaled: SUCCESS (0.000s)
[493.880850] [070/156] (529s left) gem_create (create-ext-cpu-access-sanity-check)
[494.049689] Starting subtest: create-ext-cpu-access-sanity-check
[494.054296] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[494.133608] [071/156] (529s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[494.225964] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[494.230541] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[494.351380] [072/156] (529s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[494.395629] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[494.503096] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[494.594679] [073/156] (529s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[494.701847] Starting subtest: yf-tiled-16bpp-rotate-0
[494.706378] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[494.811045] [074/156] (529s left) syncobj_timeline (single-wait-for-submit-signaled)
[494.870057] Starting subtest: single-wait-for-submit-signaled
[494.872424] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[494.975144] [075/156] (529s left) drm_read (fault-buffer)
[495.120361] Starting subtest: fault-buffer
[495.122605] Subtest fault-buffer: SUCCESS (0.001s)
[495.230234] [076/156] (528s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[495.330616] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[495.332858] Starting dynamic subtest: pipe-A
[495.349962] Dynamic subtest pipe-A: SKIP (0.017s)
[495.360716] Starting dynamic subtest: pipe-B
[495.381491] Dynamic subtest pipe-B: SKIP (0.029s)
[495.391531] Starting dynamic subtest: pipe-C
[495.412085] Dynamic subtest pipe-C: SKIP (0.030s)
[495.421960] Starting dynamic subtest: pipe-D
[495.443708] Dynamic subtest pipe-D: SKIP (0.030s)
[495.447984] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.111s)
[495.539450] [077/156] (528s left) gem_exec_alignment (forked)
[495.592974] Starting subtest: forked
[534.189173] Subtest forked: SUCCESS (38.590s)
[534.265066] [078/156] (489s left) gem_ctx_persistence (heartbeat-stop)
[534.363243] Starting subtest: heartbeat-stop
[534.367751] Subtest heartbeat-stop: SKIP (0.000s)
[534.477982] [079/156] (489s left) gem_exec_reloc (basic-cpu-read-active)
[534.548156] Subtest basic-cpu-read-active: SKIP (0.000s)
[534.612825] [080/156] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[534.722655] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[542.222660] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.505s)
[542.358608] [081/156] (481s left) gem_exec_flush (basic-wb-ro-default)
[542.425303] Starting subtest: basic-wb-ro-default
[547.889741] Subtest basic-wb-ro-default: SUCCESS (5.465s)
[548.079767] [082/156] (476s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[548.186169] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[548.190647] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[548.257293] [083/156] (476s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[548.362635] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[548.364962] Starting dynamic subtest: pipe-A-eDP-1
[548.458450] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[548.469449] Starting dynamic subtest: pipe-B-eDP-1
[549.639159] Dynamic subtest pipe-B-eDP-1: SKIP (1.178s)
[549.643692] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.280s)
[550.826825] [084/156] (473s left) gem_userptr_blits (input-checking)
[550.887693] Starting subtest: input-checking
[550.889807] Subtest input-checking: SUCCESS (0.000s)
[551.007694] [085/156] (473s left) prime_vgem (coherency-blt)
[551.156981] Starting subtest: coherency-blt
[552.268301] Subtest coherency-blt: SUCCESS (1.110s)
[552.385861] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[552.390016] [086/156] (472s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[552.497278] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[552.501458] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[552.607422] [087/156] (471s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[552.703145] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[552.707340] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[552.809670] [088/156] (471s left) prime_mmap (test_aperture_limit)
[552.861820] Starting subtest: test_aperture_limit
[552.863944] Starting dynamic subtest: test_aperture_limit-smem
[552.873085] Dynamic subtest test_aperture_limit-smem: SKIP (0.011s)
[552.877196] Subtest test_aperture_limit: SKIP (0.011s)
[552.984983] [089/156] (471s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[553.078120] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[553.082135] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[553.147498] [090/156] (471s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[553.239271] Starting subtest: primary-yf-tiled-reflect-x-0
[553.298620] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[553.401948] [091/156] (471s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[553.500783] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[553.504450] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[553.586393] [092/156] (471s left) kms_chamelium_frames (dp-crc-fast)
[553.966129] Subtest dp-crc-fast: SKIP (0.000s)
[554.749472] [093/156] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[554.856543] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[554.860595] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[554.967745] [094/156] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[555.072474] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[555.076814] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[555.183073] [095/156] (469s left) kms_prime (d3hot)
[555.263240] Subtest D3hot: SKIP (0.000s)
[555.354693] [096/156] (469s left) perf (gen12-mi-rpc)
[555.490594] Starting subtest: gen12-mi-rpc
[555.492817] Starting dynamic subtest: rcs0
[555.514972] Dynamic subtest rcs0: SUCCESS (0.023s)
[555.517255] Subtest gen12-mi-rpc: SUCCESS (0.024s)
[555.565550] [097/156] (469s left) kms_rmfb (rmfb-ioctl)
[555.685077] Starting subtest: rmfb-ioctl
[555.687049] Starting dynamic subtest: pipe-A-eDP-1
[555.791639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[555.802069] Starting dynamic subtest: pipe-B-eDP-1
[557.027068] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[557.039071] Starting dynamic subtest: pipe-C-eDP-1
[558.245237] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[558.257038] Starting dynamic subtest: pipe-D-eDP-1
[559.376406] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[559.378761] Subtest rmfb-ioctl: SUCCESS (3.692s)
[560.604725] [098/156] (464s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[560.721392] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[568.131336] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.416s)
[568.260143] [099/156] (456s left) i915_drm_fdinfo (busy-hang)
[568.300478] Starting subtest: busy-hang
[568.302852] Starting dynamic subtest: rcs0
[568.335073] Dynamic subtest rcs0: SKIP (0.032s)
[568.347585] Starting dynamic subtest: bcs0
[568.351692] Dynamic subtest bcs0: SKIP (0.001s)
[568.364591] Starting dynamic subtest: vcs0
[568.369044] Dynamic subtest vcs0: SKIP (0.001s)
[568.378542] Starting dynamic subtest: vcs1
[568.382696] Dynamic subtest vcs1: SKIP (0.000s)
[568.392154] Starting dynamic subtest: vecs0
[568.396298] Dynamic subtest vecs0: SKIP (0.000s)
[568.406057] Starting dynamic subtest: ccs0
[568.410180] Dynamic subtest ccs0: SKIP (0.000s)
[568.414210] Subtest busy-hang: SKIP (0.041s)
[568.452262] [100/156] (456s left) syncobj_basic (bad-flags-handle-to-fd)
[568.499896] Starting subtest: bad-flags-handle-to-fd
[568.502815] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[568.594383] [101/156] (456s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[568.689614] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[568.693684] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[568.777761] [102/156] (456s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[568.872295] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[568.876571] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[568.977290] [103/156] (456s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[569.079714] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[569.083249] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[569.175310] [104/156] (456s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[569.270117] Starting subtest: x-tiled-32bpp-rotate-270
[569.290316] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[569.408183] [105/156] (455s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[569.500779] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[569.504059] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[569.598697] [106/156] (455s left) gem_mmap_offset (partial-unmap)
[569.644076] Starting subtest: partial-unmap
[569.646061] Starting dynamic subtest: smem0
[570.157504] Dynamic subtest smem0: SUCCESS (0.512s)
[570.159903] Subtest partial-unmap: SUCCESS (0.513s)
[570.274829] [107/156] (455s left) gem_ringfill (legacy-basic)
[576.358494] Starting subtest: legacy-basic
[576.361129] Starting dynamic subtest: default
[576.417600] Dynamic subtest default: SUCCESS (0.059s)
[576.429952] Starting dynamic subtest: render
[576.461077] Dynamic subtest render: SUCCESS (0.041s)
[576.472424] Starting dynamic subtest: bsd
[576.505057] Dynamic subtest bsd: SUCCESS (0.042s)
[576.518369] Starting dynamic subtest: bsd1
[576.547056] Dynamic subtest bsd1: SUCCESS (0.039s)
[576.560067] Starting dynamic subtest: bsd2
[576.590099] Dynamic subtest bsd2: SUCCESS (0.040s)
[576.600851] Starting dynamic subtest: blt
[576.635114] Dynamic subtest blt: SUCCESS (0.043s)
[576.646611] Starting dynamic subtest: vebox
[576.679052] Dynamic subtest vebox: SUCCESS (0.042s)
[576.681449] Subtest legacy-basic: SUCCESS (0.323s)
[576.760241] [108/156] (448s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[576.870573] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[576.874798] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[576.980545] [109/156] (448s left) sw_sync (sync_multi_consumer_producer)
[577.021662] Starting subtest: sync_multi_consumer_producer
[577.330621] Subtest sync_multi_consumer_producer: SUCCESS (0.312s)
[577.394320] [110/156] (448s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[577.515962] Starting subtest: flip-vs-cursor-legacy
[585.107598] Subtest flip-vs-cursor-legacy: SUCCESS (7.590s)
[585.962086] [111/156] (439s left) gem_exec_balancer (parallel-ordering)
[586.232577] Starting subtest: parallel-ordering
[587.227164] Subtest parallel-ordering: SUCCESS (0.994s)
[587.344058] [112/156] (438s left) gem_lmem_swapping (random)
[587.386325] Subtest random: SKIP (0.000s)
[587.428710] [113/156] (438s left) gem_exec_whisper (basic-queues-forked)
[587.495104] Starting subtest: basic-queues-forked
[610.520523] Subtest basic-queues-forked: SUCCESS (23.023s)
[610.716397] [114/156] (414s left) gem_userptr_blits (sync-unmap)
[610.781738] Starting subtest: sync-unmap
[610.807268] Subtest sync-unmap: SUCCESS (0.024s)
[610.937223] [115/156] (414s left) gem_exec_reloc (basic-gtt-read-noreloc)
[611.010921] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[611.079257] [116/156] (414s left) gem_exec_reloc (basic-gtt-read)
[611.138047] Subtest basic-gtt-read: SKIP (0.000s)
[611.206206] [117/156] (414s left) gem_ctx_param (invalid-ctx-set)
[611.251977] Starting subtest: invalid-ctx-set
[611.254319] Subtest invalid-ctx-set: SUCCESS (0.002s)
[611.352923] [118/156] (414s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[611.457599] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[611.467248] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[611.546935] [119/156] (414s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[611.641192] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[611.644512] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[611.737690] [120/156] (414s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[611.834234] Starting subtest: psrhdr-rgb565-draw-render
[611.837930] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[611.945675] [121/156] (414s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt)
[612.052504] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt
[612.056321] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[612.149069] [122/156] (413s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[612.253567] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[612.256804] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[612.350880] [123/156] (413s left) gem_userptr_blits (probe)
[612.432182] Starting subtest: probe
[612.509593] Subtest probe: SUCCESS (0.079s)
[612.636806] [124/156] (413s left) kms_psr (fbc-psr-primary-mmap-gtt)
[612.730126] Starting subtest: fbc-psr-primary-mmap-gtt
[612.731961] Starting dynamic subtest: eDP-1
[612.735435] Dynamic subtest eDP-1: SKIP (0.000s)
[612.738827] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[612.825541] [125/156] (413s left) kms_flip (flip-vs-dpms-on-nop)
[612.915481] Starting subtest: flip-vs-dpms-on-nop
[612.917476] Starting dynamic subtest: A-eDP1
[614.764294] Dynamic subtest A-eDP1: SUCCESS (1.848s)
[614.777676] Starting dynamic subtest: B-eDP1
[616.703799] Dynamic subtest B-eDP1: SUCCESS (1.938s)
[616.714672] Starting dynamic subtest: C-eDP1
[618.534973] Dynamic subtest C-eDP1: SUCCESS (1.829s)
[618.545322] Starting dynamic subtest: D-eDP1
[620.377631] Dynamic subtest D-eDP1: SUCCESS (1.841s)
[620.383623] Subtest flip-vs-dpms-on-nop: SUCCESS (7.467s)
[621.555089] [126/156] (404s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[621.647390] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[621.651723] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[621.748703] [127/156] (404s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[621.858126] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc
[621.862271] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[621.966560] [128/156] (404s left) kms_draw_crc (fill-fb)
[622.060624] Starting subtest: fill-fb
[622.522815] Subtest fill-fb: SUCCESS (0.464s)
[622.630245] [129/156] (403s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[622.727059] Starting subtest: fbc-rgb101010-draw-blt
[625.265195] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.542s)
[626.465044] [130/156] (399s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[626.579991] Starting subtest: 2x-cursor-vs-flip-atomic
[626.584649] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[626.725478] [131/156] (399s left) gem_spin_batch (user-each)
[626.788972] Starting subtest: user-each
[630.150947] Subtest user-each: SUCCESS (3.361s)
[630.396399] [132/156] (396s left) fbdev (write)
[630.435595] Starting subtest: write
[630.800103] Subtest write: SUCCESS (0.364s)
[630.867524] [133/156] (395s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[630.973111] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[638.365036] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.398s)
[638.530415] [134/156] (387s left) gem_exec_schedule (preempt-queue-chain)
[638.605775] Subtest preempt-queue-chain: SKIP (0.000s)
[638.900417] [135/156] (387s left) kms_psr (fbc-pr-primary-mmap-gtt)
[638.994792] Starting subtest: fbc-pr-primary-mmap-gtt
[638.999183] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[639.068857] [136/156] (387s left) i915_hangman (detector)
[639.129143] Starting subtest: detector
[639.131327] Starting dynamic subtest: rcs0
[649.283696] Dynamic subtest rcs0: SUCCESS (10.153s)
[649.297641] Starting dynamic subtest: bcs0
[661.312969] Dynamic subtest bcs0: SUCCESS (12.026s)
[661.329297] Starting dynamic subtest: vcs0
[673.281905] Dynamic subtest vcs0: SUCCESS (11.965s)
[673.296289] Starting dynamic subtest: vcs1
[685.248770] Dynamic subtest vcs1: SUCCESS (11.964s)
[685.263351] Starting dynamic subtest: vecs0
[697.281033] Dynamic subtest vecs0: SUCCESS (12.028s)
[697.295442] Starting dynamic subtest: ccs0
[709.314885] Dynamic subtest ccs0: SUCCESS (12.031s)
[709.317699] Subtest detector: SUCCESS (70.183s)
[709.456138] [137/156] (317s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt)
[709.562382] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt
[709.566690] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[709.658649] [138/156] (317s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[709.758534] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[709.762982] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[709.879452] [139/156] (316s left) gem_request_retire (retire-vma-not-inactive)
[709.930601] Starting subtest: retire-vma-not-inactive
[709.991910] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[710.133663] [140/156] (316s left) i915_pm_rps (thresholds)
[710.199486] Starting subtest: thresholds
[710.203602] Subtest thresholds: SKIP (0.001s)
[710.300230] [141/156] (316s left) kms_color (invalid-degamma-lut-sizes)
[710.392516] Starting subtest: invalid-degamma-lut-sizes
[710.394507] Starting dynamic subtest: pipe-A
[710.676848] Dynamic subtest pipe-A: SUCCESS (0.286s)
[710.687825] Starting dynamic subtest: pipe-B
[710.690261] Dynamic subtest pipe-B: SUCCESS (0.000s)
[710.702285] Starting dynamic subtest: pipe-C
[710.704686] Dynamic subtest pipe-C: SUCCESS (0.000s)
[710.714836] Starting dynamic subtest: pipe-D
[710.716796] Dynamic subtest pipe-D: SUCCESS (0.000s)
[710.718775] Subtest invalid-degamma-lut-sizes: SUCCESS (0.290s)
[711.509398] [142/156] (315s left) gem_exec_fence (long-history)
[711.951347] Starting subtest: long-history
[719.055642] Subtest long-history: SUCCESS (7.105s)
[719.511446] [143/156] (307s left) gem_ctx_param (invalid-set-ringsize)
[719.556249] Starting subtest: invalid-set-ringsize
[719.558702] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[719.635869] [144/156] (307s left) gem_fence_thrash (bo-write-verify-threaded-y)
[719.672307] Starting subtest: bo-write-verify-threaded-y
[719.692486] Subtest bo-write-verify-threaded-y: SKIP (0.018s)
[719.758206] [145/156] (307s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[719.854433] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[719.858566] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[719.963046] [146/156] (307s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[720.058824] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[720.063298] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[720.153927] [147/156] (306s left) kms_cursor_crc (cursor-sliding-32x32)
[720.290461] Starting subtest: cursor-sliding-32x32
[720.337048] Subtest cursor-sliding-32x32: SKIP (0.043s)
[720.608410] [148/156] (306s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[720.707088] Starting subtest: stress-xrgb8888-xtiled
[726.672952] Subtest stress-xrgb8888-xtiled: SUCCESS (5.968s)
[726.731868] [149/156] (300s left) api_intel_allocator (execbuf-with-allocator)
[726.785560] Starting subtest: execbuf-with-allocator
[726.788975] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[726.928661] [150/156] (300s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[727.022803] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[727.026262] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[727.123907] [151/156] (300s left) kms_rotation_crc (bad-pixel-format)
[727.221165] Starting subtest: bad-pixel-format
[727.224770] Subtest bad-pixel-format: SKIP (0.001s)
[727.309676] [152/156] (299s left) kms_joiner (basic-force-ultra-joiner)
[727.416053] Starting subtest: basic-force-ultra-joiner
[727.419546] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[727.496952] [153/156] (299s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[727.592846] Starting subtest: psrhdr-farfromfence-mmap-gtt
[727.596291] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[727.676056] [154/156] (299s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[728.057401] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[728.917279] [155/156] (298s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[728.975589] Subtest tiled-to-untiled: SKIP (0.000s)
[729.056792] [156/156] (298s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[729.155608] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[735.881051] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.729s)
[736.006705] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: dumb_buffer
results: parsing output: 4/ for test: syncobj_basic
results: parsing output: 5/ for test: kms_dp_linktrain_fallback
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: i915_selftest
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: kms_async_flips
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_legacy_colorkey
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_vrr
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_properties
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_chamelium_color
results: parsing output: 29/ for test: gem_pwrite
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_exec_gttfill
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gen9_exec_parse
results: parsing output: 35/ for test: sysfs_preempt_timeout
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_force_connector_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_plane_multiple
results: parsing output: 46/ for test: gem_exec_flush
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_pm_rpm
results: parsing output: 59/ for test: kms_feature_discovery
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: gem_readwrite
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: gem_create
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: drm_read
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: gem_exec_alignment
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: prime_vgem
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_prime
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: kms_rmfb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: syncobj_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_mmap_offset
results: parsing output: 106/ for test: gem_ringfill
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: gem_ctx_param
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_draw_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_spin_batch
results: parsing output: 131/ for test: fbdev
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_schedule
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: i915_hangman
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_request_retire
results: parsing output: 139/ for test: i915_pm_rps
results: parsing output: 140/ for test: kms_color
results: parsing output: 141/ for test: gem_exec_fence
results: parsing output: 142/ for test: gem_ctx_param
results: parsing output: 143/ for test: gem_fence_thrash
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_cursor_crc
results: parsing output: 147/ for test: kms_pipe_stress
results: parsing output: 148/ for test: api_intel_allocator
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_rotation_crc
results: parsing output: 151/ for test: kms_joiner
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_chamelium_hpd
results: parsing output: 154/ for test: gem_set_tiling_vs_blt
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.