[58.022385] Initializing watchdogs
[58.022446]   /dev/watchdog0
[58.037762] [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]
[58.042454] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.044825] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.048194] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[58.344661] Starting subtest: cursor-offscreen-256x85
[58.397549] Subtest cursor-offscreen-256x85: SKIP (0.049s)
[58.556184] [002/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[58.648999] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[58.651337] Starting dynamic subtest: pipe-A-eDP-1
[58.707987] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[58.715648] Starting dynamic subtest: pipe-B-eDP-1
[58.770200] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[58.779974] Starting dynamic subtest: pipe-C-eDP-1
[58.839385] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[58.848135] Starting dynamic subtest: pipe-D-eDP-1
[58.906819] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[58.911451] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[60.967026] [003/133] (957s left) sysfs_timeslice_duration (duration)
[61.044020] Starting subtest: duration
[61.046333] Starting dynamic subtest: vecs0
[74.805813] Dynamic subtest vecs0: SUCCESS (13.762s)
[74.815830] Starting dynamic subtest: ccs0
[87.947394] Dynamic subtest ccs0: SUCCESS (13.141s)
[87.958726] Starting dynamic subtest: vcs0
[101.815376] Dynamic subtest vcs0: SUCCESS (13.863s)
[101.831541] Starting dynamic subtest: bcs0
[114.962906] Dynamic subtest bcs0: SUCCESS (13.149s)
[114.973414] Starting dynamic subtest: rcs0
[128.109936] Dynamic subtest rcs0: SUCCESS (13.146s)
[128.122330] Starting dynamic subtest: vcs1
[141.813071] Dynamic subtest vcs1: SUCCESS (13.701s)
[141.816600] Subtest duration: SUCCESS (80.769s)
[141.885428] [004/133] (876s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[141.991833] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[141.993784] Starting dynamic subtest: pipe-A-eDP-1
[157.979321] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.520s)
[157.989615] Starting dynamic subtest: pipe-B-eDP-1
[174.927426] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.402s)
[174.935594] Starting dynamic subtest: pipe-C-eDP-1
[191.909764] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.345s)
[191.918073] Starting dynamic subtest: pipe-D-eDP-1
[208.888050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.309s)
[208.890286] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.579s)
[210.036949] [005/133] (808s left) drm_buddy (drm_buddy)
[210.089595] Starting subtest: drm_buddy
[210.098639] Subtest drm_buddy: SKIP (0.001s)
[210.182954] [006/133] (808s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[210.291036] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[211.116234] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[211.290681] [007/133] (807s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[211.386279] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[211.388565] Starting dynamic subtest: pipe-A-eDP-1
[212.142243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[212.151800] Starting dynamic subtest: pipe-B-eDP-1
[213.974639] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.831s)
[213.988275] Starting dynamic subtest: pipe-C-eDP-1
[216.026334] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.049s)
[216.034089] Starting dynamic subtest: pipe-D-eDP-1
[217.880046] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.851s)
[217.882187] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.483s)
[219.082491] [008/133] (799s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[219.180113] Starting subtest: bad-pixel-format-yf-tiled-ccs
[219.182440] Starting dynamic subtest: pipe-A-eDP-1
[219.205721] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.214968] Starting dynamic subtest: pipe-B-eDP-1
[219.236926] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.244970] Starting dynamic subtest: pipe-C-eDP-1
[219.266909] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.275120] Starting dynamic subtest: pipe-D-eDP-1
[219.297331] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.301471] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[221.445288] [009/133] (797s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[221.509536] Starting subtest: multi-wait-available-unsubmitted-submitted
[221.512040] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.002s)
[221.608662] [010/133] (797s left) perf_pmu (event-wait)
[221.653371] Starting subtest: event-wait
[221.655760] Starting dynamic subtest: rcs0
[221.660028] Dynamic subtest rcs0: SKIP (0.000s)
[221.664551] Subtest event-wait: SKIP (0.000s)
[221.765100] [011/133] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[221.862057] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[221.866343] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[221.964703] [012/133] (797s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[222.070647] Starting subtest: psr-rgb565-draw-mmap-gtt
[222.074961] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[222.183908] [013/133] (796s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[222.279750] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[222.282096] Starting dynamic subtest: pipe-A-eDP-1
[228.137805] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.859s)
[228.147782] Starting dynamic subtest: pipe-B-eDP-1
[234.813766] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.670s)
[234.816125] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.531s)
[235.682528] [014/133] (783s left) kms_psr (fbc-psr2-dpms)
[235.778380] Starting subtest: fbc-psr2-dpms
[235.780644] Starting dynamic subtest: eDP-1
[235.784684] Dynamic subtest eDP-1: SKIP (0.000s)
[235.788786] Subtest fbc-psr2-dpms: SKIP (0.001s)
[235.851544] [015/133] (783s left) gem_exec_balancer (parallel-ordering)
[236.118455] Starting subtest: parallel-ordering
[237.084869] Subtest parallel-ordering: SUCCESS (0.966s)
[237.203121] [016/133] (781s left) kms_joiner (basic-big-joiner)
[237.306528] Starting subtest: basic-big-joiner
[237.310823] Subtest basic-big-joiner: SKIP (0.000s)
[237.373841] [017/133] (781s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[237.497684] Starting subtest: flip-vs-cursor-crc-atomic
[238.179583] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.681s)
[239.009114] [018/133] (780s left) gem_wait (wait)
[239.084456] Starting subtest: wait
[239.086973] Starting dynamic subtest: all-engines
[240.220022] Dynamic subtest all-engines: SUCCESS (1.134s)
[240.231262] Starting dynamic subtest: rcs0
[241.265373] Dynamic subtest rcs0: SUCCESS (1.044s)
[241.276357] Starting dynamic subtest: bcs0
[242.311044] Dynamic subtest bcs0: SUCCESS (1.044s)
[242.322877] Starting dynamic subtest: vcs0
[243.355948] Dynamic subtest vcs0: SUCCESS (1.043s)
[243.366819] Starting dynamic subtest: vcs1
[244.402752] Dynamic subtest vcs1: SUCCESS (1.045s)
[244.414457] Starting dynamic subtest: vecs0
[245.448130] Dynamic subtest vecs0: SUCCESS (1.043s)
[245.459600] Starting dynamic subtest: ccs0
[246.496064] Dynamic subtest ccs0: SUCCESS (1.046s)
[246.498931] Subtest wait: SUCCESS (7.409s)
[246.709518] [019/133] (772s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[246.812555] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[246.816492] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[246.908731] [020/133] (772s left) kms_flip (2x-flip-vs-expired-vblank)
[247.014729] Starting subtest: 2x-flip-vs-expired-vblank
[247.024088] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[247.107632] [021/133] (772s left) kms_lease (page-flip-implicit-plane)
[247.195437] Starting subtest: page-flip-implicit-plane
[247.197800] Starting dynamic subtest: pipe-A-eDP-1
[247.678436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s)
[247.689898] Starting dynamic subtest: pipe-B-eDP-1
[248.856876] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.174s)
[248.865904] Starting dynamic subtest: pipe-C-eDP-1
[249.958603] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[249.969768] Starting dynamic subtest: pipe-D-eDP-1
[251.090017] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[251.092461] Subtest page-flip-implicit-plane: SUCCESS (3.895s)
[251.923120] [022/133] (767s left) gem_exec_params (rsvd2-dirt)
[251.997910] Starting subtest: rsvd2-dirt
[252.002606] Subtest rsvd2-dirt: SKIP (0.000s)
[252.113902] [023/133] (767s left) api_intel_bb (blit-reloc-purge-cache)
[252.171643] Starting subtest: blit-reloc-purge-cache
[252.176333] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[252.300709] [024/133] (767s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[252.393715] Starting subtest: fbc-shrfb-scaledprimary
[255.389213] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.998s)
[256.528745] [025/133] (763s left) i915_pm_rpm (gem-idle)
[258.352451] Starting subtest: gem-idle
[264.553131] Subtest gem-idle: SUCCESS (6.200s)
[264.877307] [026/133] (754s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[266.223643] Starting subtest: x-tiled-8bpp-rotate-0
[267.438464] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.215s)
[267.569995] [027/133] (752s left) gem_exec_schedule (preempt-contexts)
[267.642282] Starting subtest: preempt-contexts
[267.644071] Starting dynamic subtest: rcs0
[267.696365] Dynamic subtest rcs0: SUCCESS (0.058s)
[267.705541] Starting dynamic subtest: bcs0
[267.748914] Dynamic subtest bcs0: SUCCESS (0.052s)
[267.757249] Starting dynamic subtest: vcs0
[267.792685] Dynamic subtest vcs0: SUCCESS (0.043s)
[267.800933] Starting dynamic subtest: vcs1
[267.844238] Dynamic subtest vcs1: SUCCESS (0.051s)
[267.853496] Starting dynamic subtest: vecs0
[267.901473] Dynamic subtest vecs0: SUCCESS (0.057s)
[267.910332] Starting dynamic subtest: ccs0
[267.948740] Dynamic subtest ccs0: SUCCESS (0.047s)
[267.950767] Subtest preempt-contexts: SUCCESS (0.311s)
[269.308116] [028/133] (750s left) gem_exec_flush (basic-uc-rw-default)
[269.365609] Starting subtest: basic-uc-rw-default
[274.818986] Subtest basic-uc-rw-default: SUCCESS (5.454s)
[275.005175] [029/133] (744s left) kms_color_pipeline (plane-lut1d)
[275.118708] Starting subtest: plane-lut1d
[275.267197] Starting dynamic subtest: pipe-A-plane-0
[275.647114] Dynamic subtest pipe-A-plane-0: FAIL (0.197s)
[275.655758] Starting dynamic subtest: pipe-A-plane-1
[275.877311] Dynamic subtest pipe-A-plane-1: FAIL (0.166s)
[275.887709] Starting dynamic subtest: pipe-A-plane-2
[276.108446] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[276.985399] Starting dynamic subtest: pipe-B-plane-0
[277.409511] Dynamic subtest pipe-B-plane-0: FAIL (0.164s)
[277.418037] Starting dynamic subtest: pipe-B-plane-1
[277.715755] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[277.727295] Starting dynamic subtest: pipe-B-plane-2
[278.025278] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[278.701002] Starting dynamic subtest: pipe-C-plane-0
[279.179907] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[279.192313] Starting dynamic subtest: pipe-C-plane-1
[279.575037] Dynamic subtest pipe-C-plane-1: FAIL (0.143s)
[279.584991] Starting dynamic subtest: pipe-C-plane-2
[279.929218] Dynamic subtest pipe-C-plane-2: FAIL (0.631s)
[280.844220] Starting dynamic subtest: pipe-D-plane-0
[281.419852] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[281.429895] Starting dynamic subtest: pipe-D-plane-1
[281.869417] Dynamic subtest pipe-D-plane-1: FAIL (0.606s)
[281.879248] Starting dynamic subtest: pipe-D-plane-2
[282.297944] Dynamic subtest pipe-D-plane-2: FAIL (0.550s)
[282.434916] Subtest plane-lut1d: FAIL (7.311s)
[283.305734] [030/133] (736s left) gem_exec_schedule (deep)
[283.495254] Starting subtest: deep
[283.497457] Starting dynamic subtest: rcs0
[288.628279] Dynamic subtest rcs0: SKIP (5.130s)
[288.639957] Starting dynamic subtest: vcs0
[298.929729] Dynamic subtest vcs0: SUCCESS (10.299s)
[298.943506] Starting dynamic subtest: vcs1
[309.755744] Dynamic subtest vcs1: SUCCESS (10.825s)
[309.768209] Starting dynamic subtest: vecs0
[321.236246] Dynamic subtest vecs0: SUCCESS (11.485s)
[321.257947] Starting dynamic subtest: ccs0
[332.994218] Dynamic subtest ccs0: SUCCESS (11.762s)
[332.996993] Subtest deep: SUCCESS (49.509s)
[333.987514] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[333.990758] [031/133] (685s left) kms_cursor_crc (cursor-suspend)
[334.125961] Starting subtest: cursor-suspend
[334.128281] Starting dynamic subtest: pipe-A-eDP-1
[367.226369] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.151s)
[367.238629] Starting dynamic subtest: pipe-D-eDP-1
[401.211321] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.707s)
[401.213776] Subtest cursor-suspend: SUCCESS (6.862s)
[402.040592] [032/133] (617s left) perf (gen8-unprivileged-single-ctx-counters)
[402.189279] Starting subtest: gen8-unprivileged-single-ctx-counters
[402.193646] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[402.231340] [033/133] (617s left) api_intel_bb (intel-bb-blit-y)
[402.293336] Starting subtest: intel-bb-blit-y
[406.009469] Subtest intel-bb-blit-y: SUCCESS (3.710s)
[406.135398] [034/133] (613s left) prime_mmap (test_refcounting)
[406.197896] Starting subtest: test_refcounting
[406.199856] Starting dynamic subtest: test_refcounting-smem
[406.229125] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[406.231608] Subtest test_refcounting: SUCCESS (0.033s)
[406.332125] [035/133] (613s left) kms_atomic_transition (modeset-transition)
[406.421022] Starting subtest: modeset-transition
[406.422889] Starting dynamic subtest: 1x-outputs
[417.213559] Dynamic subtest 1x-outputs: SUCCESS (10.784s)
[417.216002] Subtest modeset-transition: SUCCESS (10.786s)
[418.080777] [036/133] (601s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[418.170827] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[418.173260] Starting dynamic subtest: pipe-A
[418.190076] Dynamic subtest pipe-A: SKIP (0.016s)
[418.199272] Starting dynamic subtest: pipe-B
[418.220820] Dynamic subtest pipe-B: SKIP (0.030s)
[418.229879] Starting dynamic subtest: pipe-C
[418.252029] Dynamic subtest pipe-C: SKIP (0.032s)
[418.260692] Starting dynamic subtest: pipe-D
[418.285592] Dynamic subtest pipe-D: SKIP (0.031s)
[418.289267] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.112s)
[418.364693] [037/133] (601s left) kms_frontbuffer_tracking (fbc-suspend)
[418.456838] Starting subtest: fbc-suspend
[456.235866] Subtest fbc-suspend: SUCCESS (7.496s)
[457.416204] [038/133] (562s left) gem_pxp (display-protected-crc)
[457.542192] Starting subtest: display-protected-crc
[459.171843] Subtest display-protected-crc: SUCCESS (1.631s)
[459.281520] [039/133] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[459.382240] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[459.387291] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[459.487861] [040/133] (560s left) gem_userptr_blits (dmabuf-unsync)
[459.552421] Subtest dmabuf-unsync: SKIP (0.000s)
[459.672250] [041/133] (560s left) gem_eio (context-create)
[459.905507] Starting subtest: context-create
[460.231765] Subtest context-create: SUCCESS (0.326s)
[460.353666] [042/133] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[460.456371] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[467.209043] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.749s)
[467.350114] [043/133] (552s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[467.451884] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[467.457757] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[467.564100] [044/133] (552s left) kms_selftest (drm_dp_mst_helper)
[467.609785] Starting subtest: drm_dp_mst_helper
[467.704734] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[467.803024] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.095s)
[467.813429] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[467.914436] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.112s)
[467.924379] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[468.019674] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.103s)
[468.021783] Subtest drm_dp_mst_helper: SUCCESS (0.409s)
[468.179578] [045/133] (552s left) gem_spin_batch (resubmit-new)
[468.242717] Starting subtest: resubmit-new
[468.245033] Starting dynamic subtest: rcs0
[468.253022] Dynamic subtest rcs0: SUCCESS (0.010s)
[468.263299] Starting dynamic subtest: bcs0
[468.265155] Dynamic subtest bcs0: SUCCESS (0.004s)
[468.274307] Starting dynamic subtest: vcs0
[468.276038] Dynamic subtest vcs0: SUCCESS (0.004s)
[468.285324] Starting dynamic subtest: vcs1
[468.287209] Dynamic subtest vcs1: SUCCESS (0.004s)
[468.296040] Starting dynamic subtest: vecs0
[468.297651] Dynamic subtest vecs0: SUCCESS (0.005s)
[468.306467] Starting dynamic subtest: ccs0
[468.308082] Dynamic subtest ccs0: SUCCESS (0.007s)
[468.309696] Subtest resubmit-new: SUCCESS (0.041s)
[469.765941] [046/133] (550s left) testdisplay
[470.089778] [047/133] (550s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[470.187860] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[470.190352] Starting dynamic subtest: pipe-A-eDP-1
[470.306281] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[470.316847] Starting dynamic subtest: pipe-B-eDP-1
[471.509617] Dynamic subtest pipe-B-eDP-1: SKIP (1.202s)
[471.514589] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.326s)
[472.712568] [048/133] (547s left) i915_selftest (live)
[474.487217] Starting subtest: live
[474.489730] Starting dynamic subtest: sanitycheck
[478.144835] Dynamic subtest sanitycheck: SUCCESS (3.655s)
[478.154572] Starting dynamic subtest: uncore
[481.702263] Dynamic subtest uncore: SUCCESS (3.554s)
[481.712798] Starting dynamic subtest: workarounds
[500.932887] Dynamic subtest workarounds: FAIL (19.059s)
[500.939935] Starting dynamic subtest: gt_engines
[504.657851] Dynamic subtest gt_engines: SUCCESS (3.896s)
[504.667691] Starting dynamic subtest: gt_timelines
[521.107377] Dynamic subtest gt_timelines: SUCCESS (16.445s)
[521.117876] Starting dynamic subtest: gt_contexts
[526.270034] Dynamic subtest gt_contexts: SUCCESS (5.160s)
[526.280596] Starting dynamic subtest: gt_lrc
[531.431958] Dynamic subtest gt_lrc: SUCCESS (5.158s)
[531.447237] Starting dynamic subtest: gt_mocs
[535.313680] Dynamic subtest gt_mocs: SUCCESS (3.879s)
[535.322683] Starting dynamic subtest: gt_pm
[542.912032] Dynamic subtest gt_pm: SUCCESS (7.594s)
[542.921845] Starting dynamic subtest: gt_heartbeat
[546.419331] Dynamic subtest gt_heartbeat: SUCCESS (3.504s)
[546.429480] Starting dynamic subtest: gt_tlb
[556.617544] Dynamic subtest gt_tlb: SUCCESS (10.198s)
[556.627908] Starting dynamic subtest: requests
[569.025885] Dynamic subtest requests: SUCCESS (12.408s)
[569.035957] Starting dynamic subtest: migrate
[575.606061] Dynamic subtest migrate: SUCCESS (6.579s)
[575.616496] Starting dynamic subtest: active
[579.157326] Dynamic subtest active: SUCCESS (3.549s)
[579.167598] Starting dynamic subtest: objects
[583.443356] Dynamic subtest objects: SUCCESS (4.284s)
[583.453141] Starting dynamic subtest: mman
[587.668959] Dynamic subtest mman: SUCCESS (4.222s)
[587.685391] Starting dynamic subtest: dmabuf
[591.318400] Dynamic subtest dmabuf: SUCCESS (3.647s)
[591.328710] Starting dynamic subtest: vma
[594.907348] Dynamic subtest vma: SUCCESS (3.587s)
[594.917521] Starting dynamic subtest: coherency
[599.254772] Dynamic subtest coherency: SUCCESS (4.346s)
[599.265030] Starting dynamic subtest: gtt
[610.024346] Dynamic subtest gtt: SUCCESS (10.767s)
[610.033947] Starting dynamic subtest: gem
[618.392359] Dynamic subtest gem: SUCCESS (8.365s)
[618.402419] Starting dynamic subtest: evict
[623.315414] Dynamic subtest evict: SUCCESS (4.920s)
[623.324830] Starting dynamic subtest: hugepages
[632.891291] Dynamic subtest hugepages: SUCCESS (9.571s)
[632.900649] Starting dynamic subtest: gem_contexts
[660.168055] Dynamic subtest gem_contexts: SUCCESS (27.268s)
[660.178332] Starting dynamic subtest: client
[663.795910] Dynamic subtest client: SUCCESS (3.603s)
[663.804217] Starting dynamic subtest: gem_migrate
[669.001542] Dynamic subtest gem_migrate: SUCCESS (5.227s)
[669.010515] Starting dynamic subtest: reset
[674.152272] Dynamic subtest reset: SUCCESS (5.148s)
[674.162247] Starting dynamic subtest: memory_region
[677.740699] Dynamic subtest memory_region: SUCCESS (3.586s)
[677.750509] Starting dynamic subtest: hangcheck
[691.504599] Dynamic subtest hangcheck: SUCCESS (13.765s)
[691.514243] Starting dynamic subtest: execlists
[695.046779] Dynamic subtest execlists: SUCCESS (3.540s)
[695.057328] Starting dynamic subtest: ring_submission
[698.557003] Dynamic subtest ring_submission: SUCCESS (3.509s)
[698.566608] Starting dynamic subtest: perf
[702.237771] Dynamic subtest perf: SUCCESS (3.680s)
[702.247471] Starting dynamic subtest: slpc
[715.170173] Dynamic subtest slpc: SUCCESS (12.932s)
[715.180247] Starting dynamic subtest: guc
[719.910341] Dynamic subtest guc: SUCCESS (4.739s)
[719.919953] Starting dynamic subtest: guc_multi_lrc
[723.452698] Dynamic subtest guc_multi_lrc: SUCCESS (3.541s)
[723.463684] Starting dynamic subtest: guc_hang
[727.751290] Dynamic subtest guc_hang: SUCCESS (4.297s)
[727.761684] Starting dynamic subtest: late_gt_pm
[731.508636] Dynamic subtest late_gt_pm: SUCCESS (3.755s)
[731.511422] Subtest live: FAIL (257.002s)
[731.543765] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[731.544721] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[731.548210] [049/133] (288s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[733.908162] Subtest writes-after-reads-uncached: SKIP (0.000s)
[733.995761] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[733.997024] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[734.001231] [050/133] (286s left) kms_getfb (getfb-handle-not-fb)
[734.103557] Starting subtest: getfb-handle-not-fb
[734.106010] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[734.207382] [051/133] (286s left) kms_psr (fbc-psr-sprite-plane-onoff)
[734.313604] Starting subtest: fbc-psr-sprite-plane-onoff
[734.316449] Starting dynamic subtest: eDP-1
[734.321912] Dynamic subtest eDP-1: SKIP (0.000s)
[734.327305] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[734.443961] [052/133] (286s left) i915_hangman (gt-error-state-capture)
[734.518752] Starting subtest: gt-error-state-capture
[734.521579] Starting dynamic subtest: rcs0
[744.699722] Dynamic subtest rcs0: SUCCESS (10.182s)
[744.714024] Starting dynamic subtest: bcs0
[756.668437] Dynamic subtest bcs0: SUCCESS (11.966s)
[756.680337] Starting dynamic subtest: vcs0
[768.634301] Dynamic subtest vcs0: SUCCESS (11.963s)
[768.646937] Starting dynamic subtest: vcs1
[779.641586] Dynamic subtest vcs1: SUCCESS (11.003s)
[779.653881] Starting dynamic subtest: vecs0
[790.649437] Dynamic subtest vecs0: SUCCESS (11.004s)
[790.661991] Starting dynamic subtest: ccs0
[802.681063] Dynamic subtest ccs0: SUCCESS (12.027s)
[802.684040] Subtest gt-error-state-capture: SUCCESS (68.159s)
[802.799879] [053/133] (217s left) perf (invalid-open-flags)
[802.918907] Starting subtest: invalid-open-flags
[802.921281] Subtest invalid-open-flags: SUCCESS (0.000s)
[802.967469] [054/133] (217s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[803.079902] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[803.084858] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[803.182639] [055/133] (217s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[803.265452] Starting subtest: async-flip-with-page-flip-events-linear
[803.650292] Starting dynamic subtest: pipe-A-eDP-1
[806.457044] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.805s)
[806.832563] Starting dynamic subtest: pipe-B-eDP-1
[809.581012] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.754s)
[809.953597] Starting dynamic subtest: pipe-C-eDP-1
[812.716004] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[813.088850] Starting dynamic subtest: pipe-D-eDP-1
[815.842340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[815.845274] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.577s)
[817.032458] [056/133] (203s left) sw_sync (alloc_fence)
[817.072921] Starting subtest: alloc_fence
[817.075857] Subtest alloc_fence: SUCCESS (0.000s)
[817.151505] [057/133] (203s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[817.252798] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[817.255723] Starting dynamic subtest: pipe-A-default-mode
[818.389498] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[818.395025] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.135s)
[818.535419] [058/133] (202s left) gem_ctx_persistence (heartbeat-close)
[818.588174] Starting subtest: heartbeat-close
[818.593769] Subtest heartbeat-close: SKIP (0.000s)
[818.705407] [059/133] (202s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[818.808939] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[818.814488] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[818.912505] [060/133] (202s left) kms_flip (2x-flip-vs-modeset)
[819.003008] Starting subtest: 2x-flip-vs-modeset
[819.014274] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[819.110547] [061/133] (202s left) sw_sync (alloc_timeline)
[819.157085] Starting subtest: alloc_timeline
[819.159826] Subtest alloc_timeline: SUCCESS (0.000s)
[819.217583] [062/133] (201s left) gem_exec_fence (syncobj-timeline-chain-engines)
[819.758139] Starting subtest: syncobj-timeline-chain-engines
[819.884826] Subtest syncobj-timeline-chain-engines: SUCCESS (0.130s)
[820.811936] [063/133] (200s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[820.920811] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[820.925961] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[821.004290] [064/133] (200s left) perf_pmu (all-busy-check-all)
[821.053597] Starting subtest: all-busy-check-all
[822.748959] Subtest all-busy-check-all: SUCCESS (1.695s)
[822.869191] [065/133] (198s left) kms_chamelium_frames (hdmi-crc-single)
[823.261868] Subtest hdmi-crc-single: SKIP (0.000s)
[824.084562] [066/133] (197s left) kms_draw_crc (draw-method-mmap-wc)
[824.178901] Starting subtest: draw-method-mmap-wc
[824.181494] Starting dynamic subtest: xrgb8888-untiled
[824.487557] Dynamic subtest xrgb8888-untiled: SUCCESS (0.312s)
[824.498295] Starting dynamic subtest: rgb565-untiled
[824.709739] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[824.719954] Starting dynamic subtest: xrgb2101010-untiled
[824.920863] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[824.930954] Starting dynamic subtest: xbgr16161616f-untiled
[825.142510] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[825.152074] Starting dynamic subtest: xrgb8888-xtiled
[825.265361] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[825.274844] Starting dynamic subtest: rgb565-xtiled
[825.398588] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[825.408234] Starting dynamic subtest: xrgb2101010-xtiled
[825.520751] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[825.530491] Starting dynamic subtest: xbgr16161616f-xtiled
[825.654405] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[825.664035] Starting dynamic subtest: xrgb8888-4tiled
[825.798696] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[825.808229] Starting dynamic subtest: rgb565-4tiled
[825.943173] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[825.955314] Starting dynamic subtest: xrgb2101010-4tiled
[826.087777] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[826.097840] Starting dynamic subtest: xbgr16161616f-4tiled
[826.265294] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[826.267456] Subtest draw-method-mmap-wc: SUCCESS (2.090s)
[826.350439] [067/133] (195s left) kms_content_protection (atomic)
[826.494312] Starting subtest: atomic
[826.498740] Subtest atomic: SKIP (0.000s)
[826.648433] [068/133] (194s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[826.734700] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[826.736591] Starting dynamic subtest: pipe-A-eDP-1
[826.755998] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[826.766498] Starting dynamic subtest: pipe-B-eDP-1
[826.786704] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[826.795904] Starting dynamic subtest: pipe-C-eDP-1
[826.816716] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[826.825883] Starting dynamic subtest: pipe-D-eDP-1
[826.847786] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[826.851753] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[829.049459] [069/133] (192s left) kms_psr (pr-primary-render)
[829.143825] Starting subtest: pr-primary-render
[829.148787] Subtest pr-primary-render: SKIP (0.000s)
[829.222977] [070/133] (192s left) gem_exec_flush (basic-uc-ro-default)
[829.281745] Starting subtest: basic-uc-ro-default
[834.743908] Subtest basic-uc-ro-default: SUCCESS (5.462s)
[834.938326] [071/133] (186s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[835.029848] Starting subtest: fb-8bpc-vs-panel-8bpc
[835.032925] Starting dynamic subtest: pipe-A-eDP-1
[836.415539] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.386s)
[836.418341] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.388s)
[837.237424] [072/133] (184s left) gem_madvise (dontneed-after-mmap)
[837.275304] Starting subtest: dontneed-after-mmap
[837.293196] Subtest dontneed-after-mmap: SUCCESS (0.018s)
[837.389033] [073/133] (184s left) kms_plane_alpha_blend (constant-alpha-mid)
[837.479534] Starting subtest: constant-alpha-mid
[837.768647] Starting dynamic subtest: pipe-A-eDP-1
[838.623137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s)
[838.634047] Starting dynamic subtest: pipe-D-eDP-1
[840.120674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.497s)
[840.123333] Subtest constant-alpha-mid: SUCCESS (2.643s)
[840.991865] [074/133] (180s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[841.048695] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[841.117216] [075/133] (180s left) kms_flip (2x-flip-vs-wf_vblank)
[841.206035] Starting subtest: 2x-flip-vs-wf_vblank
[841.220963] Subtest 2x-flip-vs-wf_vblank: SKIP (0.014s)
[841.301353] [076/133] (180s left) kms_cursor_crc (cursor-sliding-128x42)
[841.528745] Starting subtest: cursor-sliding-128x42
[841.575521] Subtest cursor-sliding-128x42: SKIP (0.045s)
[841.786526] [077/133] (180s left) kms_psr (psr2-suspend)
[841.875669] Starting subtest: psr2-suspend
[841.878196] Starting dynamic subtest: eDP-1
[860.133656] Dynamic subtest eDP-1: SUCCESS (2.969s)
[860.136143] Subtest psr2-suspend: SUCCESS (2.970s)
[860.931760] [078/133] (160s left) gem_mmap_offset (open-flood)
[860.981888] Starting subtest: open-flood
[882.451033] Subtest open-flood: SUCCESS (21.490s)
[882.576129] [079/133] (139s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[882.678081] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[882.682618] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[882.789796] [080/133] (139s left) gem_exec_nop (basic-sequential)
[882.855921] Starting subtest: basic-sequential
[897.477573] Subtest basic-sequential: SUCCESS (14.634s)
[897.706122] [081/133] (124s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[897.800987] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[897.806083] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[897.880237] [082/133] (124s left) gem_mmap_gtt (basic-small-bo-tiledy)
[897.939129] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[898.007698] [083/133] (124s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[898.105797] Starting subtest: y-tiled-64bpp-rotate-90
[898.111057] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[898.201607] [084/133] (123s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[898.299034] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[907.001327] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.705s)
[907.116829] [085/133] (115s left) gem_exec_alignment (single)
[907.175363] Starting subtest: single
[907.178287] Subtest single: SUCCESS (0.004s)
[907.284687] [086/133] (114s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[907.383091] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[907.388176] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[907.486385] [087/133] (114s left) syncobj_timeline (etime-single-wait-submitted)
[907.546168] Starting subtest: etime-single-wait-submitted
[907.654345] Subtest etime-single-wait-submitted: SUCCESS (0.109s)
[907.733240] [088/133] (114s left) i915_drm_fdinfo (virtual-busy-all)
[907.772181] Starting subtest: virtual-busy-all
[907.777283] Subtest virtual-busy-all: SKIP (0.000s)
[907.840747] [089/133] (114s left) gem_ctx_exec (basic)
[907.892180] Starting subtest: basic
[907.898684] Subtest basic: SUCCESS (0.008s)
[908.015901] [090/133] (114s left) gem_busy (parallel)
[908.197948] Starting subtest: parallel
[908.200997] Starting dynamic subtest: rcs0
[910.034459] Dynamic subtest rcs0: SUCCESS (1.835s)
[910.048346] Starting dynamic subtest: bcs0
[912.019159] Dynamic subtest bcs0: SUCCESS (1.981s)
[912.032133] Starting dynamic subtest: vcs0
[914.004764] Dynamic subtest vcs0: SUCCESS (1.983s)
[914.018185] Starting dynamic subtest: vcs1
[915.986876] Dynamic subtest vcs1: SUCCESS (1.980s)
[916.000156] Starting dynamic subtest: vecs0
[918.034366] Dynamic subtest vecs0: SUCCESS (2.045s)
[918.047986] Starting dynamic subtest: ccs0
[920.019249] Dynamic subtest ccs0: SUCCESS (1.982s)
[920.022568] Subtest parallel: SUCCESS (11.821s)
[920.269163] [091/133] (102s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[920.327213] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[920.330120] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[920.430177] [092/133] (102s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[920.526948] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[920.531621] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[920.600510] [093/133] (101s left) kms_vblank (ts-continuation-dpms-rpm)
[920.690340] Starting subtest: ts-continuation-dpms-rpm
[920.693132] Starting dynamic subtest: pipe-A-eDP-1
[923.229912] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.541s)
[923.244901] Starting dynamic subtest: pipe-D-eDP-1
[925.472196] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.236s)
[925.474722] Subtest ts-continuation-dpms-rpm: SUCCESS (4.780s)
[926.282883] [094/133] ( 96s left) sw_sync (timeline_closed_signaled)
[926.322260] Starting subtest: timeline_closed_signaled
[926.324957] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[926.393640] [095/133] ( 96s left) gem_lmem_swapping (verify)
[926.442148] Subtest verify: SKIP (0.000s)
[926.487272] [096/133] ( 96s left) syncobj_wait (invalid-signal-zero-handles)
[926.544258] Starting subtest: invalid-signal-zero-handles
[926.547204] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[926.651628] [097/133] ( 96s left) kms_pm_rpm (i2c)
[928.188243] Starting subtest: i2c
[933.861096] Subtest i2c: SUCCESS (5.674s)
[933.975397] [098/133] ( 88s left) vgem_basic (setversion)
[934.027215] Starting subtest: setversion
[934.032068] Subtest setversion: SUCCESS (0.000s)
[934.099199] [099/133] ( 88s left) gem_exec_reloc (basic-write-gtt)
[934.154356] Subtest basic-write-gtt: SKIP (0.000s)
[934.224704] [100/133] ( 88s left) kms_scaling_modes (scaling-mode-center)
[934.321875] Starting subtest: scaling-mode-center
[934.323866] Starting dynamic subtest: pipe-A-eDP-1
[934.417261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[934.428600] Starting dynamic subtest: pipe-B-eDP-1
[935.566554] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[935.577100] Starting dynamic subtest: pipe-C-eDP-1
[936.685536] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[936.699377] Starting dynamic subtest: pipe-D-eDP-1
[937.821164] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[937.824341] Subtest scaling-mode-center: SUCCESS (3.502s)
[938.978788] [101/133] ( 83s left) perf_pmu (frequency)
[939.020110] Starting subtest: frequency
[939.025691] Starting dynamic subtest: gt0
[941.138622] Dynamic subtest gt0: SUCCESS (2.109s)
[941.150947] Starting dynamic subtest: idle-gt0
[941.644164] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[941.656872] Starting dynamic subtest: gt1
[945.980889] Dynamic subtest gt1: SUCCESS (4.331s)
[945.993266] Starting dynamic subtest: idle-gt1
[946.507514] Dynamic subtest idle-gt1: SUCCESS (0.526s)
[946.510586] Subtest frequency: SUCCESS (7.490s)
[946.620136] [102/133] ( 76s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[946.735012] Starting subtest: 4-tiled-32bpp-rotate-180
[948.124540] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.389s)
[948.285432] [103/133] ( 74s left) kms_hdr (bpc-switch-dpms)
[948.377189] Starting subtest: bpc-switch-dpms
[949.449256] Starting dynamic subtest: pipe-A-eDP-1
[953.858346] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.411s)
[953.861191] Subtest bpc-switch-dpms: SUCCESS (5.483s)
[953.962720] [104/133] ( 69s left) syncobj_timeline (wait-any-interrupted)
[954.021575] Starting subtest: wait-any-interrupted
[954.125910] Subtest wait-any-interrupted: SUCCESS (0.106s)
[954.208479] [105/133] ( 68s left) gem_exec_parallel (contexts)
[954.263774] Starting subtest: contexts
[954.266530] Starting dynamic subtest: rcs0
[957.824334] Dynamic subtest rcs0: SUCCESS (3.559s)
[957.838221] Starting dynamic subtest: bcs0
[961.790218] Dynamic subtest bcs0: SUCCESS (3.963s)
[961.802922] Starting dynamic subtest: vcs0
[966.521005] Dynamic subtest vcs0: SUCCESS (4.727s)
[966.534388] Starting dynamic subtest: vcs1
[972.334317] Dynamic subtest vcs1: SUCCESS (5.812s)
[972.345559] Starting dynamic subtest: vecs0
[978.350946] Dynamic subtest vecs0: SUCCESS (6.013s)
[978.364795] Starting dynamic subtest: ccs0
[983.072644] Dynamic subtest ccs0: SUCCESS (4.719s)
[983.075690] Subtest contexts: SUCCESS (28.806s)
[983.260618] [106/133] ( 39s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[983.371058] Starting subtest: verify-pxp-key-change-after-suspend-resume
[990.535980] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.167s)
[990.651392] [107/133] ( 32s left) gem_create (create-ext-placement-each)
[990.823797] Starting subtest: create-ext-placement-each
[990.826690] Subtest create-ext-placement-each: SUCCESS (0.000s)
[990.933924] [108/133] ( 32s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[991.023165] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[991.025917] Starting dynamic subtest: pipe-A-eDP-1
[991.048696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[991.060568] Starting dynamic subtest: pipe-B-eDP-1
[991.083803] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[991.094823] Starting dynamic subtest: pipe-C-eDP-1
[991.117390] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[991.130271] Starting dynamic subtest: pipe-D-eDP-1
[991.153644] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[991.156191] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[993.276727] [109/133] ( 30s left) gem_close_race (basic-process)
[993.351077] Starting subtest: basic-process
[993.391592] Subtest basic-process: SUCCESS (0.041s)
[993.583800] [110/133] ( 29s left) gem_exec_schedule (u-independent)
[993.662670] Starting subtest: u-independent
[993.664973] Starting dynamic subtest: rcs0
[995.026943] Dynamic subtest rcs0: SUCCESS (1.375s)
[995.040568] Starting dynamic subtest: vcs0
[997.022001] Dynamic subtest vcs0: SUCCESS (1.992s)
[997.038898] Starting dynamic subtest: vcs1
[999.005103] Dynamic subtest vcs1: SUCCESS (1.982s)
[999.018007] Starting dynamic subtest: vecs0
[1000.984243] Dynamic subtest vecs0: SUCCESS (1.978s)
[1000.998549] Starting dynamic subtest: ccs0
[1002.964161] Dynamic subtest ccs0: SUCCESS (1.976s)
[1002.967369] Subtest u-independent: SUCCESS (9.314s)
[1003.270188] [111/133] ( 20s left) gen9_exec_parse (batch-without-end)
[1003.344151] Subtest batch-without-end: SKIP (0.000s)
[1003.395019] [112/133] ( 20s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[1005.127927] Starting subtest: dpms-mode-unset-lpsp
[1009.199402] Subtest dpms-mode-unset-lpsp: SUCCESS (4.072s)
[1009.569973] [113/133] ( 13s left) kms_chamelium_hpd (vga-hpd)
[1009.969169] Subtest vga-hpd: SKIP (0.000s)
[1010.772836] [114/133] ( 12s left) gem_lmem_swapping (heavy-multi)
[1010.814990] Subtest heavy-multi: SKIP (0.000s)
[1010.863712] [115/133] ( 12s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[1010.973609] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[1010.978796] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[1011.044242] [116/133] ( 12s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[1011.143055] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[1011.148228] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[1011.237891] [117/133] ( 12s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[1011.326948] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1015.800258] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.476s)
[1017.014095] [118/133] (  6s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1017.105009] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1024.428890] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.327s)
[1024.524399] Overall timeout time exceeded, stopping.
[1024.543089] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: drm_buddy
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: testdisplay
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: i915_selftest
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: sw_sync
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: kms_dither
results: parsing output: 71/ for test: gem_madvise
results: parsing output: 72/ for test: kms_plane_alpha_blend
results: parsing output: 73/ for test: kms_pipe_b_c_ivb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_nop
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_alignment
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: gem_ctx_exec
results: parsing output: 89/ for test: gem_busy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_parallel
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_close_race
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 119/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 120/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 121/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 122/ for test: perf_pmu
results: no output, setting notrun
results: parsing output: 123/ for test: kms_force_connector_basic
results: no output, setting notrun
results: parsing output: 124/ for test: gem_ctx_param
results: no output, setting notrun
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 126/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 127/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 128/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 129/ for test: gem_exec_whisper
results: no output, setting notrun
results: parsing output: 130/ for test: kms_plane_lowres
results: no output, setting notrun
results: parsing output: 131/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 132/ for test: prime_vgem
results: no output, setting notrun
Done.