[58.731413] Initializing watchdogs
[58.731461]   /dev/watchdog0
[58.745670] [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.750016] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.752290] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.755904] [001/131] (960s left) vgem_slow (nohang)
[58.857159] Starting subtest: nohang
[69.234263] Subtest nohang: SUCCESS (10.257s)
[69.315632] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[69.318665] [002/131] (949s left) gem_userptr_blits (unsync-overlap)
[69.398051] Subtest unsync-overlap: SKIP (0.000s)
[69.565095] [003/131] (949s left) gem_exec_schedule (u-fairslice-all)
[69.641850] Starting subtest: u-fairslice-all
[71.716443] Subtest u-fairslice-all: SUCCESS (2.071s)
[72.031753] [004/131] (947s left) gem_lmem_swapping (parallel-random)
[72.067699] Subtest parallel-random: SKIP (0.000s)
[72.104988] [005/131] (947s left) kms_sequence (queue-idle)
[72.205998] Starting subtest: queue-idle
[72.208430] Starting dynamic subtest: pipe-A-eDP-1
[74.039669] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.828s)
[74.049145] Starting dynamic subtest: pipe-B-eDP-1
[76.469853] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.423s)
[76.478515] Starting dynamic subtest: pipe-C-eDP-1
[78.899448] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.425s)
[78.908265] Starting dynamic subtest: pipe-D-eDP-1
[81.345491] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.442s)
[81.347769] Subtest queue-idle: SUCCESS (9.121s)
[82.171138] [006/131] (937s left) gem_exec_schedule (lateslice)
[82.261319] Starting subtest: lateslice
[82.263637] Starting dynamic subtest: rcs0
[82.269648] Dynamic subtest rcs0: SUCCESS (0.019s)
[82.276496] Starting dynamic subtest: bcs0
[82.288499] Dynamic subtest bcs0: SUCCESS (0.019s)
[82.295259] Starting dynamic subtest: vcs0
[82.305688] Dynamic subtest vcs0: SUCCESS (0.017s)
[82.312504] Starting dynamic subtest: vcs1
[82.323597] Dynamic subtest vcs1: SUCCESS (0.018s)
[82.330352] Starting dynamic subtest: vecs0
[82.341990] Dynamic subtest vecs0: SUCCESS (0.018s)
[82.348722] Starting dynamic subtest: ccs0
[82.363174] Dynamic subtest ccs0: SUCCESS (0.021s)
[82.365494] Subtest lateslice: SUCCESS (0.113s)
[84.059398] [007/131] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[84.171568] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[84.175951] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[84.324599] [008/131] (935s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[84.851103] Starting subtest: syncobj-timeline-invalid-wait
[84.853816] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[85.989429] [009/131] (933s left) gem_exec_params (no-vebox)
[86.052607] Starting subtest: no-vebox
[86.054921] Subtest no-vebox: SUCCESS (0.002s)
[87.994540] [010/131] (931s left) gem_exec_balancer (parallel-contexts)
[88.255300] Starting subtest: parallel-contexts
[91.957203] Subtest parallel-contexts: SUCCESS (3.699s)
[92.106204] [011/131] (927s left) kms_pm_rpm (legacy-planes-dpms)
[94.082377] Starting subtest: legacy-planes-dpms
[94.084801] Starting dynamic subtest: plane-63
[102.359698] Dynamic subtest plane-63: SUCCESS (8.276s)
[102.370574] Starting dynamic subtest: plane-93
[110.688972] Dynamic subtest plane-93: SUCCESS (8.326s)
[110.700052] Starting dynamic subtest: plane-123
[119.000235] Dynamic subtest plane-123: SUCCESS (8.310s)
[119.010654] Starting dynamic subtest: plane-133
[127.624429] Dynamic subtest plane-133: SUCCESS (8.622s)
[127.627378] Subtest legacy-planes-dpms: SUCCESS (33.538s)
[128.028527] [012/131] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[128.126549] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[128.130847] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[128.257192] [013/131] (891s left) kms_cursor_edge_walk (64x64-left-edge)
[128.346848] Starting subtest: 64x64-left-edge
[128.349193] Starting dynamic subtest: pipe-A-eDP-1
[131.778577] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[131.787817] Starting dynamic subtest: pipe-D-eDP-1
[134.903675] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[134.905871] Subtest 64x64-left-edge: SUCCESS (6.557s)
[135.722604] [014/131] (884s left) gem_mmap_offset (open-flood)
[135.782568] Starting subtest: open-flood
[157.269675] Subtest open-flood: SUCCESS (21.488s)
[157.419591] [015/131] (862s left) gem_spin_batch (spin-each)
[157.486035] Starting subtest: spin-each
[160.852264] Subtest spin-each: SUCCESS (3.363s)
[161.125369] [016/131] (858s left) gem_ctx_persistence (saturated-hostile)
[161.185231] Starting subtest: saturated-hostile
[161.187792] Starting dynamic subtest: rcs0
[162.037071] Dynamic subtest rcs0: SUCCESS (0.851s)
[162.047969] Starting dynamic subtest: bcs0
[162.864849] Dynamic subtest bcs0: SUCCESS (0.827s)
[162.875766] Starting dynamic subtest: vcs0
[163.664392] Dynamic subtest vcs0: SUCCESS (0.797s)
[163.675526] Starting dynamic subtest: vcs1
[164.430756] Dynamic subtest vcs1: SUCCESS (0.766s)
[164.441287] Starting dynamic subtest: vecs0
[165.232813] Dynamic subtest vecs0: SUCCESS (0.801s)
[165.244065] Starting dynamic subtest: ccs0
[166.077437] Dynamic subtest ccs0: SUCCESS (0.843s)
[166.080049] Subtest saturated-hostile: SUCCESS (4.893s)
[166.180640] [017/131] (853s left) gem_ctx_shared (q-independent)
[166.247966] Starting subtest: Q-independent
[166.250394] Starting dynamic subtest: rcs0
[166.362905] Dynamic subtest rcs0: SUCCESS (0.113s)
[166.372906] Starting dynamic subtest: vcs0
[166.424076] Dynamic subtest vcs0: SUCCESS (0.062s)
[166.434489] Starting dynamic subtest: vcs1
[166.496986] Dynamic subtest vcs1: SUCCESS (0.072s)
[166.507071] Starting dynamic subtest: vecs0
[166.569933] Dynamic subtest vecs0: SUCCESS (0.072s)
[166.580367] Starting dynamic subtest: ccs0
[166.659026] Dynamic subtest ccs0: SUCCESS (0.089s)
[166.661880] Subtest Q-independent: SUCCESS (0.410s)
[168.047476] [018/131] (851s left) kms_psr (fbc-psr-primary-render)
[168.149848] Starting subtest: fbc-psr-primary-render
[168.152180] Starting dynamic subtest: eDP-1
[168.156526] Dynamic subtest eDP-1: SKIP (0.000s)
[168.160955] Subtest fbc-psr-primary-render: SKIP (0.001s)
[168.245044] [019/131] (851s left) perf_pmu (rc6-all-gts)
[168.285223] Starting subtest: rc6-all-gts
[174.669641] Subtest rc6-all-gts: SUCCESS (6.384s)
[175.561486] [020/131] (844s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[175.670068] Starting subtest: crc-primary-suspend-y-tiled-ccs
[175.672395] Starting dynamic subtest: pipe-A-eDP-1
[175.681494] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.689952] Starting dynamic subtest: pipe-B-eDP-1
[175.697524] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.705060] Starting dynamic subtest: pipe-C-eDP-1
[175.712212] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.719203] Starting dynamic subtest: pipe-D-eDP-1
[175.726256] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.729823] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[177.890347] [021/131] (842s left) gem_pxp (create-regular-context-1)
[178.030083] Starting subtest: create-regular-context-1
[178.032844] Subtest create-regular-context-1: SUCCESS (0.002s)
[178.172717] [022/131] (841s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[178.235321] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[178.239932] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[178.447915] [023/131] (841s left) syncobj_timeline (host-signal-points)
[178.507937] Starting subtest: host-signal-points
[178.512482] Subtest host-signal-points: SUCCESS (0.004s)
[178.649075] [024/131] (841s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[178.742649] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[178.744773] Starting dynamic subtest: pipe-A-eDP-1
[178.769817] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[178.780100] Starting dynamic subtest: pipe-B-eDP-1
[178.803246] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[178.812990] Starting dynamic subtest: pipe-C-eDP-1
[178.837077] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[178.845983] Starting dynamic subtest: pipe-D-eDP-1
[178.870050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[178.874407] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[181.051409] [025/131] (839s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[181.158395] Starting subtest: stress-xrgb8888-xtiled
[187.096098] Subtest stress-xrgb8888-xtiled: SUCCESS (5.938s)
[187.155304] [026/131] (833s left) kms_async_flips (test-time-stamp)
[187.255967] Starting subtest: test-time-stamp
[187.627501] Starting dynamic subtest: pipe-A-eDP-1
[188.425514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[188.800357] Starting dynamic subtest: pipe-B-eDP-1
[189.558778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[189.934066] Starting dynamic subtest: pipe-C-eDP-1
[190.691825] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[191.052495] Starting dynamic subtest: pipe-D-eDP-1
[191.816280] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[191.818725] Subtest test-time-stamp: SUCCESS (4.561s)
[192.998028] [027/131] (827s left) prime_self_import (basic-with_two_bos)
[193.036392] Starting subtest: basic-with_two_bos
[193.066802] Subtest basic-with_two_bos: SUCCESS (0.030s)
[193.216873] [028/131] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[193.315466] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[200.820894] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.506s)
[200.958222] [029/131] (819s left) gem_mmap_gtt (close-race)
[201.028952] Subtest close-race: SKIP (0.000s)
[201.087742] [030/131] (819s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[201.188457] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[205.664437] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.479s)
[206.830800] [031/131] (813s left) gen9_exec_parse (valid-registers)
[206.902570] Subtest valid-registers: SKIP (0.000s)
[206.993111] [032/131] (813s left) kms_color (legacy-gamma-reset)
[207.086620] Starting subtest: legacy-gamma-reset
[207.088746] Starting dynamic subtest: pipe-A-eDP-1
[207.469028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.383s)
[207.477786] Starting dynamic subtest: pipe-B-eDP-1
[207.482660] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[207.490727] Starting dynamic subtest: pipe-C-eDP-1
[207.502123] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[207.510271] Starting dynamic subtest: pipe-D-eDP-1
[207.534317] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.030s)
[207.536651] Subtest legacy-gamma-reset: SUCCESS (0.450s)
[208.345248] [033/131] (812s left) gem_partial_pwrite_pread (reads-snoop)
[208.402122] Subtest reads-snoop: SKIP (0.000s)
[208.496427] [034/131] (812s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[208.594068] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[208.598240] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[208.730279] [035/131] (811s left) gem_exec_reloc (basic-gtt-noreloc)
[208.802295] Subtest basic-gtt-noreloc: SKIP (0.000s)
[208.886847] [036/131] (811s left) syncobj_timeline (invalid-transfer-illegal-handle)
[208.946496] Starting subtest: invalid-transfer-illegal-handle
[208.948392] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[209.073013] [037/131] (811s left) gem_ctx_param (invalid-get-engines)
[209.125795] Starting subtest: invalid-get-engines
[209.128080] Subtest invalid-get-engines: SUCCESS (0.001s)
[209.270402] [038/131] (811s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[209.369848] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[209.373449] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[209.474455] [039/131] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[209.571829] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[209.575185] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[209.686059] [040/131] (811s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[209.786275] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[209.789541] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[209.920034] [041/131] (810s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[210.018980] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[210.021012] Starting dynamic subtest: pipe-A-eDP-1
[210.040359] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[210.049828] Starting dynamic subtest: pipe-B-eDP-1
[210.068550] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[210.077255] Starting dynamic subtest: pipe-C-eDP-1
[210.095614] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.102501] Starting dynamic subtest: pipe-D-eDP-1
[210.120323] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.123929] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[212.297609] [042/131] (808s left) kms_plane_cursor (primary)
[212.395471] Starting subtest: primary
[212.400218] Starting dynamic subtest: pipe-A-eDP-1-size-64
[214.935463] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.543s)
[214.956843] Starting dynamic subtest: pipe-A-eDP-1-size-128
[217.604446] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.649s)
[217.626310] Starting dynamic subtest: pipe-A-eDP-1-size-256
[220.167579] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[220.484820] Starting dynamic subtest: pipe-B-eDP-1-size-64
[223.742801] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.268s)
[223.766258] Starting dynamic subtest: pipe-B-eDP-1-size-128
[226.322069] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[226.345956] Starting dynamic subtest: pipe-B-eDP-1-size-256
[228.922876] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.581s)
[229.239467] Starting dynamic subtest: pipe-C-eDP-1-size-64
[232.098179] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.868s)
[232.124206] Starting dynamic subtest: pipe-C-eDP-1-size-128
[234.343349] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.224s)
[234.369388] Starting dynamic subtest: pipe-C-eDP-1-size-256
[236.509872] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.146s)
[236.827773] Starting dynamic subtest: pipe-D-eDP-1-size-64
[239.647538] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.831s)
[239.673473] Starting dynamic subtest: pipe-D-eDP-1-size-128
[241.858385] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[241.884544] Starting dynamic subtest: pipe-D-eDP-1-size-256
[244.002056] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.124s)
[244.311040] Subtest primary: SUCCESS (31.917s)
[245.207780] [043/131] (775s left) kms_flip (dpms-off-confusion-interruptible)
[245.310607] Starting subtest: dpms-off-confusion-interruptible
[245.312952] Starting dynamic subtest: A-eDP1
[253.984962] Dynamic subtest A-eDP1: SUCCESS (8.674s)
[253.996755] Starting dynamic subtest: B-eDP1
[262.617745] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[262.627692] Starting dynamic subtest: C-eDP1
[271.231528] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[271.240127] Starting dynamic subtest: D-eDP1
[279.856738] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[279.861079] Subtest dpms-off-confusion-interruptible: SUCCESS (34.551s)
[281.057559] [044/131] (739s left) kms_cursor_edge_walk (256x256-top-bottom)
[281.167840] Starting subtest: 256x256-top-bottom
[281.170123] Starting dynamic subtest: pipe-A-eDP-1
[284.606058] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[284.614426] Starting dynamic subtest: pipe-D-eDP-1
[287.736094] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[287.738426] Subtest 256x256-top-bottom: SUCCESS (6.569s)
[288.558366] [045/131] (732s left) kms_psr (pr-sprite-plane-onoff)
[288.656167] Starting subtest: pr-sprite-plane-onoff
[288.660151] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[288.749000] [046/131] (732s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[288.872077] Starting subtest: short-flip-before-cursor-toggle
[289.795734] Subtest short-flip-before-cursor-toggle: SUCCESS (0.926s)
[290.704288] [047/131] (730s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[290.808579] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[290.810814] Starting dynamic subtest: A-eDP1
[299.711347] Dynamic subtest A-eDP1: SUCCESS (8.901s)
[299.721131] Starting dynamic subtest: B-eDP1
[308.638131] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[308.654438] Starting dynamic subtest: C-eDP1
[317.547275] Dynamic subtest C-eDP1: SUCCESS (8.906s)
[317.559749] Starting dynamic subtest: D-eDP1
[326.399559] Dynamic subtest D-eDP1: SUCCESS (8.849s)
[326.401958] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.592s)
[327.640756] [048/131] (693s left) gem_exec_params (secure-non-master)
[327.718559] Starting subtest: secure-non-master
[327.723156] Subtest secure-non-master: SKIP (0.000s)
[327.850342] [049/131] (693s left) kms_flip (2x-flip-vs-dpms)
[327.952835] Starting subtest: 2x-flip-vs-dpms
[327.961645] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[328.097911] [050/131] (693s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[328.195116] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[328.199050] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[328.333447] [051/131] (692s left) drm_read (fault-buffer)
[328.481294] Starting subtest: fault-buffer
[328.483942] Subtest fault-buffer: SUCCESS (0.000s)
[328.666686] [052/131] (692s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[328.746491] Starting subtest: basic-batch-kernel-default-cmd
[328.749965] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[328.955514] [053/131] (692s left) kms_cursor_crc (cursor-offscreen-128x128)
[329.170052] Starting subtest: cursor-offscreen-128x128
[329.172430] Starting dynamic subtest: pipe-A-eDP-1
[331.115492] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[331.139407] Starting dynamic subtest: pipe-D-eDP-1
[333.706547] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s)
[333.708994] Subtest cursor-offscreen-128x128: SUCCESS (4.539s)
[334.605719] [054/131] (686s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[334.718425] Starting subtest: x-tiled-8bpp-rotate-90
[334.740136] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[334.902172] [055/131] (686s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[334.958591] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[335.064545] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[335.166253] [056/131] (686s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[335.261071] Starting subtest: 4-tiled-32bpp-rotate-90
[335.280838] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[335.439357] [057/131] (686s left) core_setmaster (master-drop-set-shared-fd)
[335.537587] Starting subtest: master-drop-set-shared-fd
[335.555531] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[335.594340] [058/131] (685s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[335.687030] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[335.696069] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[335.801559] [059/131] (685s left) syncobj_wait (single-wait-all-submitted)
[335.867825] Starting subtest: single-wait-all-submitted
[335.969733] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[336.067217] [060/131] (685s left) kms_big_fb (linear-64bpp-rotate-270)
[336.181685] Starting subtest: linear-64bpp-rotate-270
[336.201687] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[336.361752] [061/131] (685s left) gem_exec_params (invalid-fence-in-submit)
[336.407782] Starting subtest: invalid-fence-in-submit
[336.411783] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[336.567342] [062/131] (685s left) syncobj_wait (single-wait-for-submit-submitted)
[336.619713] Starting subtest: single-wait-for-submit-submitted
[336.728881] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[336.830088] [063/131] (684s left) prime_vgem (fence-write-hang)
[336.906330] Subtest fence-write-hang: SKIP (0.000s)
[337.037448] [064/131] (684s left) syncobj_timeline (single-wait-signaled)
[337.085075] Starting subtest: single-wait-signaled
[337.087317] Subtest single-wait-signaled: SUCCESS (0.000s)
[337.197181] [065/131] (684s left) kms_chamelium_edid (vga-edid-read)
[337.585319] Subtest vga-edid-read: SKIP (0.000s)
[338.398218] [066/131] (683s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[338.528280] Starting subtest: 2x-long-flip-vs-cursor-atomic
[338.532637] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[338.695694] [067/131] (683s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[338.791087] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[343.286332] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.498s)
[344.445847] [068/131] (677s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[344.554933] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[349.137928] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.588s)
[350.325975] [069/131] (671s left) prime_vgem (basic-read)
[350.420816] Starting subtest: basic-read
[350.441243] Subtest basic-read: SKIP (0.020s)
[350.581386] [070/131] (671s left) gem_userptr_blits (vma-merge)
[350.659349] Starting subtest: vma-merge
[350.694602] Subtest vma-merge: SUCCESS (0.038s)
[350.870408] [071/131] (671s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[350.978607] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[350.983031] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[351.112271] [072/131] (671s left) kms_vrr (negative-basic)
[351.205078] Starting subtest: negative-basic
[351.211601] Starting dynamic subtest: pipe-A-eDP-1
[356.625834] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.412s)
[356.924656] Subtest negative-basic: SUCCESS (5.719s)
[357.750331] [073/131] (664s left) gem_exec_reloc (basic-cpu-read-active)
[357.814449] Subtest basic-cpu-read-active: SKIP (0.000s)
[357.875745] [074/131] (664s left) kms_chamelium_hpd (hdmi-hpd)
[358.249626] Subtest hdmi-hpd: SKIP (0.000s)
[359.030733] [075/131] (663s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[359.141048] Starting subtest: yf-tiled-16bpp-rotate-0
[359.145729] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[359.279450] [076/131] (663s left) syncobj_timeline (reset-signaled)
[359.342604] Starting subtest: reset-signaled
[359.344760] Subtest reset-signaled: SUCCESS (0.000s)
[359.480203] [077/131] (662s left) kms_psr (fbc-psr2-basic)
[359.577746] Starting subtest: fbc-psr2-basic
[359.579939] Starting dynamic subtest: eDP-1
[359.583888] Dynamic subtest eDP-1: SKIP (0.000s)
[359.587815] Subtest fbc-psr2-basic: SKIP (0.001s)
[359.678133] [078/131] (662s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[359.777314] Starting subtest: primary-yf-tiled-reflect-x-0
[359.848577] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[359.971224] [079/131] (662s left) kms_prop_blob (basic)
[360.029621] Starting subtest: basic
[360.031517] Subtest basic: SUCCESS (0.000s)
[360.150061] [080/131] (662s left) vgem_basic (debugfs)
[360.188532] Starting subtest: debugfs
[360.190409] Subtest debugfs: SUCCESS (0.000s)
[360.271895] [081/131] (662s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[360.368212] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[367.377396] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.010s)
[367.547158] [082/131] (654s left) gem_userptr_blits (unsync-unmap-cycles)
[367.620430] Subtest unsync-unmap-cycles: SKIP (0.000s)
[367.791107] [083/131] (654s left) perf_pmu (busy-double-start)
[367.834989] Starting subtest: busy-double-start
[367.837119] Starting dynamic subtest: rcs0
[371.470306] Dynamic subtest rcs0: FAIL (3.575s)
[371.479653] Starting dynamic subtest: bcs0
[374.979999] Dynamic subtest bcs0: SUCCESS (3.570s)
[374.990716] Starting dynamic subtest: vcs0
[379.459863] Dynamic subtest vcs0: SUCCESS (4.477s)
[379.470313] Starting dynamic subtest: vcs1
[383.450943] Dynamic subtest vcs1: SUCCESS (3.989s)
[383.461774] Starting dynamic subtest: vecs0
[387.433526] Dynamic subtest vecs0: SUCCESS (3.980s)
[387.444523] Starting dynamic subtest: ccs0
[391.069650] Dynamic subtest ccs0: FAIL (3.567s)
[391.072016] Subtest busy-double-start: FAIL (23.169s)
[391.172829] [084/131] (631s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[391.290476] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[391.294512] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[391.417120] [085/131] (631s left) kms_chamelium_color (ctm-negative)
[391.517183] Subtest ctm-negative: SKIP (0.000s)
[391.561445] [086/131] (631s left) kms_async_flips (async-flip-dpms)
[391.664731] Starting subtest: async-flip-dpms
[392.035745] Starting dynamic subtest: pipe-A-eDP-1
[395.891705] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.855s)
[396.261860] Starting dynamic subtest: pipe-B-eDP-1
[399.057270] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.801s)
[399.422477] Starting dynamic subtest: pipe-C-eDP-1
[402.228421] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.811s)
[402.609201] Starting dynamic subtest: pipe-D-eDP-1
[405.395340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.793s)
[405.397674] Subtest async-flip-dpms: SUCCESS (13.733s)
[406.595138] [087/131] (616s left) gem_busy (semaphore)
[406.780880] Subtest semaphore: SKIP (0.000s)
[407.041060] [088/131] (615s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[407.138210] Starting subtest: flip-vs-dpms-off-vs-modeset
[407.140659] Starting dynamic subtest: A-eDP1
[410.810204] Dynamic subtest A-eDP1: SUCCESS (3.670s)
[410.827036] Starting dynamic subtest: B-eDP1
[414.018243] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[414.029344] Starting dynamic subtest: C-eDP1
[417.148323] Dynamic subtest C-eDP1: SUCCESS (3.131s)
[417.158098] Starting dynamic subtest: D-eDP1
[420.236187] Dynamic subtest D-eDP1: SUCCESS (3.086s)
[420.238494] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.103s)
[421.063584] [089/131] (601s left) prime_mmap (test_reprime)
[421.124808] Starting subtest: test_reprime
[421.127237] Starting dynamic subtest: test_reprime-smem
[421.172645] Dynamic subtest test_reprime-smem: SUCCESS (0.050s)
[421.175309] Subtest test_reprime: SUCCESS (0.051s)
[421.289170] [090/131] (601s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[426.341851] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[426.346551] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[427.204792] [091/131] (595s left) gem_exec_whisper (basic-fds)
[427.272057] Starting subtest: basic-fds
[432.957944] Subtest basic-fds: SUCCESS (5.683s)
[433.164273] [092/131] (589s left) gem_ctx_param (set-priority-range)
[433.238494] Starting subtest: set-priority-range
[433.249922] Subtest set-priority-range: SUCCESS (0.014s)
[433.395932] [093/131] (589s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[433.497760] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[433.499897] Starting dynamic subtest: pipe-A-default-mode
[436.195188] Dynamic subtest pipe-A-default-mode: SUCCESS (2.696s)
[436.197523] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.697s)
[437.109917] [094/131] (585s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[437.204957] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[437.207419] Starting dynamic subtest: pipe-A-default-mode
[437.511094] Dynamic subtest pipe-A-default-mode: SKIP (0.304s)
[437.515903] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.306s)
[438.336555] [095/131] (584s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[438.433667] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[438.438315] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[438.578360] [096/131] (584s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[438.677129] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[438.679451] Starting dynamic subtest: pipe-A-eDP-1
[438.822320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[438.831334] Starting dynamic subtest: pipe-B-eDP-1
[438.851340] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[438.860523] Starting dynamic subtest: pipe-C-eDP-1
[438.879655] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[438.887371] Starting dynamic subtest: pipe-D-eDP-1
[438.906512] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[438.908403] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.169s)
[441.104395] [097/131] (582s left) i915_selftest (mock)
[444.564089] Starting subtest: mock
[444.566485] Starting dynamic subtest: sanitycheck
[445.289297] Dynamic subtest sanitycheck: SUCCESS (0.725s)
[445.298647] Starting dynamic subtest: shmem
[446.030239] Dynamic subtest shmem: SUCCESS (0.739s)
[446.039373] Starting dynamic subtest: fence
[454.110192] Dynamic subtest fence: SUCCESS (8.077s)
[454.119618] Starting dynamic subtest: scatterlist
[455.846424] Dynamic subtest scatterlist: SUCCESS (1.734s)
[455.856039] Starting dynamic subtest: syncmap
[459.291065] Dynamic subtest syncmap: SUCCESS (3.442s)
[459.299508] Starting dynamic subtest: uncore
[460.030180] Dynamic subtest uncore: SUCCESS (0.738s)
[460.038874] Starting dynamic subtest: ring
[460.790368] Dynamic subtest ring: SUCCESS (0.758s)
[460.798811] Starting dynamic subtest: engine
[461.534294] Dynamic subtest engine: SUCCESS (0.742s)
[461.543032] Starting dynamic subtest: timelines
[465.409567] Dynamic subtest timelines: SUCCESS (3.869s)
[465.417848] Starting dynamic subtest: requests
[468.863514] Dynamic subtest requests: SUCCESS (3.451s)
[468.872434] Starting dynamic subtest: objects
[469.739587] Dynamic subtest objects: SUCCESS (0.878s)
[469.748365] Starting dynamic subtest: phys
[470.606560] Dynamic subtest phys: SUCCESS (0.865s)
[470.615040] Starting dynamic subtest: dmabuf
[471.438611] Dynamic subtest dmabuf: SUCCESS (0.827s)
[471.447645] Starting dynamic subtest: vma
[476.800072] Dynamic subtest vma: SUCCESS (5.362s)
[476.808950] Starting dynamic subtest: evict
[478.246020] Dynamic subtest evict: SUCCESS (1.443s)
[478.255022] Starting dynamic subtest: gtt
[481.499344] Dynamic subtest gtt: SUCCESS (3.250s)
[481.508077] Starting dynamic subtest: hugepages
[482.475502] Dynamic subtest hugepages: SUCCESS (0.974s)
[482.485020] Starting dynamic subtest: memory_region
[485.130898] Dynamic subtest memory_region: SUCCESS (2.653s)
[485.133455] Subtest mock: SUCCESS (40.567s)
[485.161477] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[485.162208] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[485.165364] [098/131] (538s left) gem_ctx_exec (basic-close-race)
[486.695867] Starting subtest: basic-close-race
[492.333689] Subtest basic-close-race: SUCCESS (5.636s)
[492.443678] [FACT gem_ctx_exec (basic-close-race)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[492.444833] [FACT gem_ctx_exec (basic-close-race)] new: kernel.kmod_is_loaded.i915: true
[492.448404] [099/131] (530s left) prime_busy (after)
[492.513795] Starting subtest: after
[492.516217] Starting dynamic subtest: rcs0
[492.570718] Dynamic subtest rcs0: SUCCESS (0.057s)
[492.579316] Starting dynamic subtest: bcs0
[492.646382] Dynamic subtest bcs0: SUCCESS (0.074s)
[492.655935] Starting dynamic subtest: vcs0
[492.688407] Dynamic subtest vcs0: SUCCESS (0.042s)
[492.696925] Starting dynamic subtest: vcs1
[492.728208] Dynamic subtest vcs1: SUCCESS (0.039s)
[492.736653] Starting dynamic subtest: vecs0
[492.770118] Dynamic subtest vecs0: SUCCESS (0.042s)
[492.778615] Starting dynamic subtest: ccs0
[492.812542] Dynamic subtest ccs0: SUCCESS (0.042s)
[492.921516] Subtest after: SUCCESS (0.409s)
[493.023866] [100/131] (530s left) syncobj_wait (reset-signaled)
[493.083853] Starting subtest: reset-signaled
[493.086128] Subtest reset-signaled: SUCCESS (0.000s)
[493.205094] [101/131] (530s left) kms_dsc (dsc-basic)
[493.313320] Starting subtest: dsc-basic
[493.326477] Subtest dsc-basic: SKIP (0.000s)
[493.406888] [102/131] (529s left) vgem_basic (bad-flag)
[493.451105] Starting subtest: bad-flag
[493.453435] Subtest bad-flag: SUCCESS (0.000s)
[493.530339] [103/131] (529s left) kms_psr (psr2-sprite-mmap-gtt)
[493.627071] Starting subtest: psr2-sprite-mmap-gtt
[493.629344] Starting dynamic subtest: eDP-1
[495.028439] Dynamic subtest eDP-1: SKIP (1.397s)
[495.033447] Subtest psr2-sprite-mmap-gtt: SKIP (1.399s)
[495.211304] [104/131] (528s left) gem_exec_balancer (noheartbeat)
[495.473738] Starting subtest: noheartbeat
[495.478013] Subtest noheartbeat: SKIP (0.000s)
[495.601425] [105/131] (527s left) gem_tiled_wb
[495.723769] [106/131] (527s left) gem_exec_reloc (basic-softpin)
[495.791647] Subtest basic-softpin: SKIP (0.000s)
[495.877870] [107/131] (527s left) gem_pxp (hw-rejects-pxp-buffer)
[496.008853] Starting subtest: hw-rejects-pxp-buffer
[496.013587] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[496.143469] [108/131] (527s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[501.146159] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[501.148331] Starting dynamic subtest: pipe-A-eDP-1
[501.934565] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[501.943027] Starting dynamic subtest: pipe-B-eDP-1
[503.060430] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[503.064784] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.914s)
[504.262011] [109/131] (519s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[504.391252] Starting subtest: 2x-cursor-vs-flip-legacy
[504.395551] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[504.557106] [110/131] (519s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[504.649777] Starting subtest: multiplane-rotation-cropping-bottom
[522.074411] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.426s)
[522.236929] [111/131] (501s left) gem_userptr_blits (sync-overlap)
[522.318513] Starting subtest: sync-overlap
[522.320586] Subtest sync-overlap: SUCCESS (0.000s)
[522.499336] [112/131] (501s left) kms_feature_discovery (psr2)
[522.579498] Starting subtest: psr2
[522.581475] Subtest psr2: SUCCESS (0.000s)
[522.674789] [113/131] (501s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[522.773110] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[529.577069] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.806s)
[529.739727] [114/131] (494s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[529.850023] Starting subtest: y-tiled-32bpp-rotate-0
[529.854576] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[529.965422] [115/131] (493s left) gem_mmap_gtt (basic-small-bo)
[530.034966] Subtest basic-small-bo: SKIP (0.000s)
[530.099216] [116/131] (493s left) api_intel_bb (simple-bb)
[530.167130] Starting subtest: simple-bb
[530.171744] Subtest simple-bb: SUCCESS (0.005s)
[530.294173] [117/131] (493s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[530.390053] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[530.392227] Starting dynamic subtest: pipe-A
[530.412227] Dynamic subtest pipe-A: SKIP (0.018s)
[530.420287] Starting dynamic subtest: pipe-B
[530.444729] Dynamic subtest pipe-B: SKIP (0.033s)
[530.454719] Starting dynamic subtest: pipe-C
[530.495032] Dynamic subtest pipe-C: SKIP (0.051s)
[530.502394] Starting dynamic subtest: pipe-D
[530.530718] Dynamic subtest pipe-D: SKIP (0.032s)
[530.534849] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.138s)
[530.650028] [118/131] (493s left) kms_lease (lease-unleased-connector)
[530.744443] Starting subtest: lease-unleased-connector
[530.746332] Starting dynamic subtest: pipe-A-eDP-1
[530.750666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[530.758653] Starting dynamic subtest: pipe-B-eDP-1
[530.760776] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[530.771557] Starting dynamic subtest: pipe-C-eDP-1
[530.773455] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[530.780636] Starting dynamic subtest: pipe-D-eDP-1
[530.782183] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[530.783690] Subtest lease-unleased-connector: SUCCESS (0.033s)
[530.898897] [119/131] (493s left) gen9_exec_parse (bb-secure)
[530.962294] Subtest bb-secure: SKIP (0.000s)
[531.042932] [120/131] (493s left) vgem_basic (mmap)
[531.080299] Starting subtest: mmap
[531.091059] Subtest mmap: SUCCESS (0.014s)
[531.170209] [121/131] (492s left) gem_eio (in-flight-contexts-10ms)
[531.395874] Starting subtest: in-flight-contexts-10ms
[542.946888] Subtest in-flight-contexts-10ms: SUCCESS (11.548s)
[543.156349] [122/131] (481s left) i915_pm_rpm (debugfs-forcewake-user)
[545.095312] Starting subtest: debugfs-forcewake-user
[556.485767] Subtest debugfs-forcewake-user: SUCCESS (11.393s)
[556.885351] [123/131] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[556.995778] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[557.000217] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[557.103298] [124/131] (467s left) kms_psr (fbc-pr-no-drrs)
[557.202182] Starting subtest: fbc-pr-no-drrs
[557.206267] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[557.301149] [125/131] (466s left) kms_invalid_mode (bad-htotal)
[557.398230] Starting subtest: bad-htotal
[557.400376] Starting dynamic subtest: pipe-A-eDP-1
[557.690345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[557.699322] Starting dynamic subtest: pipe-B-eDP-1
[557.701153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[557.708805] Starting dynamic subtest: pipe-C-eDP-1
[557.710682] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[557.718413] Starting dynamic subtest: pipe-D-eDP-1
[557.720565] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[557.722689] Subtest bad-htotal: SUCCESS (0.300s)
[558.513865] [126/131] (465s left) kms_cursor_crc (cursor-random-128x42)
[558.772980] Starting subtest: cursor-random-128x42
[558.821559] Subtest cursor-random-128x42: SKIP (0.043s)
[559.078649] [127/131] (465s left) gem_linear_blits (interruptible)
[559.636964] Starting subtest: interruptible
[564.801441] Subtest interruptible: SUCCESS (5.163s)
[564.977099] [128/131] (459s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[565.121580] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[572.136201] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.017s)
[572.295317] [129/131] (452s left) i915_hangman (engine-engine-error)
[572.372202] Starting subtest: engine-engine-error
[572.374115] Starting dynamic subtest: rcs0
[573.875852] Dynamic subtest rcs0: SUCCESS (1.503s)
[573.887503] Starting dynamic subtest: bcs0
[575.858863] Dynamic subtest bcs0: SUCCESS (1.980s)
[575.870396] Starting dynamic subtest: vcs0
[577.907346] Dynamic subtest vcs0: SUCCESS (2.046s)
[577.919125] Starting dynamic subtest: vcs1
[579.890412] Dynamic subtest vcs1: SUCCESS (1.980s)
[579.906827] Starting dynamic subtest: vecs0
[581.875206] Dynamic subtest vecs0: SUCCESS (1.982s)
[581.887778] Starting dynamic subtest: ccs0
[583.858899] Dynamic subtest ccs0: SUCCESS (1.981s)
[583.861994] Subtest engine-engine-error: SUCCESS (11.488s)
[584.026862] [130/131] (440s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[584.127053] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[584.131268] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[584.257350] [131/131] (440s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[584.355513] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[584.357643] Starting dynamic subtest: pipe-A
[584.377559] Dynamic subtest pipe-A: SKIP (0.018s)
[584.386078] Starting dynamic subtest: pipe-B
[584.411533] Dynamic subtest pipe-B: SKIP (0.032s)
[584.422525] Starting dynamic subtest: pipe-C
[584.443308] Dynamic subtest pipe-C: SKIP (0.032s)
[584.452558] Starting dynamic subtest: pipe-D
[584.473061] Dynamic subtest pipe-D: SKIP (0.029s)
[584.477477] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.115s)
[584.601808] Closing watchdogs
results: parsing output: 0/ for test: vgem_slow
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_edge_walk
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: gem_ctx_shared
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_pipe_stress
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: prime_self_import
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_plane_cursor
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_cursor_edge_walk
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: drm_read
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: core_setmaster
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_vrr
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_prop_blob
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_chamelium_color
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: gem_busy
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: prime_mmap
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: gem_ctx_param
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: i915_selftest
results: parsing output: 97/ for test: gem_ctx_exec
results: parsing output: 98/ for test: prime_busy
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_dsc
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: gem_tiled_wb
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_feature_discovery
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_invalid_mode
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: gem_linear_blits
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_plane_scaling
Done.