[57.074581] Initializing watchdogs
[57.074625]   /dev/watchdog0
[57.089330] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.093323] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.095326] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.098555] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[57.202373] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[64.657726] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.458s)
[64.755139] [002/133] (952s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[64.833319] Starting subtest: plane-all-modeset-transition-fencing
[64.837375] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[64.904772] [003/133] (952s left) syncobj_timeline (single-wait-all-available-signaled)
[64.953114] Starting subtest: single-wait-all-available-signaled
[64.955537] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[65.040201] [004/133] (952s left) gem_userptr_blits (sync-overlap)
[65.099587] Starting subtest: sync-overlap
[65.101881] Subtest sync-overlap: SUCCESS (0.000s)
[65.224936] [005/133] (952s left) kms_properties (plane-properties-atomic)
[65.308696] Starting subtest: plane-properties-atomic
[65.310592] Starting dynamic subtest: pipe-A-eDP-1
[65.898097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s)
[65.905777] Starting dynamic subtest: pipe-B-eDP-1
[67.128742] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s)
[67.138564] Starting dynamic subtest: pipe-C-eDP-1
[68.359284] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[68.367850] Starting dynamic subtest: pipe-D-eDP-1
[69.600198] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[69.602121] Subtest plane-properties-atomic: SUCCESS (4.291s)
[70.392284] [006/133] (947s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[70.464976] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[70.469272] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[70.545902] [007/133] (947s left) kms_chamelium_hpd (dp-hpd-fast)
[70.903659] Subtest dp-hpd-fast: SKIP (0.000s)
[71.704188] [008/133] (946s left) sriov_basic (enable-vfs-autoprobe-off)
[71.767179] Starting subtest: enable-vfs-autoprobe-off
[71.769490] Starting dynamic subtest: numvfs-1
[71.843798] Dynamic subtest numvfs-1: FAIL (0.015s)
[71.853070] Starting dynamic subtest: numvfs-2
[71.927397] Dynamic subtest numvfs-2: FAIL (0.004s)
[71.935910] Starting dynamic subtest: numvfs-3
[72.009277] Dynamic subtest numvfs-3: FAIL (0.004s)
[72.019120] Starting dynamic subtest: numvfs-4
[72.091993] Dynamic subtest numvfs-4: FAIL (0.004s)
[72.100809] Starting dynamic subtest: numvfs-5
[72.174671] Dynamic subtest numvfs-5: FAIL (0.003s)
[72.184321] Starting dynamic subtest: numvfs-6
[72.257442] Dynamic subtest numvfs-6: FAIL (0.004s)
[72.266027] Starting dynamic subtest: numvfs-7
[72.340635] Dynamic subtest numvfs-7: FAIL (0.003s)
[72.349214] Starting dynamic subtest: numvfs-random
[72.421262] Dynamic subtest numvfs-random: FAIL (0.003s)
[72.429732] Starting dynamic subtest: numvfs-all
[72.502589] Dynamic subtest numvfs-all: FAIL (0.509s)
[72.504908] Subtest enable-vfs-autoprobe-off: FAIL (0.552s)
[72.539749] [009/133] (945s left) gem_ctx_persistence (engines-persistence)
[72.595033] Starting subtest: engines-persistence
[72.597504] Starting dynamic subtest: rcs0
[73.374741] Dynamic subtest rcs0: SUCCESS (0.778s)
[73.384886] Starting dynamic subtest: bcs0
[74.138702] Dynamic subtest bcs0: SUCCESS (0.763s)
[74.146436] Starting dynamic subtest: vcs0
[74.902808] Dynamic subtest vcs0: SUCCESS (0.765s)
[74.912437] Starting dynamic subtest: vcs1
[75.670807] Dynamic subtest vcs1: SUCCESS (0.767s)
[75.680675] Starting dynamic subtest: vecs0
[76.438181] Dynamic subtest vecs0: SUCCESS (0.766s)
[76.448171] Starting dynamic subtest: ccs0
[77.185807] Dynamic subtest ccs0: SUCCESS (0.747s)
[77.188528] Subtest engines-persistence: SUCCESS (4.591s)
[77.328025] [010/133] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[77.419597] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[77.424091] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[77.531411] [011/133] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[77.617239] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[77.621359] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[77.718570] [012/133] (940s left) gem_exec_schedule (wide)
[77.897489] Starting subtest: wide
[77.900198] Starting dynamic subtest: rcs0
[88.596955] Dynamic subtest rcs0: SUCCESS (10.697s)
[88.607846] Starting dynamic subtest: vcs0
[102.457697] Dynamic subtest vcs0: SUCCESS (13.859s)
[102.468686] Starting dynamic subtest: vcs1
[117.234408] Dynamic subtest vcs1: SUCCESS (14.776s)
[117.245588] Starting dynamic subtest: vecs0
[132.144181] Dynamic subtest vecs0: SUCCESS (14.909s)
[132.155035] Starting dynamic subtest: ccs0
[149.490291] Dynamic subtest ccs0: SUCCESS (17.345s)
[149.492739] Subtest wide: SUCCESS (71.589s)
[151.482265] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[151.485814] [013/133] (866s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[151.559606] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[151.561886] Starting dynamic subtest: pipe-A-eDP-1
[151.584325] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.592882] Starting dynamic subtest: pipe-B-eDP-1
[151.613954] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.622142] Starting dynamic subtest: pipe-C-eDP-1
[151.643054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.650976] Starting dynamic subtest: pipe-D-eDP-1
[151.672993] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.677138] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[153.881704] [014/133] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[153.965739] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[161.140881] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.178s)
[161.276168] [015/133] (856s left) kms_psr (psr2-cursor-blt)
[161.359958] Starting subtest: psr2-cursor-blt
[161.362291] Starting dynamic subtest: eDP-1
[163.055936] Dynamic subtest eDP-1: SUCCESS (1.695s)
[163.058385] Subtest psr2-cursor-blt: SUCCESS (1.696s)
[163.851618] [016/133] (854s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[163.939131] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[163.941305] Starting dynamic subtest: pipe-A-eDP-1
[174.912914] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.980s)
[174.922331] Starting dynamic subtest: pipe-B-eDP-1
[186.642719] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.727s)
[186.645199] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.710s)
[187.516110] [017/133] (830s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[187.592345] Starting subtest: psr-rgb101010-draw-mmap-cpu
[194.664728] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.075s)
[194.782076] [018/133] (823s left) kms_psr (fbc-psr-dpms)
[194.862681] Starting subtest: fbc-psr-dpms
[194.864824] Starting dynamic subtest: eDP-1
[194.868733] Dynamic subtest eDP-1: SKIP (0.000s)
[194.872696] Subtest fbc-psr-dpms: SKIP (0.001s)
[194.935411] [019/133] (823s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[195.009315] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[195.013718] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[195.088872] [020/133] (823s left) kms_cdclk (mode-transition-all-outputs)
[195.171055] Starting subtest: mode-transition-all-outputs
[195.462069] Subtest mode-transition-all-outputs: SKIP (0.288s)
[196.282459] [021/133] (822s left) i915_pm_freq_api (freq-reset-multiple)
[196.348071] Starting subtest: freq-reset-multiple
[196.350316] Starting dynamic subtest: gt0
[205.942965] Dynamic subtest gt0: SUCCESS (9.595s)
[205.952597] Starting dynamic subtest: gt1
[214.129867] Dynamic subtest gt1: SUCCESS (8.187s)
[214.132388] Subtest freq-reset-multiple: SUCCESS (17.783s)
[214.208959] [022/133] (804s left) kms_color (ctm-0-75)
[214.293614] Starting subtest: ctm-0-75
[214.295795] Starting dynamic subtest: pipe-A-eDP-1
[219.124797] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.832s)
[219.134307] Starting dynamic subtest: pipe-B-eDP-1
[224.570725] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.446s)
[224.578698] Starting dynamic subtest: pipe-C-eDP-1
[229.940064] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.365s)
[229.950613] Starting dynamic subtest: pipe-D-eDP-1
[235.280432] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.343s)
[235.282738] Subtest ctm-0-75: SUCCESS (20.988s)
[236.111334] [023/133] (782s left) perf (unprivileged-single-ctx-counters)
[236.239317] Starting subtest: unprivileged-single-ctx-counters
[236.243887] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[236.285963] [024/133] (782s left) kms_legacy_colorkey (invalid-plane)
[236.360432] Starting subtest: invalid-plane
[236.362653] Starting dynamic subtest: zero-id
[236.364724] Dynamic subtest zero-id: SUCCESS (0.000s)
[236.372577] Starting dynamic subtest: outrange-id
[236.374798] Dynamic subtest outrange-id: SUCCESS (0.000s)
[236.376644] Subtest invalid-plane: SUCCESS (0.002s)
[236.430901] [025/133] (782s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[236.510728] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[236.513067] Starting dynamic subtest: pipe-A-eDP-1
[236.534542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.544037] Starting dynamic subtest: pipe-B-eDP-1
[236.564156] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.571821] Starting dynamic subtest: pipe-C-eDP-1
[236.592626] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.600093] Starting dynamic subtest: pipe-D-eDP-1
[236.621327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.625587] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[238.768991] [026/133] (779s left) kms_content_protection (suspend-resume)
[238.886952] Starting subtest: suspend-resume
[238.891617] Subtest suspend-resume: SKIP (0.000s)
[239.019469] [027/133] (779s left) perf (invalid-oa-exponent)
[239.119450] Starting subtest: invalid-oa-exponent
[239.136755] Subtest invalid-oa-exponent: SUCCESS (0.017s)
[239.183707] [028/133] (779s left) kms_psr (psr2-sprite-mmap-gtt)
[239.254064] Starting subtest: psr2-sprite-mmap-gtt
[239.256200] Starting dynamic subtest: eDP-1
[240.667895] Dynamic subtest eDP-1: SKIP (1.410s)
[240.673068] Subtest psr2-sprite-mmap-gtt: SKIP (1.411s)
[240.829876] [029/133] (777s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[240.926816] Starting subtest: cursorA-vs-flipB-atomic
[240.931241] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[241.068297] [030/133] (777s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[241.138934] Starting subtest: dsc-fractional-bpp-with-bpc
[241.169630] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[241.210741] [031/133] (777s left) gem_mmap (basic-small-bo)
[241.260276] Subtest basic-small-bo: SKIP (0.000s)
[241.318933] [032/133] (777s left) i915_query (query-topology-kernel-writes)
[241.371481] Starting subtest: query-topology-kernel-writes
[241.373759] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[241.461221] [033/133] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[241.538707] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[241.542521] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[241.633056] [034/133] (777s left) kms_cursor_edge_walk (64x64-top-edge)
[241.703328] Starting subtest: 64x64-top-edge
[241.705137] Starting dynamic subtest: pipe-A-eDP-1
[245.155235] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.450s)
[245.164009] Starting dynamic subtest: pipe-D-eDP-1
[248.289802] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[248.292088] Subtest 64x64-top-edge: SUCCESS (6.586s)
[249.096142] [035/133] (769s left) syncobj_wait (invalid-signal-zero-handles)
[249.152285] Starting subtest: invalid-signal-zero-handles
[249.154621] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[249.252788] [036/133] (769s left) kms_psr (psr-suspend)
[249.343981] Starting subtest: psr-suspend
[249.346365] Starting dynamic subtest: eDP-1
[266.918961] Dynamic subtest eDP-1: SUCCESS (3.077s)
[266.921354] Subtest psr-suspend: SUCCESS (3.079s)
[267.769781] [037/133] (751s left) perf_pmu (idle)
[267.829492] Starting subtest: idle
[267.831855] Starting dynamic subtest: rcs0
[268.370246] Dynamic subtest rcs0: SUCCESS (0.540s)
[268.382698] Starting dynamic subtest: bcs0
[268.893398] Dynamic subtest bcs0: SUCCESS (0.520s)
[268.906227] Starting dynamic subtest: vcs0
[269.411749] Dynamic subtest vcs0: SUCCESS (0.515s)
[269.423511] Starting dynamic subtest: vcs1
[269.936448] Dynamic subtest vcs1: SUCCESS (0.522s)
[269.949416] Starting dynamic subtest: vecs0
[270.455228] Dynamic subtest vecs0: SUCCESS (0.515s)
[270.467859] Starting dynamic subtest: ccs0
[270.978088] Dynamic subtest ccs0: SUCCESS (0.520s)
[270.981464] Subtest idle: SUCCESS (3.148s)
[271.106104] [038/133] (747s left) gem_exec_fence (submit67)
[271.274584] Starting subtest: submit67
[271.279217] Subtest submit67: SKIP (0.000s)
[273.426782] [039/133] (745s left) gem_spin_batch (engines)
[273.499031] Starting subtest: engines
[273.501282] Starting dynamic subtest: rcs0
[276.743479] Dynamic subtest rcs0: SUCCESS (3.241s)
[276.757163] Starting dynamic subtest: bcs0
[279.981505] Dynamic subtest bcs0: SUCCESS (3.233s)
[279.993752] Starting dynamic subtest: vcs0
[283.219969] Dynamic subtest vcs0: SUCCESS (3.234s)
[283.232165] Starting dynamic subtest: vcs1
[286.460010] Dynamic subtest vcs1: SUCCESS (3.236s)
[286.472153] Starting dynamic subtest: vecs0
[289.694885] Dynamic subtest vecs0: SUCCESS (3.231s)
[289.707129] Starting dynamic subtest: ccs0
[292.933789] Dynamic subtest ccs0: SUCCESS (3.235s)
[292.936299] Subtest engines: SUCCESS (19.431s)
[293.156509] [040/133] (726s left) gem_ctx_persistence (legacy-engines-hang)
[293.214180] Starting subtest: legacy-engines-hang
[293.216471] Starting dynamic subtest: render
[293.296365] Dynamic subtest render: SUCCESS (0.082s)
[293.308258] Starting dynamic subtest: bsd1
[293.391416] Dynamic subtest bsd1: SUCCESS (0.093s)
[293.403349] Starting dynamic subtest: bsd2
[293.489310] Dynamic subtest bsd2: SUCCESS (0.095s)
[293.501433] Starting dynamic subtest: blt
[293.585330] Dynamic subtest blt: SUCCESS (0.093s)
[293.597313] Starting dynamic subtest: vebox
[293.676352] Dynamic subtest vebox: SUCCESS (0.088s)
[293.678870] Subtest legacy-engines-hang: SUCCESS (0.464s)
[293.761207] [041/133] (725s left) gem_exec_reloc (basic-wc-noreloc)
[293.815754] Subtest basic-wc-noreloc: SKIP (0.000s)
[293.889228] [042/133] (725s left) gen7_exec_parse (basic-rejected)
[293.943467] Subtest basic-rejected: SKIP (0.000s)
[294.000038] [043/133] (725s left) gem_exec_flush (basic-wb-rw-default)
[294.061339] Starting subtest: basic-wb-rw-default
[299.529126] Subtest basic-wb-rw-default: SUCCESS (5.468s)
[299.717899] [044/133] (719s left) kms_vrr (max-min)
[299.800710] Starting subtest: max-min
[299.807604] Subtest max-min: SKIP (0.000s)
[299.871841] [045/133] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[299.953084] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[299.957545] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[300.065319] [046/133] (719s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[300.167110] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[311.353441] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.186s)
[312.225301] [047/133] (707s left) kms_async_flips (crc-atomic)
[312.301955] Starting subtest: crc-atomic
[312.672495] Starting dynamic subtest: pipe-A-eDP-1
[315.612356] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.939s)
[315.989760] Starting dynamic subtest: pipe-B-eDP-1
[318.850817] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s)
[319.226622] Starting dynamic subtest: pipe-C-eDP-1
[322.064083] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.846s)
[322.428376] Starting dynamic subtest: pipe-D-eDP-1
[325.290238] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.874s)
[325.292617] Subtest crc-atomic: SUCCESS (12.990s)
[326.478424] [048/133] (693s left) kms_pm_rpm (system-suspend-idle)
[328.504215] Starting subtest: system-suspend-idle
[347.677038] Subtest system-suspend-idle: SUCCESS (4.289s)
[348.064169] [049/133] (671s left) kms_sequence (queue-busy)
[348.149446] Starting subtest: queue-busy
[348.151627] Starting dynamic subtest: pipe-A-eDP-1
[350.090803] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[350.100758] Starting dynamic subtest: pipe-B-eDP-1
[352.647170] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.553s)
[352.657365] Starting dynamic subtest: pipe-C-eDP-1
[355.262485] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.615s)
[355.273290] Starting dynamic subtest: pipe-D-eDP-1
[357.794806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[357.797111] Subtest queue-busy: SUCCESS (9.640s)
[358.606861] [050/133] (660s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[358.685653] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[358.687987] Starting dynamic subtest: pipe-A-eDP-1
[358.711021] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[358.723014] Starting dynamic subtest: pipe-B-eDP-1
[358.744617] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[358.753556] Starting dynamic subtest: pipe-C-eDP-1
[358.775255] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[358.783915] Starting dynamic subtest: pipe-D-eDP-1
[358.805851] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[358.810216] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[360.959147] [051/133] (658s left) kms_properties (connector-properties-legacy)
[361.040206] Starting subtest: connector-properties-legacy
[361.042463] Starting dynamic subtest: pipe-A-eDP-1
[368.952510] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.911s)
[368.962145] Starting dynamic subtest: pipe-None-DP-1
[368.966484] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[368.975281] Starting dynamic subtest: pipe-None-DP-2
[368.979779] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[368.988378] Starting dynamic subtest: pipe-None-DP-3
[368.992450] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[369.001576] Starting dynamic subtest: pipe-None-DP-4
[369.006115] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[369.015049] Starting dynamic subtest: pipe-None-DP-5
[369.019469] Dynamic subtest pipe-None-DP-5: SUCCESS (0.001s)
[369.021756] Subtest connector-properties-legacy: SUCCESS (7.921s)
[369.819330] [052/133] (649s left) vgem_basic (dmabuf-export)
[369.862658] Starting subtest: dmabuf-export
[369.882159] Subtest dmabuf-export: SUCCESS (0.023s)
[369.981547] [053/133] (649s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[370.055957] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[370.058232] Starting dynamic subtest: pipe-A-eDP-1
[370.078563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[370.090794] Starting dynamic subtest: pipe-B-eDP-1
[370.109197] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[370.117879] Starting dynamic subtest: pipe-C-eDP-1
[370.137007] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[370.145796] Starting dynamic subtest: pipe-D-eDP-1
[370.165153] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[370.167030] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[372.292429] [054/133] (647s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[372.413482] Starting subtest: cursorA-vs-flipB-atomic-transitions
[372.418007] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[372.557533] [055/133] (647s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[372.641233] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[372.645467] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[372.729028] [056/133] (647s left) i915_query (query-regions-garbage-items)
[372.788449] Starting subtest: query-regions-garbage-items
[372.790671] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[372.893145] [057/133] (646s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[372.952776] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[373.053019] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[373.145167] [058/133] (646s left) gem_exec_balancer (busy)
[373.201298] Starting subtest: busy
[375.215190] Subtest busy: SUCCESS (2.015s)
[375.531981] [059/133] (644s left) kms_async_flips (async-flip-suspend-resume)
[375.610947] Starting subtest: async-flip-suspend-resume
[375.983680] Starting dynamic subtest: pipe-A-eDP-1
[393.471420] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.961s)
[393.913676] Starting dynamic subtest: pipe-B-eDP-1
[411.469596] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.851s)
[411.850928] Starting dynamic subtest: pipe-C-eDP-1
[429.467724] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.910s)
[429.831155] Starting dynamic subtest: pipe-D-eDP-1
[447.500811] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.943s)
[447.503189] Subtest async-flip-suspend-resume: SUCCESS (13.192s)
[448.664651] [060/133] (571s left) kms_invalid_mode (bad-vsync-end)
[448.743644] Starting subtest: bad-vsync-end
[448.746048] Starting dynamic subtest: pipe-A-eDP-1
[449.027258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[449.041620] Starting dynamic subtest: pipe-B-eDP-1
[449.043626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[449.053063] Starting dynamic subtest: pipe-C-eDP-1
[449.055319] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[449.064842] Starting dynamic subtest: pipe-D-eDP-1
[449.067095] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[449.069382] Subtest bad-vsync-end: SUCCESS (0.292s)
[449.899139] [061/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[449.989823] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[456.535408] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.540s)
[456.652890] [062/133] (563s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[456.725208] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[457.349809] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.625s)
[457.499532] [063/133] (562s left) gem_ctx_sseu (engines)
[457.567767] Subtest engines: SKIP (0.000s)
[457.643913] [064/133] (562s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[457.699421] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[457.801062] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[457.887080] [065/133] (562s left) kms_cursor_crc (cursor-offscreen-max-size)
[458.168411] Starting subtest: cursor-offscreen-max-size
[458.174866] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[458.293748] [066/133] (561s left) gem_exec_flush (basic-wb-set-default)
[458.348885] Starting subtest: basic-wb-set-default
[463.820553] Subtest basic-wb-set-default: SUCCESS (5.467s)
[464.021957] [067/133] (556s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[464.102335] Starting subtest: psr-dirtyfb-ioctl
[464.104624] Starting dynamic subtest: A-eDP-1
[467.959142] Dynamic subtest A-eDP-1: SUCCESS (3.852s)
[467.961344] Subtest psr-dirtyfb-ioctl: SUCCESS (3.854s)
[468.752700] [068/133] (551s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[468.828900] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[468.832784] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[468.937355] [069/133] (551s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[469.012405] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[469.017235] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[469.105221] [070/133] (551s left) gem_caching (read-writes)
[469.168310] Subtest read-writes: SKIP (0.000s)
[469.220321] [071/133] (551s left) gem_mmap_gtt (hang)
[469.276964] Subtest hang: SKIP (0.000s)
[469.338974] [072/133] (551s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[469.446816] Starting subtest: flip-vs-cursor-varying-size
[478.270765] Subtest flip-vs-cursor-varying-size: SUCCESS (8.816s)
[479.084725] [073/133] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[479.167319] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[479.171718] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[479.275721] [074/133] (541s left) gem_mmap_gtt (medium-copy-xy)
[479.340346] Subtest medium-copy-XY: SKIP (0.000s)
[479.402183] [075/133] (541s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[479.455406] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[479.457553] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[479.555584] [076/133] (541s left) syncobj_timeline (multi-wait-for-submit-signaled)
[479.615224] Starting subtest: multi-wait-for-submit-signaled
[479.617420] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[479.736157] [077/133] (540s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[479.818059] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[479.821899] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[479.931452] [078/133] (540s left) api_intel_bb (add-remove-objects)
[479.978430] Starting subtest: add-remove-objects
[479.987363] Subtest add-remove-objects: SUCCESS (0.010s)
[480.110067] [079/133] (540s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[480.162746] Starting subtest: yf-tiled-ccs-to-x-tiled
[480.166711] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[480.344572] [080/133] (540s left) gem_exec_whisper (basic-sync)
[480.412372] Starting subtest: basic-sync
[486.770277] Subtest basic-sync: SUCCESS (6.352s)
[486.957533] [081/133] (533s left) kms_big_fb (linear-16bpp-rotate-90)
[487.039801] Starting subtest: linear-16bpp-rotate-90
[487.058506] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[487.173172] [082/133] (533s left) gem_exec_reloc (basic-cpu-wc-active)
[487.233744] Subtest basic-cpu-wc-active: SKIP (0.000s)
[487.315133] [083/133] (533s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[487.395761] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[487.398010] Starting dynamic subtest: pipe-A-eDP-1
[487.460164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[487.761055] Starting dynamic subtest: pipe-B-eDP-1
[488.588886] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.834s)
[488.884354] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.486s)
[489.736865] [084/133] (531s left) kms_plane_alpha_blend (alpha-transparent-fb)
[489.834300] Starting subtest: alpha-transparent-fb
[490.116356] Starting dynamic subtest: pipe-A-eDP-1
[490.800130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.681s)
[490.810502] Starting dynamic subtest: pipe-D-eDP-1
[492.179207] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.376s)
[492.181627] Subtest alpha-transparent-fb: SUCCESS (2.345s)
[493.012372] [085/133] (528s left) gem_userptr_blits (coherency-unsync)
[493.082558] Subtest coherency-unsync: SKIP (0.000s)
[493.198424] [086/133] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[493.271120] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[500.385061] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.112s)
[500.511829] [087/133] (520s left) gem_mmap_gtt (big-bo)
[500.570879] Subtest big-bo: SKIP (0.000s)
[500.637043] [088/133] (520s left) gem_render_tiled_blits (basic)
[500.701047] Subtest basic: SKIP (0.000s)
[500.763403] [089/133] (520s left) gem_close_race (multigpu-basic-threads)
[500.819912] Starting subtest: multigpu-basic-threads
[500.824322] Subtest multigpu-basic-threads: SKIP (0.000s)
[501.044462] [090/133] (520s left) sysfs_timeslice_duration (timeout)
[501.098068] Starting subtest: timeout
[501.100282] Starting dynamic subtest: vecs0
[510.939064] Dynamic subtest vecs0: SUCCESS (9.833s)
[510.950794] Starting dynamic subtest: ccs0
[512.270657] Dynamic subtest ccs0: SUCCESS (1.330s)
[512.281572] Starting dynamic subtest: vcs0
[520.919327] Dynamic subtest vcs0: SUCCESS (8.641s)
[520.931636] Starting dynamic subtest: bcs0
[521.603509] Dynamic subtest bcs0: SUCCESS (0.683s)
[521.613594] Starting dynamic subtest: rcs0
[522.857129] Dynamic subtest rcs0: SUCCESS (1.251s)
[522.866682] Starting dynamic subtest: vcs1
[532.887554] Dynamic subtest vcs1: SUCCESS (10.020s)
[532.890111] Subtest timeout: SUCCESS (31.771s)
[532.961549] [091/133] (488s left) syncobj_eventfd (timeline-wait-before-signal)
[533.016800] Starting subtest: timeline-wait-before-signal
[533.046200] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[533.127414] [092/133] (488s left) prime_self_import (basic-with_one_bo_two_files)
[533.166864] Starting subtest: basic-with_one_bo_two_files
[533.184153] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[533.285369] [093/133] (488s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[533.357803] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[533.360060] Starting dynamic subtest: pipe-A
[533.420649] Dynamic subtest pipe-A: SUCCESS (0.065s)
[533.432248] Starting dynamic subtest: pipe-B
[534.556193] Dynamic subtest pipe-B: SUCCESS (1.133s)
[534.568169] Starting dynamic subtest: pipe-C
[535.672083] Dynamic subtest pipe-C: SUCCESS (1.114s)
[535.682202] Starting dynamic subtest: pipe-D
[536.803728] Dynamic subtest pipe-D: SUCCESS (1.130s)
[536.805995] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.447s)
[537.960953] [094/133] (483s left) i915_drm_fdinfo (memory-info-idle)
[538.012233] Starting subtest: memory-info-idle
[538.014405] Starting dynamic subtest: smem0
[538.056554] Dynamic subtest smem0: SUCCESS (0.046s)
[538.059453] Subtest memory-info-idle: SUCCESS (0.046s)
[538.147894] [095/133] (483s left) gem_exec_balancer (sequential)
[538.225851] Starting subtest: sequential
[541.277560] Subtest sequential: SUCCESS (3.053s)
[541.592547] [096/133] (479s left) kms_cursor_crc (cursor-random-128x128)
[541.776433] Starting subtest: cursor-random-128x128
[541.781213] Starting dynamic subtest: pipe-A-eDP-1
[545.132539] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.353s)
[545.159086] Starting dynamic subtest: pipe-D-eDP-1
[549.160532] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.008s)
[549.162385] Subtest cursor-random-128x128: SUCCESS (7.385s)
[550.024187] [097/133] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[550.115707] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[550.119722] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[550.207681] [098/133] (471s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[550.281750] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[550.290278] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.008s)
[550.365326] [099/133] (471s left) gem_lmem_swapping (parallel-random-verify-ccs)
[550.413520] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[550.453260] [100/133] (471s left) kms_addfb_basic (bad-pitch-256)
[550.515968] Starting subtest: bad-pitch-256
[550.518078] Subtest bad-pitch-256: SUCCESS (0.000s)
[550.630586] [101/133] (471s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[550.690502] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[550.694877] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[550.877526] [102/133] (470s left) gem_pread (bench)
[550.929903] Subtest bench: SKIP (0.000s)
[550.989055] [103/133] (470s left) gem_barrier_race (remote-request)
[551.051195] Starting subtest: remote-request
[551.053283] Starting dynamic subtest: rcs0
[556.227256] Dynamic subtest rcs0: SUCCESS (5.181s)
[556.230854] Subtest remote-request: SUCCESS (5.182s)
[556.357070] [104/133] (465s left) syncobj_wait (wait-all-for-submit-snapshot)
[556.412142] Starting subtest: wait-all-for-submit-snapshot
[556.494322] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[556.578019] [105/133] (465s left) kms_vblank (ts-continuation-dpms-rpm)
[556.646554] Starting subtest: ts-continuation-dpms-rpm
[556.648371] Starting dynamic subtest: pipe-A-eDP-1
[559.127070] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.480s)
[559.144918] Starting dynamic subtest: pipe-D-eDP-1
[561.358162] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.228s)
[561.360504] Subtest ts-continuation-dpms-rpm: SUCCESS (4.712s)
[562.157805] [106/133] (459s left) gem_exec_schedule (preempt-queue-contexts-chain)
[562.224025] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[562.515051] [107/133] (459s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[562.599351] Starting subtest: 4-tiled-16bpp-rotate-270
[562.619824] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[562.733657] [108/133] (459s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[562.813252] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[562.817494] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[562.921435] [109/133] (459s left) syncobj_wait (invalid-signal-bad-pad)
[562.977208] Starting subtest: invalid-signal-bad-pad
[562.979493] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[563.059760] [110/133] (459s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[563.144091] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[563.148618] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[563.253910] [111/133] (458s left) kms_pm_dc (dc5-dpms)
[564.345623] Starting subtest: dc5-dpms
[566.419967] Subtest dc5-dpms: SUCCESS (2.074s)
[566.502842] [112/133] (455s left) kms_plane_scaling (invalid-num-scalers)
[566.580280] Starting subtest: invalid-num-scalers
[566.582562] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[566.601208] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[566.611660] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[566.634849] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[566.644897] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[566.667373] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[566.677239] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[566.699232] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[566.701523] Subtest invalid-num-scalers: SUCCESS (0.118s)
[566.801189] [113/133] (455s left) core_getversion (all-cards)
[566.847038] Starting subtest: all-cards
[566.856814] Subtest all-cards: SUCCESS (0.012s)
[566.901203] [114/133] (455s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[566.992096] Starting subtest: extended-modeset-hang-newfb-with-reset
[566.994320] Starting dynamic subtest: pipe-A
[582.128927] Dynamic subtest pipe-A: SUCCESS (15.137s)
[582.139930] Starting dynamic subtest: pipe-D
[597.611867] Dynamic subtest pipe-D: SUCCESS (15.482s)
[597.614284] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.623s)
[598.411336] [115/133] (423s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[598.480519] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[598.485090] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[598.555336] [116/133] (423s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[598.603349] Starting subtest: invalid-signal-one-illegal-handle
[598.605530] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[598.704809] [117/133] (423s left) gem_mmap_gtt (fault-concurrent-y)
[598.765237] Subtest fault-concurrent-Y: SKIP (0.000s)
[598.824963] [118/133] (423s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[598.885638] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[598.887687] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[599.005987] [119/133] (423s left) gem_exec_reloc (basic-concurrent0)
[599.063289] Subtest basic-concurrent0: SKIP (0.000s)
[599.125022] [120/133] (423s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[599.207667] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[600.398367] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.191s)
[600.519318] [121/133] (422s left) api_intel_bb (object-reloc-purge-cache)
[600.565061] Starting subtest: object-reloc-purge-cache
[600.568912] Subtest object-reloc-purge-cache: SKIP (0.003s)
[600.680725] [122/133] (421s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[600.749532] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[600.752919] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[600.857457] [123/133] (421s left) gem_exec_schedule (preempt-engines)
[600.928210] Starting subtest: preempt-engines
[600.929981] Starting dynamic subtest: rcs0
[603.181956] Dynamic subtest rcs0: SUCCESS (2.257s)
[603.196235] Starting dynamic subtest: bcs0
[605.443402] Dynamic subtest bcs0: SUCCESS (2.259s)
[605.456849] Starting dynamic subtest: vcs0
[607.731483] Dynamic subtest vcs0: SUCCESS (2.286s)
[607.744836] Starting dynamic subtest: vcs1
[610.071014] Dynamic subtest vcs1: SUCCESS (2.336s)
[610.083872] Starting dynamic subtest: vecs0
[612.379074] Dynamic subtest vecs0: SUCCESS (2.306s)
[612.392409] Starting dynamic subtest: ccs0
[614.652376] Dynamic subtest ccs0: SUCCESS (2.271s)
[614.655347] Subtest preempt-engines: SUCCESS (13.728s)
[614.962268] [124/133] (407s left) kms_psr2_su (page_flip-nv12)
[615.017139] Subtest page_flip-NV12: SKIP (0.000s)
[615.085669] [125/133] (407s left) gem_exec_suspend (basic)
[615.151254] Starting subtest: basic
[615.153494] Starting dynamic subtest: smem
[616.926625] Dynamic subtest smem: SUCCESS (1.773s)
[616.929426] Subtest basic: SUCCESS (1.775s)
[617.114023] [126/133] (405s left) i915_pm_rpm (debugfs-read)
[619.025937] Starting subtest: debugfs-read
[620.171397] Subtest debugfs-read: SUCCESS (1.144s)
[620.544387] [127/133] (402s left) gem_wait (write-wait)
[620.608430] Starting subtest: write-wait
[620.610874] Starting dynamic subtest: all-engines
[621.750819] Dynamic subtest all-engines: SUCCESS (1.141s)
[621.768366] Starting dynamic subtest: rcs0
[622.810215] Dynamic subtest rcs0: SUCCESS (1.057s)
[622.826793] Starting dynamic subtest: bcs0
[623.868294] Dynamic subtest bcs0: SUCCESS (1.055s)
[623.885757] Starting dynamic subtest: vcs0
[624.923929] Dynamic subtest vcs0: SUCCESS (1.053s)
[624.941730] Starting dynamic subtest: vcs1
[625.978869] Dynamic subtest vcs1: SUCCESS (1.052s)
[625.997449] Starting dynamic subtest: vecs0
[627.035448] Dynamic subtest vecs0: SUCCESS (1.054s)
[627.052627] Starting dynamic subtest: ccs0
[628.092960] Dynamic subtest ccs0: SUCCESS (1.055s)
[628.095548] Subtest write-wait: SUCCESS (7.484s)
[628.289316] [128/133] (394s left) kms_psr (fbc-psr2-cursor-plane-move)
[628.369900] Starting subtest: fbc-psr2-cursor-plane-move
[628.372080] Starting dynamic subtest: eDP-1
[628.376140] Dynamic subtest eDP-1: SKIP (0.000s)
[628.380185] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[628.456358] [129/133] (394s left) kms_chamelium_frames (hdmi-crc-fast)
[628.826739] Subtest hdmi-crc-fast: SKIP (0.000s)
[629.658015] [130/133] (393s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[629.743997] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[629.748096] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[629.820538] [131/133] (393s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[629.895097] Starting subtest: psr-shrfb-scaledprimary
[635.631258] Subtest psr-shrfb-scaledprimary: SUCCESS (5.738s)
[635.791900] [132/133] (387s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[635.869195] Starting subtest: yf-tiled-32bpp-rotate-90
[635.873496] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[635.982544] [133/133] (387s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[636.064426] Starting subtest: 2x-plain-flip-ts-check-interruptible
[636.074834] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.008s)
[636.149263] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_atomic_transition
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_properties
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_chamelium_hpd
results: parsing output: 7/ for test: sriov_basic
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_cdclk
results: parsing output: 20/ for test: i915_pm_freq_api
results: parsing output: 21/ for test: kms_color
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_legacy_colorkey
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_content_protection
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_dsc
results: parsing output: 30/ for test: gem_mmap
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_cursor_edge_walk
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: gem_spin_batch
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gen7_exec_parse
results: parsing output: 42/ for test: gem_exec_flush
results: parsing output: 43/ for test: kms_vrr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_sequence
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_properties
results: parsing output: 51/ for test: vgem_basic
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: i915_query
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: kms_invalid_mode
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_ctx_sseu
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: kms_dirtyfb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_caching
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_atomic_transition
results: parsing output: 83/ for test: kms_plane_alpha_blend
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: gem_render_tiled_blits
results: parsing output: 88/ for test: gem_close_race
results: parsing output: 89/ for test: sysfs_timeslice_duration
results: parsing output: 90/ for test: syncobj_eventfd
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: gem_pread
results: parsing output: 102/ for test: gem_barrier_race
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_pm_dc
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: core_getversion
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_psr2_su
results: parsing output: 124/ for test: gem_exec_suspend
results: parsing output: 125/ for test: i915_pm_rpm
results: parsing output: 126/ for test: gem_wait
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_chamelium_frames
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_flip
Done.