[57.239017] Initializing watchdogs
[57.239148]   /dev/watchdog0
[57.255853] [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]
[57.260498] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.262799] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.266085] [001/133] (960s left) kms_flip (2x-wf_vblank-ts-check)
[57.390495] Starting subtest: 2x-wf_vblank-ts-check
[57.405509] Subtest 2x-wf_vblank-ts-check: SKIP (0.015s)
[57.508163] [002/133] (960s left) gem_exec_reloc (basic-gtt-cpu-active)
[57.587291] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[57.680148] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[57.790616] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[57.794935] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[57.902620] [004/133] (960s left) gem_exec_whisper (basic-queues-all)
[57.967676] Starting subtest: basic-queues-all
[68.673474] Subtest basic-queues-all: SUCCESS (10.703s)
[68.869968] [005/133] (949s left) gem_ctx_create (basic)
[68.943448] Starting subtest: basic
[68.945892] Subtest basic: SUCCESS (0.000s)
[69.138725] [006/133] (948s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[69.242748] Starting subtest: psr2-cursor-plane-update-sf
[69.245062] Starting dynamic subtest: pipe-A-eDP-1
[69.866068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s)
[69.875657] Starting dynamic subtest: pipe-B-eDP-1
[71.199937] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s)
[71.202316] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.962s)
[72.062212] [007/133] (945s left) gem_exec_params (dr4-dirt)
[72.121612] Starting subtest: DR4-dirt
[72.123962] Subtest DR4-dirt: SUCCESS (0.000s)
[72.235431] [008/133] (945s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[72.309108] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[72.313420] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[72.549725] [009/133] (945s left) gem_exec_balancer (nohangcheck)
[72.976742] Starting subtest: nohangcheck
[74.129572] Subtest nohangcheck: SUCCESS (1.151s)
[74.241462] [010/133] (943s left) gem_exec_schedule (noreorder)
[74.417747] Starting subtest: noreorder
[74.419974] Starting dynamic subtest: rcs0
[74.499676] Dynamic subtest rcs0: SUCCESS (0.083s)
[74.509747] Starting dynamic subtest: vcs0
[76.318140] Dynamic subtest vcs0: SUCCESS (1.816s)
[76.329313] Starting dynamic subtest: vcs1
[78.300245] Dynamic subtest vcs1: SUCCESS (1.981s)
[78.311730] Starting dynamic subtest: vecs0
[80.352044] Dynamic subtest vecs0: SUCCESS (2.051s)
[80.363246] Starting dynamic subtest: ccs0
[80.435020] Dynamic subtest ccs0: SUCCESS (0.083s)
[80.437617] Subtest noreorder: SUCCESS (6.019s)
[80.617254] [011/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[80.723355] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[80.727647] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[80.824085] [012/133] (937s left) gem_exec_reloc (basic-wc-cpu)
[80.876497] Subtest basic-wc-cpu: SKIP (0.000s)
[80.955384] [013/133] (937s left) gem_exec_fence (basic-wait)
[81.126934] Starting subtest: basic-wait
[81.129361] Starting dynamic subtest: rcs0
[81.216123] Dynamic subtest rcs0: SUCCESS (0.088s)
[81.226908] Starting dynamic subtest: bcs0
[81.269763] Dynamic subtest bcs0: SUCCESS (0.053s)
[81.280449] Starting dynamic subtest: vcs0
[81.326401] Dynamic subtest vcs0: SUCCESS (0.056s)
[81.336995] Starting dynamic subtest: vcs1
[81.384353] Dynamic subtest vcs1: SUCCESS (0.057s)
[81.394127] Starting dynamic subtest: vecs0
[81.450050] Dynamic subtest vecs0: SUCCESS (0.065s)
[81.460849] Starting dynamic subtest: ccs0
[81.508674] Dynamic subtest ccs0: SUCCESS (0.058s)
[81.511303] Subtest basic-wait: SUCCESS (0.382s)
[83.396258] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[83.399272] [014/133] (934s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[83.455491] Starting subtest: invalid-multi-wait-unsubmitted
[83.457708] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[83.546352] [015/133] (934s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[83.650936] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[87.375703] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.730s)
[88.583929] [016/133] (929s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[88.632081] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[88.634217] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[88.730573] [017/133] (929s left) kms_psr (psr2-suspend)
[88.815928] Starting subtest: psr2-suspend
[88.818049] Starting dynamic subtest: eDP-1
[106.728588] Dynamic subtest eDP-1: SUCCESS (3.426s)
[106.730923] Subtest psr2-suspend: SUCCESS (3.426s)
[113.557849] [018/133] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[113.668131] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[113.672555] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[113.769838] [019/133] (910s left) sw_sync (alloc_fence)
[113.802847] Starting subtest: alloc_fence
[113.805138] Subtest alloc_fence: SUCCESS (0.000s)
[113.862159] [020/133] (910s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[113.954874] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[113.957309] Starting dynamic subtest: pipe-A-eDP-1
[113.966799] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[113.978425] Starting dynamic subtest: pipe-B-eDP-1
[113.987601] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[113.997047] Starting dynamic subtest: pipe-C-eDP-1
[114.005582] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[114.014383] Starting dynamic subtest: pipe-D-eDP-1
[114.023089] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[114.027502] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[116.202055] [021/133] (908s left) syncobj_basic (bad-fd-to-handle)
[116.252254] Starting subtest: bad-fd-to-handle
[116.254224] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[116.333160] [022/133] (908s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[116.384753] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[116.490412] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[116.568537] [023/133] (908s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[116.682181] Starting subtest: cursorB-vs-flipA-varying-size
[116.686849] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[116.827856] [024/133] (907s left) gen9_exec_parse (secure-batches)
[116.900762] Subtest secure-batches: SKIP (0.000s)
[116.974896] [025/133] (907s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[117.083004] Starting subtest: x-tiled-16bpp-rotate-180
[118.473281] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.390s)
[118.604086] [026/133] (906s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[118.651309] Starting subtest: multi-wait-all-available-submitted-signaled
[118.653279] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[118.749160] [027/133] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[118.847139] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[127.553035] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.708s)
[127.675818] [028/133] (897s left) gem_exec_nop (basic-sequential)
[127.760512] Starting subtest: basic-sequential
[142.293420] Subtest basic-sequential: SUCCESS (14.540s)
[142.535487] [029/133] (882s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[142.856135] Starting subtest: cursor-rapid-movement-max-size
[142.862355] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[143.009680] [030/133] (882s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[143.105454] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[143.107668] Starting dynamic subtest: pipe-A-eDP-1
[149.774514] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.669s)
[149.785599] Starting dynamic subtest: pipe-B-eDP-1
[156.862508] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.088s)
[156.864766] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.760s)
[157.749488] [031/133] (867s left) api_intel_bb (simple-bb-ctx)
[157.814532] Starting subtest: simple-bb-ctx
[157.821461] Subtest simple-bb-ctx: SUCCESS (0.008s)
[157.950307] [032/133] (867s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[158.036747] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[158.041093] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[158.123379] [033/133] (867s left) gem_workarounds (suspend-resume-fd)
[158.190831] Starting subtest: suspend-resume-fd
[174.328169] Subtest suspend-resume-fd: SUCCESS (1.585s)
[184.465777] [034/133] (850s left) kms_joiner (invalid-modeset-force-big-joiner)
[184.570462] Starting subtest: invalid-modeset-force-big-joiner
[184.575897] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[184.635290] [035/133] (850s left) gem_ctx_param (basic-default)
[184.683558] Starting subtest: basic-default
[184.686369] Subtest basic-default: SUCCESS (0.000s)
[184.761018] [036/133] (850s left) syncobj_wait (reset-unsignaled)
[184.818554] Starting subtest: reset-unsignaled
[184.821384] Subtest reset-unsignaled: SUCCESS (0.000s)
[184.915901] [037/133] (850s left) syncobj_wait (multi-wait-all-submitted-signaled)
[184.966551] Starting subtest: multi-wait-all-submitted-signaled
[185.073624] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[185.150750] [038/133] (850s left) sysfs_heartbeat_interval (idempotent)
[185.204060] Starting subtest: idempotent
[185.206530] Starting dynamic subtest: vecs0
[185.209147] Dynamic subtest vecs0: SUCCESS (0.001s)
[185.220555] Starting dynamic subtest: ccs0
[185.223278] Dynamic subtest ccs0: SUCCESS (0.001s)
[185.233203] Starting dynamic subtest: vcs0
[185.235382] Dynamic subtest vcs0: SUCCESS (0.000s)
[185.245380] Starting dynamic subtest: bcs0
[185.247929] Dynamic subtest bcs0: SUCCESS (0.001s)
[185.257678] Starting dynamic subtest: rcs0
[185.260450] Dynamic subtest rcs0: SUCCESS (0.000s)
[185.270379] Starting dynamic subtest: vcs1
[185.272800] Dynamic subtest vcs1: SUCCESS (0.000s)
[185.275031] Subtest idempotent: SUCCESS (0.007s)
[185.316227] [039/133] (850s left) kms_lease (lease-again)
[185.410544] Starting subtest: lease-again
[185.413231] Starting dynamic subtest: pipe-A-eDP-1
[185.415969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[185.426549] Starting dynamic subtest: pipe-B-eDP-1
[185.428883] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[185.438122] Starting dynamic subtest: pipe-C-eDP-1
[185.440455] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[185.449937] Starting dynamic subtest: pipe-D-eDP-1
[185.452248] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[185.454460] Subtest lease-again: SUCCESS (0.012s)
[185.528449] [040/133] (849s left) syncobj_timeline (wait-all-interrupted)
[185.585560] Starting subtest: wait-all-interrupted
[185.689817] Subtest wait-all-interrupted: SUCCESS (0.104s)
[185.767725] [041/133] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[185.858449] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[193.298534] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.440s)
[193.422932] [042/133] (842s left) kms_content_protection (lic-type-1)
[193.561272] Starting subtest: lic-type-1
[193.566390] Subtest lic-type-1: SKIP (0.000s)
[193.678248] [043/133] (841s left) gem_vm_create (invalid-destroy)
[193.739361] Starting subtest: invalid-destroy
[193.742066] Subtest invalid-destroy: SUCCESS (0.002s)
[193.829831] [044/133] (841s left) gem_create (create-ext-placement-each)
[193.993974] Starting subtest: create-ext-placement-each
[193.996566] Subtest create-ext-placement-each: SUCCESS (0.000s)
[194.093366] [045/133] (841s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[194.186336] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[194.191590] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[194.290689] [046/133] (841s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[194.375075] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[194.379913] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[195.473210] [047/133] (840s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[195.566584] Starting subtest: yf-tiled-addfb-size-overflow
[195.571438] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[195.656491] [048/133] (840s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[195.753235] Starting subtest: fbc-psr2-cursor-plane-onoff
[195.755412] Starting dynamic subtest: eDP-1
[195.760334] Dynamic subtest eDP-1: SKIP (0.000s)
[195.765341] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[195.843181] [049/133] (840s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[195.933900] Starting subtest: fbc-modesetfrombusy
[199.727352] Subtest fbc-modesetfrombusy: SUCCESS (3.797s)
[200.907466] [050/133] (835s left) kms_flip (2x-modeset-vs-vblank-race)
[201.004027] Starting subtest: 2x-modeset-vs-vblank-race
[201.013060] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[201.091374] [051/133] (834s left) gem_exec_schedule (promotion)
[201.176213] Starting subtest: promotion
[201.178464] Starting dynamic subtest: rcs0
[201.278532] Dynamic subtest rcs0: SUCCESS (0.114s)
[201.290401] Starting dynamic subtest: vcs0
[201.373125] Dynamic subtest vcs0: SUCCESS (0.094s)
[201.383444] Starting dynamic subtest: vcs1
[201.468087] Dynamic subtest vcs1: SUCCESS (0.094s)
[201.478420] Starting dynamic subtest: vecs0
[201.553089] Dynamic subtest vecs0: SUCCESS (0.083s)
[201.566081] Starting dynamic subtest: ccs0
[201.648745] Dynamic subtest ccs0: SUCCESS (0.094s)
[201.651558] Subtest promotion: SUCCESS (0.484s)
[202.473190] [052/133] (833s left) gem_softpin (allocator-nopin-reserve)
[202.525047] Starting subtest: allocator-nopin-reserve
[202.633566] Subtest allocator-nopin-reserve: SUCCESS (0.110s)
[202.744160] [053/133] (833s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[202.839458] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[202.844753] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[202.939411] [054/133] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[203.034343] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[203.039963] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[203.132996] [055/133] (833s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[203.225717] Starting subtest: plane-all-modeset-transition-fencing
[203.231371] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[203.309665] [056/133] (832s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[203.412200] Starting subtest: psr-1p-pri-indfb-multidraw
[226.625109] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.215s)
[226.736355] [057/133] (809s left) i915_drm_fdinfo (isolation)
[226.786303] Starting subtest: isolation
[226.788834] Starting dynamic subtest: rcs0
[226.814024] Dynamic subtest rcs0: SKIP (0.026s)
[226.825836] Starting dynamic subtest: bcs0
[226.830424] Dynamic subtest bcs0: SKIP (0.000s)
[226.841456] Starting dynamic subtest: vcs0
[226.846333] Dynamic subtest vcs0: SKIP (0.000s)
[226.855882] Starting dynamic subtest: vcs1
[226.860797] Dynamic subtest vcs1: SKIP (0.000s)
[226.870018] Starting dynamic subtest: vecs0
[226.874136] Dynamic subtest vecs0: SKIP (0.000s)
[226.886391] Starting dynamic subtest: ccs0
[226.891190] Dynamic subtest ccs0: SKIP (0.000s)
[226.895047] Subtest isolation: SKIP (0.031s)
[226.935997] [058/133] (809s left) dmabuf_sync_file (export-wait-after-attach)
[226.986238] Starting subtest: export-wait-after-attach
[226.988197] Subtest export-wait-after-attach: SUCCESS (0.001s)
[227.042878] [059/133] (809s left) kms_vblank (query-busy-hang)
[227.129253] Starting subtest: query-busy-hang
[227.131349] Starting dynamic subtest: pipe-A-eDP-1
[253.150036] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.015s)
[253.166386] Starting dynamic subtest: pipe-D-eDP-1
[278.103574] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.947s)
[278.106360] Subtest query-busy-hang: SUCCESS (50.966s)
[278.920110] [060/133] (757s left) kms_psr (pr-primary-mmap-cpu)
[279.018556] Starting subtest: pr-primary-mmap-cpu
[279.023418] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[279.093210] [061/133] (757s left) perf_pmu (busy-check-all)
[279.133357] Starting subtest: busy-check-all
[279.136100] Starting dynamic subtest: rcs0
[279.681990] Dynamic subtest rcs0: SUCCESS (0.550s)
[279.696358] Starting dynamic subtest: bcs0
[280.235695] Dynamic subtest bcs0: SUCCESS (0.551s)
[280.250348] Starting dynamic subtest: vcs0
[281.357090] Dynamic subtest vcs0: SUCCESS (1.118s)
[281.370293] Starting dynamic subtest: vcs1
[283.341815] Dynamic subtest vcs1: SUCCESS (1.981s)
[283.357326] Starting dynamic subtest: vecs0
[285.389401] Dynamic subtest vecs0: SUCCESS (2.045s)
[285.402076] Starting dynamic subtest: ccs0
[285.948363] Dynamic subtest ccs0: SUCCESS (0.556s)
[285.951320] Subtest busy-check-all: SUCCESS (6.817s)
[286.049970] [062/133] (750s left) gem_exec_fence (submit)
[286.218755] Starting subtest: submit
[286.224813] Subtest submit: SKIP (0.000s)
[288.413359] [063/133] (748s left) perf (disabled-read-error)
[288.536913] Starting subtest: disabled-read-error
[288.556543] Subtest disabled-read-error: SUCCESS (0.020s)
[288.600743] [064/133] (747s left) kms_psr (psr-dpms)
[288.695251] Starting subtest: psr-dpms
[288.697741] Starting dynamic subtest: eDP-1
[291.654096] Dynamic subtest eDP-1: SUCCESS (2.959s)
[291.656867] Subtest psr-dpms: SUCCESS (2.960s)
[292.515080] [065/133] (744s left) gem_close_race (basic-threads)
[292.576076] Starting subtest: basic-threads
[293.979531] Subtest basic-threads: SUCCESS (1.403s)
[294.164913] [066/133] (742s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[294.253283] Starting subtest: fbc-shrfb-scaledprimary
[297.215170] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.964s)
[298.432832] [067/133] (738s left) perf_pmu (init-busy)
[298.473078] Starting subtest: init-busy
[298.475741] Starting dynamic subtest: rcs0
[298.478133] Dynamic subtest rcs0: SUCCESS (0.001s)
[298.489263] Starting dynamic subtest: bcs0
[298.491536] Dynamic subtest bcs0: SUCCESS (0.000s)
[298.501395] Starting dynamic subtest: vcs0
[298.503932] Dynamic subtest vcs0: SUCCESS (0.001s)
[298.513375] Starting dynamic subtest: vcs1
[298.515947] Dynamic subtest vcs1: SUCCESS (0.000s)
[298.526480] Starting dynamic subtest: vecs0
[298.529284] Dynamic subtest vecs0: SUCCESS (0.001s)
[298.539570] Starting dynamic subtest: ccs0
[298.541971] Dynamic subtest ccs0: SUCCESS (0.001s)
[298.544312] Subtest init-busy: SUCCESS (0.007s)
[298.586772] [068/133] (738s left) kms_color (deep-color)
[298.675138] Starting subtest: deep-color
[299.803454] Starting dynamic subtest: pipe-A-eDP-1-gamma
[300.537993] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.736s)
[300.548354] Starting dynamic subtest: pipe-A-eDP-1-degamma
[302.000378] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.462s)
[302.011197] Starting dynamic subtest: pipe-A-eDP-1-ctm
[303.433609] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.432s)
[304.194805] Starting dynamic subtest: pipe-B-eDP-1-gamma
[304.904271] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.719s)
[304.914040] Starting dynamic subtest: pipe-B-eDP-1-degamma
[306.396536] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.491s)
[306.407149] Starting dynamic subtest: pipe-B-eDP-1-ctm
[307.838124] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.442s)
[308.591797] Starting dynamic subtest: pipe-C-eDP-1-gamma
[309.285928] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.699s)
[309.298960] Starting dynamic subtest: pipe-C-eDP-1-degamma
[310.674161] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.388s)
[310.684961] Starting dynamic subtest: pipe-C-eDP-1-ctm
[312.092165] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.419s)
[312.892132] Starting dynamic subtest: pipe-D-eDP-1-gamma
[313.588559] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.702s)
[313.599750] Starting dynamic subtest: pipe-D-eDP-1-degamma
[314.954258] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.369s)
[314.965445] Starting dynamic subtest: pipe-D-eDP-1-ctm
[316.389455] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.433s)
[316.392319] Subtest deep-color: SUCCESS (17.710s)
[317.266089] [069/133] (719s left) syncobj_timeline (reset-signaled)
[317.329467] Starting subtest: reset-signaled
[317.332318] Subtest reset-signaled: SUCCESS (0.000s)
[317.435939] [070/133] (719s left) gem_mmap_gtt (basic-small-bo-tiledy)
[317.491521] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[317.543601] [071/133] (719s left) kms_vblank (wait-forked-hang)
[317.629943] Starting subtest: wait-forked-hang
[317.632401] Starting dynamic subtest: pipe-A-eDP-1
[344.217367] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.581s)
[344.234964] Starting dynamic subtest: pipe-D-eDP-1
[369.113045] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.888s)
[369.115438] Subtest wait-forked-hang: SUCCESS (51.473s)
[369.923213] [072/133] (666s left) api_intel_allocator (execbuf-with-allocator)
[369.982822] Starting subtest: execbuf-with-allocator
[369.986032] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[370.136398] [073/133] (666s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[370.523042] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[371.339409] [074/133] (665s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[371.442284] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[371.447161] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[371.543583] [075/133] (665s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[371.628323] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[371.630572] Starting dynamic subtest: A-eDP1
[380.501814] Dynamic subtest A-eDP1: SUCCESS (8.872s)
[380.512528] Starting dynamic subtest: B-eDP1
[389.440435] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[389.452187] Starting dynamic subtest: C-eDP1
[398.368827] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[398.380209] Starting dynamic subtest: D-eDP1
[407.309281] Dynamic subtest D-eDP1: SUCCESS (8.938s)
[407.311849] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.678s)
[408.551083] [076/133] (628s left) gem_pxp (create-regular-context-2)
[408.668317] Starting subtest: create-regular-context-2
[408.670896] Subtest create-regular-context-2: SUCCESS (0.002s)
[408.789126] [077/133] (628s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[408.877158] Starting subtest: read-crc-frame-sequence
[408.879276] Starting dynamic subtest: pipe-A-eDP-1
[409.603794] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s)
[409.615309] Starting dynamic subtest: pipe-B-eDP-1
[411.031212] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[411.043451] Starting dynamic subtest: pipe-C-eDP-1
[412.410274] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[412.421935] Starting dynamic subtest: pipe-D-eDP-1
[413.737470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[413.740487] Subtest read-crc-frame-sequence: SUCCESS (4.861s)
[414.581990] [078/133] (622s left) gem_ctx_persistence (hostile)
[414.639356] Starting subtest: hostile
[424.782179] Subtest hostile: SUCCESS (10.141s)
[424.905107] [079/133] (612s left) kms_big_fb (linear-addfb)
[425.014035] Starting subtest: linear-addfb
[425.016606] Subtest linear-addfb: SUCCESS (0.000s)
[425.100054] [080/133] (612s left) prime_mmap (test_forked_cpu_write)
[425.163366] Starting subtest: test_forked_cpu_write
[425.165565] Starting dynamic subtest: test_forked_cpu_write-smem
[425.170867] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[425.173454] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[425.283544] [081/133] (612s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[425.372711] Starting subtest: bad-rotation-90-yf-tiled-ccs
[425.375170] Starting dynamic subtest: pipe-A-eDP-1
[425.398969] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[425.409566] Starting dynamic subtest: pipe-B-eDP-1
[425.434467] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[425.444542] Starting dynamic subtest: pipe-C-eDP-1
[425.470294] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[425.480358] Starting dynamic subtest: pipe-D-eDP-1
[425.506649] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[425.511457] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[427.563460] [082/133] (609s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[427.649063] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[427.653688] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[427.732028] [083/133] (609s left) kms_cursor_crc (cursor-offscreen-512x512)
[427.999864] Starting subtest: cursor-offscreen-512x512
[428.004540] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[428.164924] [084/133] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[428.260376] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[428.265343] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[428.356317] [085/133] (609s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[428.451993] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[429.086488] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[429.273274] [086/133] (608s left) kms_cursor_crc (cursor-sliding-32x32)
[429.427090] Starting subtest: cursor-sliding-32x32
[429.474102] Subtest cursor-sliding-32x32: SKIP (0.043s)
[429.751456] [087/133] (607s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[429.864214] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[439.263839] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.398s)
[440.092443] [088/133] (597s left) kms_psr (fbc-psr-cursor-blt)
[440.186267] Starting subtest: fbc-psr-cursor-blt
[440.188946] Starting dynamic subtest: eDP-1
[440.194083] Dynamic subtest eDP-1: SKIP (0.000s)
[440.199399] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[440.261695] [089/133] (597s left) kms_pm_rpm (modeset-pc8-residency-stress)
[442.591544] Starting subtest: modeset-pc8-residency-stress
[442.597114] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[442.968575] [090/133] (594s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[443.060479] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[443.066195] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[443.158714] [091/133] (594s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[443.246275] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[443.272424] Starting dynamic subtest: pipe-A-plane-0
[443.751203] Dynamic subtest pipe-A-plane-0: SUCCESS (0.478s)
[443.762169] Starting dynamic subtest: pipe-A-plane-3
[444.016554] Dynamic subtest pipe-A-plane-3: SUCCESS (0.264s)
[445.148380] Starting dynamic subtest: pipe-B-plane-0
[445.608550] Dynamic subtest pipe-B-plane-0: SUCCESS (0.466s)
[445.621446] Starting dynamic subtest: pipe-B-plane-3
[445.885022] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s)
[446.207532] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.960s)
[447.024111] [092/133] (590s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[447.134825] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[447.139424] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[447.216598] [093/133] (590s left) kms_plane (planar-pixel-format-settings)
[447.308170] Starting subtest: planar-pixel-format-settings
[447.376477] Subtest planar-pixel-format-settings: SUCCESS (0.071s)
[447.482556] [094/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[447.576340] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[447.581525] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[447.675646] [095/133] (590s left) gem_mmap_wc (read)
[447.730078] Subtest read: SKIP (0.000s)
[447.798713] [096/133] (590s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[447.883302] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[447.886062] Starting dynamic subtest: pipe-A
[448.219287] Dynamic subtest pipe-A: SUCCESS (0.339s)
[448.229567] Starting dynamic subtest: pipe-B
[449.612375] Dynamic subtest pipe-B: SUCCESS (1.392s)
[449.625370] Starting dynamic subtest: pipe-C
[451.047402] Dynamic subtest pipe-C: SUCCESS (1.434s)
[451.057481] Starting dynamic subtest: pipe-D
[452.481401] Dynamic subtest pipe-D: SUCCESS (1.433s)
[452.484342] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.600s)
[453.653192] [097/133] (584s left) kms_rotation_crc (primary-rotation-90)
[453.744420] Starting subtest: primary-rotation-90
[453.749714] Subtest primary-rotation-90: SKIP (0.001s)
[453.829694] [098/133] (584s left) kms_getfb (getfb-handle-protection)
[453.915837] Starting subtest: getfb-handle-protection
[453.931537] Subtest getfb-handle-protection: SUCCESS (0.016s)
[454.035931] [099/133] (584s left) kms_chamelium_hpd (dp-hpd-fast)
[454.417522] Subtest dp-hpd-fast: SKIP (0.000s)
[455.280906] [100/133] (582s left) i915_drm_fdinfo (virtual-idle)
[455.325449] Starting subtest: virtual-idle
[458.387907] Subtest virtual-idle: SUCCESS (3.062s)
[458.466089] [101/133] (579s left) gem_ctx_param (invalid-set-no-zeromap)
[458.511986] Starting subtest: invalid-set-no-zeromap
[458.514677] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[458.602661] [102/133] (579s left) kms_pm_rpm (basic-pci-d3-state)
[460.535569] Starting subtest: basic-pci-d3-state
[462.005385] Subtest basic-pci-d3-state: SUCCESS (1.471s)
[462.121774] [103/133] (576s left) kms_draw_crc (draw-method-blt)
[462.224593] Starting subtest: draw-method-blt
[462.226767] Starting dynamic subtest: xrgb8888-untiled
[462.489235] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[462.499550] Starting dynamic subtest: rgb565-untiled
[462.711388] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[462.722527] Starting dynamic subtest: xrgb2101010-untiled
[462.933703] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[462.945554] Starting dynamic subtest: xbgr16161616f-untiled
[463.144667] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[463.155786] Starting dynamic subtest: xrgb8888-xtiled
[463.266412] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[463.280186] Starting dynamic subtest: rgb565-xtiled
[463.388877] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[463.400081] Starting dynamic subtest: xrgb2101010-xtiled
[463.500375] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[463.512190] Starting dynamic subtest: xbgr16161616f-xtiled
[463.611445] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[463.624555] Starting dynamic subtest: xrgb8888-4tiled
[463.732892] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[463.743786] Starting dynamic subtest: rgb565-4tiled
[463.856373] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[463.867015] Starting dynamic subtest: xrgb2101010-4tiled
[463.966844] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[463.977331] Starting dynamic subtest: xbgr16161616f-4tiled
[464.078073] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[464.080550] Subtest draw-method-blt: SUCCESS (1.856s)
[464.199156] [104/133] (574s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[464.290874] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[464.295361] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[464.387783] [105/133] (573s left) gem_exec_fence (syncobj-timeline-unused-fence)
[464.936110] Starting subtest: syncobj-timeline-unused-fence
[464.941347] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[466.436976] [106/133] (571s left) gem_exec_params (invalid-ring)
[466.490547] Starting subtest: invalid-ring
[466.493349] Subtest invalid-ring: SUCCESS (0.000s)
[466.604017] [107/133] (571s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[466.719530] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[468.133817] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.413s)
[468.935946] [108/133] (569s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[469.036127] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[470.104410] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.068s)
[470.213967] [109/133] (568s left) gem_blits (basic)
[470.268030] Starting subtest: basic
[471.693563] Subtest basic: SUCCESS (1.424s)
[471.823799] [110/133] (566s left) gem_eio (create-ext)
[472.057050] Starting subtest: create-ext
[472.388305] Subtest create-ext: SUCCESS (0.331s)
[472.518493] [111/133] (566s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[472.609100] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[479.374521] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.766s)
[479.516916] [112/133] (559s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[479.573809] Starting subtest: invalid-single-wait-all-unsubmitted
[479.576259] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[479.672891] [113/133] (559s left) gem_mmap_gtt (big-bo)
[479.733178] Subtest big-bo: SKIP (0.000s)
[479.794126] [114/133] (558s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[479.852034] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[479.910612] [115/133] (558s left) kms_cursor_legacy (forked-move)
[480.025885] Starting subtest: forked-move
[480.028018] Starting dynamic subtest: pipe-A
[485.495402] Dynamic subtest pipe-A: SUCCESS (5.466s)
[485.506364] Starting dynamic subtest: pipe-B
[490.985701] Dynamic subtest pipe-B: SUCCESS (5.483s)
[490.998756] Starting dynamic subtest: pipe-C
[496.469852] Dynamic subtest pipe-C: SUCCESS (5.484s)
[496.488431] Starting dynamic subtest: pipe-D
[501.942532] Dynamic subtest pipe-D: SUCCESS (5.470s)
[501.959625] Starting dynamic subtest: all-pipes
[507.441566] Dynamic subtest all-pipes: SUCCESS (5.496s)
[507.444485] Subtest forked-move: SUCCESS (27.410s)
[507.589642] [116/133] (531s left) perf_pmu (semaphore-wait)
[507.643233] Starting subtest: semaphore-wait
[507.645229] Starting dynamic subtest: rcs0
[508.157133] Dynamic subtest rcs0: SUCCESS (0.515s)
[508.171298] Starting dynamic subtest: bcs0
[508.671734] Dynamic subtest bcs0: SUCCESS (0.510s)
[508.685805] Starting dynamic subtest: vcs0
[509.185334] Dynamic subtest vcs0: SUCCESS (0.510s)
[509.199193] Starting dynamic subtest: vcs1
[509.698934] Dynamic subtest vcs1: SUCCESS (0.510s)
[509.717806] Starting dynamic subtest: vecs0
[510.213269] Dynamic subtest vecs0: SUCCESS (0.512s)
[510.228184] Starting dynamic subtest: ccs0
[510.730881] Dynamic subtest ccs0: SUCCESS (0.514s)
[510.733847] Subtest semaphore-wait: SUCCESS (3.090s)
[511.452562] [117/133] (527s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[511.569150] Starting subtest: verify-pxp-execution-after-suspend-resume
[518.648580] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.081s)
[528.802781] [118/133] (520s left) i915_pm_sseu (full-enable)
[528.865714] Subtest full-enable: SKIP (0.000s)
[528.974823] [119/133] (520s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[529.079323] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[529.469142] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[532.273455] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[532.286303] Starting dynamic subtest: pipe-A-eDP-1-4
[534.459545] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[534.473413] Starting dynamic subtest: pipe-A-eDP-1-4
[536.469465] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[536.486224] Starting dynamic subtest: pipe-A-eDP-1-x
[538.671535] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[539.069581] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[541.808665] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.748s)
[541.822735] Starting dynamic subtest: pipe-B-eDP-1-4
[543.994555] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[544.005551] Starting dynamic subtest: pipe-B-eDP-1-4
[546.005117] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[546.019412] Starting dynamic subtest: pipe-B-eDP-1-x
[548.206844] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[548.585143] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[551.347962] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[551.359270] Starting dynamic subtest: pipe-C-eDP-1-4
[553.531429] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.182s)
[553.545367] Starting dynamic subtest: pipe-C-eDP-1-4
[555.542616] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[555.557082] Starting dynamic subtest: pipe-C-eDP-1-x
[557.743367] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.200s)
[558.109482] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[560.878066] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[560.891585] Starting dynamic subtest: pipe-D-eDP-1-4
[563.073492] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.195s)
[563.087144] Starting dynamic subtest: pipe-D-eDP-1-4
[565.083398] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[565.096965] Starting dynamic subtest: pipe-D-eDP-1-x
[567.273465] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[567.276185] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.192s)
[568.467760] [120/133] (480s left) gem_mmap_gtt (cpuset-big-copy-xy)
[568.537297] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[568.607273] [121/133] (480s left) gen3_render_mixed_blits
[568.726112] [122/133] (480s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[568.816537] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[568.821245] Starting dynamic subtest: pipe-A-eDP-1
[568.851397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[568.865046] Starting dynamic subtest: pipe-B-eDP-1
[568.892550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[568.903536] Starting dynamic subtest: pipe-C-eDP-1
[568.931460] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[568.942289] Starting dynamic subtest: pipe-D-eDP-1
[568.971063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[568.975941] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[571.147968] [123/133] (478s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[571.239106] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[571.241553] Starting dynamic subtest: pipe-A-eDP-1
[571.305591] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[571.316423] Starting dynamic subtest: pipe-B-eDP-1
[571.381269] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[571.392637] Starting dynamic subtest: pipe-C-eDP-1
[571.460558] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[571.472059] Starting dynamic subtest: pipe-D-eDP-1
[571.534571] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[571.539142] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[573.491095] [124/133] (475s left) i915_pm_rpm (gem-execbuf)
[575.535959] Starting subtest: gem-execbuf
[575.539090] Starting dynamic subtest: smem0
[576.968016] Dynamic subtest smem0: SUCCESS (1.429s)
[576.970204] Subtest gem-execbuf: SUCCESS (1.431s)
[577.053992] [125/133] (472s left) kms_atomic (crtc-invalid-params-fence)
[577.145925] Starting subtest: crtc-invalid-params-fence
[577.148329] Starting dynamic subtest: pipe-A-eDP-1
[577.546237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[577.548908] Subtest crtc-invalid-params-fence: SUCCESS (0.403s)
[578.351983] [126/133] (470s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[578.452336] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[578.457574] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[578.567843] [127/133] (470s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[578.656286] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[578.660823] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[578.739427] [128/133] (470s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[578.801790] Starting subtest: basic-batch-kernel-default-cmd
[578.806580] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[578.988780] [129/133] (470s left) gem_mmap_gtt (ptrace)
[579.040359] Subtest ptrace: SKIP (0.000s)
[579.099926] [130/133] (470s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[579.204066] Starting subtest: y-tiled-8bpp-rotate-270
[579.208937] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[579.305309] [131/133] (470s left) gem_flink_race (flink_name)
[579.338097] Starting subtest: flink_name
[584.749256] Subtest flink_name: SUCCESS (5.403s)
[584.869822] [132/133] (464s left) gem_lmem_swapping (heavy-multi)
[584.913557] Subtest heavy-multi: SKIP (0.000s)
[584.959015] [133/133] (464s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[585.055777] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[585.060333] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[585.142998] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: gem_ctx_create
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: syncobj_basic
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_nop
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_workarounds
results: parsing output: 33/ for test: kms_joiner
results: parsing output: 34/ for test: gem_ctx_param
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: sysfs_heartbeat_interval
results: parsing output: 38/ for test: kms_lease
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_content_protection
results: parsing output: 42/ for test: gem_vm_create
results: parsing output: 43/ for test: gem_create
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: i915_drm_fdinfo
results: parsing output: 57/ for test: dmabuf_sync_file
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_close_race
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_color
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: api_intel_allocator
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: kms_pipe_crc_basic
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: prime_mmap
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_getfb
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: kms_draw_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_blits
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: kms_pipe_b_c_ivb
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: gem_pxp
results: parsing output: 117/ for test: i915_pm_sseu
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: gen3_render_mixed_blits
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: i915_pm_rpm
results: parsing output: 124/ for test: kms_atomic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: gem_exec_flush
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_flink_race
results: parsing output: 131/ for test: gem_lmem_swapping
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.