[57.065508] Initializing watchdogs
[57.065553]   /dev/watchdog0
[57.080534] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.084638] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.086758] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.090155] [001/131] (960s left) kms_psr (fbc-psr2-no-drrs)
[57.200061] Starting subtest: fbc-psr2-no-drrs
[57.202401] Starting dynamic subtest: eDP-1
[57.206804] Dynamic subtest eDP-1: SKIP (0.000s)
[57.211533] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[57.269740] [002/131] (960s left) kms_chamelium_hpd (hdmi-hpd-storm)
[57.648572] Subtest hdmi-hpd-storm: SKIP (0.000s)
[58.493894] [003/131] (959s left) kms_lease (lease-unleased-crtc)
[58.564478] Starting subtest: lease-unleased-crtc
[58.566677] Starting dynamic subtest: pipe-A-eDP-1
[58.851991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[58.860815] Starting dynamic subtest: pipe-B-eDP-1
[59.570536] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.714s)
[59.581669] Starting dynamic subtest: pipe-C-eDP-1
[59.583629] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[59.590182] Starting dynamic subtest: pipe-D-eDP-1
[59.592109] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[59.594042] Subtest lease-unleased-crtc: SUCCESS (1.015s)
[59.931562] [004/131] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[60.032072] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[67.355963] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.327s)
[67.474878] [005/131] (950s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[67.560574] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[67.562813] Starting dynamic subtest: pipe-A
[68.697201] Dynamic subtest pipe-A: SUCCESS (1.139s)
[68.704060] Starting dynamic subtest: pipe-B
[70.955679] Dynamic subtest pipe-B: SUCCESS (2.258s)
[70.964950] Starting dynamic subtest: pipe-C
[72.156833] Dynamic subtest pipe-C: SUCCESS (1.200s)
[72.166382] Starting dynamic subtest: pipe-D
[73.392924] Dynamic subtest pipe-D: SUCCESS (1.235s)
[73.395210] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.835s)
[74.578799] [006/131] (943s left) i915_suspend (forcewake)
[74.635811] Starting subtest: forcewake
[107.141391] Subtest forcewake: SUCCESS (2.414s)
[108.220199] [007/131] (910s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[108.316601] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[115.538779] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.230s)
[115.674489] [008/131] (903s left) gem_ctx_persistence (legacy-engines-mixed-process)
[115.740741] Starting subtest: legacy-engines-mixed-process
[115.743181] Starting dynamic subtest: render
[117.326018] Dynamic subtest render: SUCCESS (1.585s)
[117.337214] Starting dynamic subtest: bsd1
[119.315855] Dynamic subtest bsd1: SUCCESS (1.989s)
[119.326043] Starting dynamic subtest: bsd2
[121.357612] Dynamic subtest bsd2: SUCCESS (2.041s)
[121.368525] Starting dynamic subtest: blt
[123.281735] Dynamic subtest blt: SUCCESS (1.923s)
[123.293712] Starting dynamic subtest: vebox
[125.323566] Dynamic subtest vebox: SUCCESS (2.041s)
[125.326070] Subtest legacy-engines-mixed-process: SUCCESS (9.586s)
[125.404900] [009/131] (893s left) syncobj_timeline (device-submit-unordered)
[125.475387] Starting subtest: device-submit-unordered
[125.477822] Subtest device-submit-unordered: SUCCESS (0.001s)
[125.562989] [010/131] (893s left) syncobj_wait (multi-wait-signaled)
[125.619333] Starting subtest: multi-wait-signaled
[125.621517] Subtest multi-wait-signaled: SUCCESS (0.000s)
[125.709655] [011/131] (893s left) kms_cursor_edge_walk (128x128-right-edge)
[125.800782] Starting subtest: 128x128-right-edge
[125.803104] Starting dynamic subtest: pipe-A-eDP-1
[129.203769] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.402s)
[129.221351] Starting dynamic subtest: pipe-D-eDP-1
[132.340048] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[132.342193] Subtest 128x128-right-edge: SUCCESS (6.541s)
[133.152763] [012/131] (885s left) gem_media_vme
[133.273814] [013/131] (885s left) kms_plane_cursor (overlay)
[133.342605] Starting subtest: overlay
[133.347093] Starting dynamic subtest: pipe-A-eDP-1-size-64
[135.758369] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.417s)
[135.816647] Starting dynamic subtest: pipe-A-eDP-1-size-128
[138.292461] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.482s)
[138.351863] Starting dynamic subtest: pipe-A-eDP-1-size-256
[140.771124] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.427s)
[141.119312] Starting dynamic subtest: pipe-B-eDP-1-size-64
[144.291249] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.182s)
[144.348884] Starting dynamic subtest: pipe-B-eDP-1-size-128
[146.868536] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.527s)
[146.928817] Starting dynamic subtest: pipe-B-eDP-1-size-256
[149.435344] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[149.783697] Starting dynamic subtest: pipe-C-eDP-1-size-64
[152.520584] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.746s)
[152.559099] Starting dynamic subtest: pipe-C-eDP-1-size-128
[154.610164] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.058s)
[154.648141] Starting dynamic subtest: pipe-C-eDP-1-size-256
[156.754206] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[157.082517] Starting dynamic subtest: pipe-D-eDP-1-size-64
[159.857604] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.787s)
[159.896671] Starting dynamic subtest: pipe-D-eDP-1-size-128
[161.947488] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.059s)
[161.985113] Starting dynamic subtest: pipe-D-eDP-1-size-256
[164.046687] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.069s)
[164.369741] Subtest overlay: SUCCESS (31.026s)
[165.239417] [014/131] (853s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[165.311245] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[165.313658] Starting dynamic subtest: pipe-A
[165.537657] Dynamic subtest pipe-A: SUCCESS (0.229s)
[165.547101] Starting dynamic subtest: pipe-B
[166.815295] Dynamic subtest pipe-B: SUCCESS (1.277s)
[166.824102] Starting dynamic subtest: pipe-C
[168.145020] Dynamic subtest pipe-C: SUCCESS (1.329s)
[168.154364] Starting dynamic subtest: pipe-D
[169.495875] Dynamic subtest pipe-D: SUCCESS (1.350s)
[169.498198] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.188s)
[170.679229] [015/131] (848s left) gen9_exec_parse (basic-rejected-ctx-param)
[170.746120] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[170.824779] [016/131] (848s left) gem_exec_schedule (noreorder)
[171.002617] Starting subtest: noreorder
[171.005125] Starting dynamic subtest: rcs0
[171.069535] Dynamic subtest rcs0: SUCCESS (0.068s)
[171.081543] Starting dynamic subtest: vcs0
[172.291597] Dynamic subtest vcs0: SUCCESS (1.219s)
[172.302439] Starting dynamic subtest: vcs1
[174.338636] Dynamic subtest vcs1: SUCCESS (2.045s)
[174.350959] Starting dynamic subtest: vecs0
[176.238620] Dynamic subtest vecs0: SUCCESS (1.897s)
[176.251864] Starting dynamic subtest: ccs0
[176.312635] Dynamic subtest ccs0: SUCCESS (0.073s)
[176.315440] Subtest noreorder: SUCCESS (5.312s)
[176.498456] [017/131] (842s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[176.595397] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[180.567025] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.975s)
[181.763429] [018/131] (837s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[181.854405] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[185.395845] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.548s)
[186.550836] [019/131] (832s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[186.612059] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[186.616549] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[186.791373] [020/131] (832s left) kms_psr (fbc-psr-sprite-plane-move)
[186.874245] Starting subtest: fbc-psr-sprite-plane-move
[186.876509] Starting dynamic subtest: eDP-1
[186.880647] Dynamic subtest eDP-1: SKIP (0.000s)
[186.884712] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[186.943881] [021/131] (832s left) gem_exec_fence (submit-chain)
[187.129346] Starting subtest: submit-chain
[187.147524] Subtest submit-chain: SUCCESS (0.018s)
[189.395507] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[189.400042] [022/131] (830s left) kms_flip (dpms-vs-vblank-race-interruptible)
[189.478858] Starting subtest: dpms-vs-vblank-race-interruptible
[189.481001] Starting dynamic subtest: A-eDP1
[193.320391] Dynamic subtest A-eDP1: SUCCESS (3.839s)
[193.330223] Starting dynamic subtest: B-eDP1
[197.939224] Dynamic subtest B-eDP1: SUCCESS (4.618s)
[197.949887] Starting dynamic subtest: C-eDP1
[202.471170] Dynamic subtest C-eDP1: SUCCESS (4.530s)
[202.480696] Starting dynamic subtest: D-eDP1
[207.114508] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[207.116855] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.636s)
[207.970460] [023/131] (811s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[208.057414] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[208.061749] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[208.156616] [024/131] (811s left) kms_big_fb (linear-8bpp-rotate-0)
[208.247258] Starting subtest: linear-8bpp-rotate-0
[209.515769] Subtest linear-8bpp-rotate-0: SUCCESS (1.268s)
[209.627059] [025/131] (809s left) i915_query (query-topology-matches-eu-total)
[209.687019] Starting subtest: query-topology-matches-eu-total
[209.688833] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[209.805135] [026/131] (809s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[209.894858] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[214.452679] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.560s)
[215.557429] [027/131] (804s left) kms_flip (2x-nonexisting-fb-interruptible)
[215.644016] Starting subtest: 2x-nonexisting-fb-interruptible
[215.654073] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.008s)
[215.754862] [028/131] (803s left) sysfs_timeslice_duration (duration)
[215.813329] Starting subtest: duration
[215.815595] Starting dynamic subtest: vecs0
[230.310841] Dynamic subtest vecs0: SUCCESS (14.493s)
[230.323150] Starting dynamic subtest: ccs0
[243.459824] Dynamic subtest ccs0: SUCCESS (13.148s)
[243.472814] Starting dynamic subtest: vcs0
[257.254245] Dynamic subtest vcs0: SUCCESS (13.790s)
[257.266473] Starting dynamic subtest: bcs0
[270.390643] Dynamic subtest bcs0: SUCCESS (13.136s)
[270.403211] Starting dynamic subtest: rcs0
[283.535770] Dynamic subtest rcs0: SUCCESS (13.143s)
[283.547791] Starting dynamic subtest: vcs1
[297.319026] Dynamic subtest vcs1: SUCCESS (13.779s)
[297.322368] Subtest duration: SUCCESS (81.504s)
[297.408594] [029/131] (722s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[297.497083] Starting subtest: plane-lut1d-post-ctm3x4
[297.687125] Starting dynamic subtest: pipe-A-plane-0
[297.853278] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[297.863685] Starting dynamic subtest: pipe-A-plane-1
[297.997929] Dynamic subtest pipe-A-plane-1: SUCCESS (0.143s)
[298.007730] Starting dynamic subtest: pipe-A-plane-2
[298.131238] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[299.328113] Starting dynamic subtest: pipe-B-plane-0
[299.464472] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[299.473940] Starting dynamic subtest: pipe-B-plane-1
[299.597433] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[299.606859] Starting dynamic subtest: pipe-B-plane-2
[299.730416] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[300.959090] Starting dynamic subtest: pipe-C-plane-0
[301.084902] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[301.094933] Starting dynamic subtest: pipe-C-plane-1
[301.218368] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[301.229822] Starting dynamic subtest: pipe-C-plane-2
[301.351416] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[302.499905] Starting dynamic subtest: pipe-D-plane-0
[302.625371] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[302.634877] Starting dynamic subtest: pipe-D-plane-1
[302.758915] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[302.769071] Starting dynamic subtest: pipe-D-plane-2
[302.892780] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[303.195681] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.701s)
[303.998504] [030/131] (715s left) kms_flip (2x-flip-vs-panning)
[304.076357] Starting subtest: 2x-flip-vs-panning
[304.081664] Subtest 2x-flip-vs-panning: SKIP (0.007s)
[304.161911] [031/131] (715s left) kms_plane_alpha_blend (constant-alpha-mid)
[304.233674] Starting subtest: constant-alpha-mid
[304.506881] Starting dynamic subtest: pipe-A-eDP-1
[305.352909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.844s)
[305.362977] Starting dynamic subtest: pipe-D-eDP-1
[306.899071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.545s)
[306.901359] Subtest constant-alpha-mid: SUCCESS (2.667s)
[307.750197] [032/131] (712s left) syncobj_wait (invalid-reset-zero-handles)
[307.816220] Starting subtest: invalid-reset-zero-handles
[307.818135] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[307.903360] [033/131] (711s left) sw_sync (sync_busy)
[307.945407] Starting subtest: sync_busy
[307.947500] Subtest sync_busy: SUCCESS (0.002s)
[308.003032] [034/131] (711s left) kms_draw_crc (draw-method-pwrite)
[308.075099] Starting subtest: draw-method-pwrite
[308.077232] Starting dynamic subtest: xrgb8888-untiled
[308.730870] Dynamic subtest xrgb8888-untiled: SUCCESS (0.656s)
[308.740672] Starting dynamic subtest: rgb565-untiled
[309.263352] Dynamic subtest rgb565-untiled: SUCCESS (0.532s)
[309.275211] Starting dynamic subtest: xrgb2101010-untiled
[309.874477] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.610s)
[309.884848] Starting dynamic subtest: xbgr16161616f-untiled
[310.752180] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.875s)
[310.762101] Starting dynamic subtest: xrgb8888-xtiled
[312.940656] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.188s)
[312.950692] Starting dynamic subtest: rgb565-xtiled
[314.363036] Dynamic subtest rgb565-xtiled: SUCCESS (1.421s)
[314.373265] Starting dynamic subtest: xrgb2101010-xtiled
[316.563275] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.198s)
[316.573019] Starting dynamic subtest: xbgr16161616f-xtiled
[320.340660] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.776s)
[320.350604] Starting dynamic subtest: xrgb8888-4tiled
[321.673881] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.332s)
[321.683898] Starting dynamic subtest: rgb565-4tiled
[322.373673] Dynamic subtest rgb565-4tiled: SUCCESS (0.699s)
[322.383097] Starting dynamic subtest: xrgb2101010-4tiled
[323.718367] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.344s)
[323.727855] Starting dynamic subtest: xbgr16161616f-4tiled
[327.173431] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.455s)
[327.175678] Subtest draw-method-pwrite: SUCCESS (19.102s)
[327.269335] [035/131] (692s left) prime_mmap_kms (buffer-sharing)
[327.353035] Starting subtest: buffer-sharing
[327.799501] Subtest buffer-sharing: SUCCESS (0.446s)
[328.675894] [036/131] (691s left) gem_exec_whisper (basic-contexts-forked-all)
[328.726508] Starting subtest: basic-contexts-forked-all
[351.309059] Subtest basic-contexts-forked-all: SUCCESS (22.576s)
[351.496150] [037/131] (668s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[351.575021] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[351.581539] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.007s)
[351.703547] [038/131] (668s left) sriov_basic (enable-vfs-autoprobe-on)
[351.767086] Starting subtest: enable-vfs-autoprobe-on
[351.769015] Starting dynamic subtest: numvfs-1
[351.842001] Dynamic subtest numvfs-1: FAIL (0.016s)
[351.852226] Starting dynamic subtest: numvfs-2
[351.925885] Dynamic subtest numvfs-2: FAIL (0.003s)
[351.939121] Starting dynamic subtest: numvfs-3
[352.013293] Dynamic subtest numvfs-3: FAIL (0.003s)
[352.024432] Starting dynamic subtest: numvfs-4
[352.096190] Dynamic subtest numvfs-4: FAIL (0.003s)
[352.107330] Starting dynamic subtest: numvfs-5
[352.179680] Dynamic subtest numvfs-5: FAIL (0.003s)
[352.191163] Starting dynamic subtest: numvfs-6
[352.265835] Dynamic subtest numvfs-6: FAIL (0.003s)
[352.278047] Starting dynamic subtest: numvfs-7
[352.352994] Dynamic subtest numvfs-7: FAIL (0.004s)
[352.362882] Starting dynamic subtest: numvfs-random
[352.433939] Dynamic subtest numvfs-random: FAIL (0.004s)
[352.444688] Starting dynamic subtest: numvfs-all
[352.504929] Dynamic subtest numvfs-all: FAIL (0.521s)
[352.506607] Subtest enable-vfs-autoprobe-on: FAIL (0.570s)
[352.564390] [039/131] (667s left) gem_workarounds (suspend-resume-fd)
[352.627744] Starting subtest: suspend-resume-fd
[369.147063] Subtest suspend-resume-fd: SUCCESS (1.184s)
[369.297244] [040/131] (650s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[369.376002] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[369.377926] Starting dynamic subtest: pipe-A-eDP-1
[370.111874] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s)
[370.122582] Starting dynamic subtest: pipe-B-eDP-1
[371.938120] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.826s)
[371.951359] Starting dynamic subtest: pipe-C-eDP-1
[373.773481] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.835s)
[373.783706] Starting dynamic subtest: pipe-D-eDP-1
[375.598301] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.823s)
[375.600283] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.217s)
[376.754546] [041/131] (643s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[376.837908] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[376.842117] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[376.934108] [042/131] (643s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[376.996835] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[376.998986] Starting dynamic subtest: pipe-A-eDP-1
[377.007638] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.020985] Starting dynamic subtest: pipe-B-eDP-1
[377.029267] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.039482] Starting dynamic subtest: pipe-C-eDP-1
[377.049259] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.059057] Starting dynamic subtest: pipe-D-eDP-1
[377.066907] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.070929] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[379.304694] [043/131] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[379.388182] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[379.392426] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[379.488539] [044/131] (640s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[379.559847] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[379.562139] Starting dynamic subtest: pipe-A-eDP-1
[379.582324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[379.595158] Starting dynamic subtest: pipe-B-eDP-1
[379.614974] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[379.626329] Starting dynamic subtest: pipe-C-eDP-1
[379.646333] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[379.663618] Starting dynamic subtest: pipe-D-eDP-1
[379.682570] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[379.684379] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[381.803540] [045/131] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[381.875248] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[381.879576] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[381.973151] [046/131] (638s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[382.051210] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[382.055736] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[382.128515] [047/131] (638s left) kms_flip (absolute-wf_vblank-interruptible)
[382.199880] Starting subtest: absolute-wf_vblank-interruptible
[382.202203] Starting dynamic subtest: A-eDP1
[390.948498] Dynamic subtest A-eDP1: SUCCESS (8.748s)
[390.965976] Starting dynamic subtest: B-eDP1
[399.676250] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[399.689584] Starting dynamic subtest: C-eDP1
[408.393596] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[408.403917] Starting dynamic subtest: D-eDP1
[417.129048] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[417.135137] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.934s)
[418.346267] [048/131] (602s left) gem_mmap_gtt (fault-concurrent)
[418.415622] Subtest fault-concurrent: SKIP (0.000s)
[418.481174] [049/131] (602s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[418.556623] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[425.259424] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.704s)
[425.394756] [050/131] (595s left) syncobj_timeline (multi-wait-for-submit-signaled)
[425.454466] Starting subtest: multi-wait-for-submit-signaled
[425.456575] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[425.551367] [051/131] (595s left) kms_async_flips (crc)
[425.619124] Starting subtest: crc
[425.995064] Starting dynamic subtest: pipe-A-eDP-1
[428.902408] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.907s)
[429.284364] Starting dynamic subtest: pipe-B-eDP-1
[432.237931] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.967s)
[432.625508] Starting dynamic subtest: pipe-C-eDP-1
[435.541390] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.925s)
[435.918632] Starting dynamic subtest: pipe-D-eDP-1
[438.779438] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.870s)
[438.781701] Subtest crc: SUCCESS (13.162s)
[439.930947] [052/131] (580s left) gem_ctx_exec (basic)
[439.987234] Starting subtest: basic
[439.991892] Subtest basic: SUCCESS (0.005s)
[440.112913] [053/131] (580s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[440.188926] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[440.193310] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[440.283128] [054/131] (580s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[440.382871] Starting subtest: cursorB-vs-flipB-legacy
[440.387383] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[440.529251] [055/131] (580s left) kms_vrr (flip-suspend)
[440.602871] Starting subtest: flip-suspend
[440.609579] Subtest flip-suspend: SKIP (0.000s)
[440.679804] [056/131] (580s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[440.759380] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[440.763820] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[440.870709] [057/131] (580s left) api_intel_bb (misplaced-blitter)
[440.920784] Starting subtest: misplaced-blitter
[440.925300] Subtest misplaced-blitter: SUCCESS (0.006s)
[441.064060] [058/131] (579s left) kms_hdr (static-toggle)
[441.141241] Starting subtest: static-toggle
[441.146527] Subtest static-toggle: SKIP (0.000s)
[441.227953] [059/131] (579s left) kms_pm_rpm (cursor-dpms)
[442.759895] Starting subtest: cursor-dpms
[442.765073] Subtest cursor-dpms: SKIP (0.000s)
[443.482989] [060/131] (577s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[443.554358] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[443.556665] Starting dynamic subtest: pipe-A-eDP-1
[443.650958] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[443.662225] Starting dynamic subtest: pipe-B-eDP-1
[444.839107] Dynamic subtest pipe-B-eDP-1: SKIP (1.183s)
[444.843635] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.289s)
[446.016325] [061/131] (575s left) gem_mmap_wc (write-gtt-read-wc)
[446.078283] Subtest write-gtt-read-wc: SKIP (0.000s)
[446.152149] [062/131] (574s left) gem_pxp (create-protected-buffer)
[446.270264] Starting subtest: create-protected-buffer
[446.272357] Subtest create-protected-buffer: SUCCESS (0.000s)
[446.380289] [063/131] (574s left) gem_create (create-ext-placement-sanity-check)
[446.540535] Starting subtest: create-ext-placement-sanity-check
[446.546930] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[446.640476] [064/131] (574s left) kms_vblank (query-forked-busy-hang)
[446.713583] Starting subtest: query-forked-busy-hang
[446.715864] Starting dynamic subtest: pipe-A-eDP-1
[473.461662] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.747s)
[473.477213] Starting dynamic subtest: pipe-D-eDP-1
[498.479292] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.010s)
[498.481244] Subtest query-forked-busy-hang: SUCCESS (51.762s)
[499.291526] [065/131] (521s left) gem_busy (extended)
[499.486452] Starting subtest: extended
[499.488858] Starting dynamic subtest: rcs0
[499.563613] Dynamic subtest rcs0: SUCCESS (0.076s)
[499.577103] Starting dynamic subtest: bcs0
[499.605635] Dynamic subtest bcs0: SUCCESS (0.040s)
[499.618391] Starting dynamic subtest: vcs0
[501.678378] Dynamic subtest vcs0: SUCCESS (2.069s)
[501.691908] Starting dynamic subtest: vcs1
[503.662538] Dynamic subtest vcs1: SUCCESS (1.981s)
[503.676828] Starting dynamic subtest: vecs0
[505.646621] Dynamic subtest vecs0: SUCCESS (1.981s)
[505.661313] Starting dynamic subtest: ccs0
[505.691787] Dynamic subtest ccs0: SUCCESS (0.044s)
[505.694543] Subtest extended: SUCCESS (6.206s)
[505.934459] [066/131] (515s left) gem_softpin (evict-snoop-interruptible)
[505.994724] Starting subtest: evict-snoop-interruptible
[505.999356] Subtest evict-snoop-interruptible: SKIP (0.000s)
[506.107768] [067/131] (515s left) gem_flink_basic (bad-flink)
[506.171360] Starting subtest: bad-flink
[506.173794] Subtest bad-flink: SUCCESS (0.000s)
[506.275650] [068/131] (515s left) gem_exec_balancer (sliced)
[506.330387] Starting subtest: sliced
[506.334633] Subtest sliced: SKIP (0.000s)
[506.624581] [069/131] (514s left) gem_ctx_isolation (dirty-switch)
[506.688093] Starting subtest: dirty-switch
[506.690415] Starting dynamic subtest: rcs0
[506.913456] Dynamic subtest rcs0: SUCCESS (0.225s)
[506.925067] Starting dynamic subtest: bcs0
[507.170493] Dynamic subtest bcs0: SUCCESS (0.256s)
[507.183157] Starting dynamic subtest: vcs0
[507.454559] Dynamic subtest vcs0: SUCCESS (0.283s)
[507.465512] Starting dynamic subtest: vcs1
[508.847510] Dynamic subtest vcs1: SUCCESS (1.392s)
[508.860549] Starting dynamic subtest: vecs0
[510.898364] Dynamic subtest vecs0: SUCCESS (2.050s)
[510.913665] Starting dynamic subtest: ccs0
[512.841901] Dynamic subtest ccs0: SUCCESS (1.942s)
[512.844296] Subtest dirty-switch: SUCCESS (6.154s)
[513.075815] [070/131] (508s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[513.160204] Starting subtest: 4-tiled-64bpp-rotate-0
[514.626435] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.467s)
[514.821758] [071/131] (506s left) gem_exec_reloc (basic-gtt-read)
[514.891714] Subtest basic-gtt-read: SKIP (0.000s)
[514.973934] [072/131] (506s left) kms_atomic (test-only)
[515.049573] Starting subtest: test-only
[515.101520] Starting dynamic subtest: pipe-A-eDP-1
[517.585094] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.485s)
[517.587482] Subtest test-only: SUCCESS (2.536s)
[518.374637] [073/131] (503s left) kms_psr (psr-cursor-plane-move)
[518.466609] Starting subtest: psr-cursor-plane-move
[518.469873] Starting dynamic subtest: eDP-1
[520.164194] Dynamic subtest eDP-1: SUCCESS (1.697s)
[520.166588] Subtest psr-cursor-plane-move: SUCCESS (1.699s)
[521.034698] [074/131] (500s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[521.099406] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[521.203235] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[521.285270] [075/131] (500s left) kms_chamelium_edid (dp-mode-timings)
[521.663604] Subtest dp-mode-timings: SKIP (0.000s)
[522.437576] [076/131] (499s left) gem_exec_reloc (basic-cpu-gtt-active)
[522.507823] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[522.584205] [077/131] (499s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[522.655041] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[522.657347] Starting dynamic subtest: pipe-A-eDP-1
[522.923000] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.236s)
[522.935630] Starting dynamic subtest: pipe-B-eDP-1
[524.227021] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.301s)
[524.239464] Starting dynamic subtest: pipe-C-eDP-1
[525.432998] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[525.444309] Starting dynamic subtest: pipe-D-eDP-1
[526.663393] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[526.665690] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.979s)
[527.780432] [078/131] (494s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[527.849543] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[527.852030] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[527.964233] [079/131] (493s left) gem_exec_params (readonly)
[528.016927] Starting subtest: readonly
[528.019259] Subtest readonly: SUCCESS (0.002s)
[528.125403] [080/131] (493s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[528.196999] Starting subtest: x-tiled-8bpp-rotate-180
[529.298205] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.102s)
[529.415888] [081/131] (492s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[529.491197] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[529.495069] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[529.595254] [082/131] (492s left) i915_hangman (gt-engine-hang)
[529.657043] Starting subtest: gt-engine-hang
[529.658906] Starting dynamic subtest: rcs0
[531.596604] Dynamic subtest rcs0: SUCCESS (1.938s)
[531.609787] Starting dynamic subtest: bcs0
[533.644025] Dynamic subtest bcs0: SUCCESS (2.044s)
[533.656789] Starting dynamic subtest: vcs0
[535.628122] Dynamic subtest vcs0: SUCCESS (1.981s)
[535.641950] Starting dynamic subtest: vcs1
[537.612215] Dynamic subtest vcs1: SUCCESS (1.982s)
[537.625107] Starting dynamic subtest: vecs0
[539.596063] Dynamic subtest vecs0: SUCCESS (1.981s)
[539.609340] Starting dynamic subtest: ccs0
[541.580625] Dynamic subtest ccs0: SUCCESS (1.982s)
[541.583206] Subtest gt-engine-hang: SUCCESS (11.924s)
[541.716737] [083/131] (480s left) gem_wait (invalid-flags)
[541.761169] Starting subtest: invalid-flags
[541.763635] Subtest invalid-flags: SUCCESS (0.000s)
[541.988682] [084/131] (480s left) gem_pxp (reject-modify-context-protection-on)
[542.052245] Starting subtest: reject-modify-context-protection-on
[542.054431] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[542.149164] [085/131] (479s left) gen9_exec_parse (unaligned-jump)
[542.208372] Subtest unaligned-jump: SKIP (0.000s)
[542.276972] [086/131] (479s left) syncobj_timeline (invalid-signal-illegal-point)
[542.340749] Starting subtest: invalid-signal-illegal-point
[542.342997] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[542.437921] [087/131] (479s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[542.524227] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[542.528182] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[542.613094] [088/131] (479s left) gem_exec_reloc (basic-wc-gtt)
[542.671263] Subtest basic-wc-gtt: SKIP (0.000s)
[542.739680] [089/131] (479s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[542.808885] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[542.812911] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[542.876476] [090/131] (479s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[542.949870] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[542.953101] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[543.056202] [091/131] (479s left) gem_lmem_swapping (heavy-verify-random)
[543.097722] Subtest heavy-verify-random: SKIP (0.000s)
[543.142999] [092/131] (479s left) perf_pmu (idle)
[543.178316] Starting subtest: idle
[543.180226] Starting dynamic subtest: rcs0
[543.726165] Dynamic subtest rcs0: SUCCESS (0.546s)
[543.737575] Starting dynamic subtest: bcs0
[544.252696] Dynamic subtest bcs0: SUCCESS (0.524s)
[544.264341] Starting dynamic subtest: vcs0
[544.766576] Dynamic subtest vcs0: SUCCESS (0.511s)
[544.780346] Starting dynamic subtest: vcs1
[545.289201] Dynamic subtest vcs1: SUCCESS (0.519s)
[545.303031] Starting dynamic subtest: vecs0
[545.807969] Dynamic subtest vecs0: SUCCESS (0.516s)
[545.820226] Starting dynamic subtest: ccs0
[546.326601] Dynamic subtest ccs0: SUCCESS (0.516s)
[546.329459] Subtest idle: SUCCESS (3.149s)
[546.422262] [093/131] (476s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[546.477672] Starting subtest: single-wait-for-submit-available-signaled
[546.479875] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[546.575194] [094/131] (475s left) kms_atomic_interruptible (legacy-dpms)
[546.651507] Starting subtest: legacy-dpms
[546.653900] Starting dynamic subtest: pipe-A-eDP-1
[554.100819] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.449s)
[554.102935] Subtest legacy-dpms: SUCCESS (7.450s)
[554.941094] [095/131] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[555.031275] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[555.035371] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[555.140689] [096/131] (467s left) kms_scaling_modes (scaling-mode-full)
[555.220886] Starting subtest: scaling-mode-full
[555.222966] Starting dynamic subtest: pipe-A-eDP-1
[555.313998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[555.324945] Starting dynamic subtest: pipe-B-eDP-1
[556.454277] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[556.468643] Starting dynamic subtest: pipe-C-eDP-1
[557.571325] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[557.582402] Starting dynamic subtest: pipe-D-eDP-1
[558.695984] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[558.698177] Subtest scaling-mode-full: SUCCESS (3.477s)
[559.872449] [097/131] (462s left) syncobj_wait (invalid-signal-bad-pad)
[559.936291] Starting subtest: invalid-signal-bad-pad
[559.938224] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[560.038130] [098/131] (462s left) kms_selftest (drm_damage_helper)
[560.078107] Starting subtest: drm_damage_helper
[560.152644] Starting dynamic subtest: drm_test_damage_iter_no_damage
[560.262304] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.106s)
[560.273954] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[560.347131] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.086s)
[560.358013] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[560.440823] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.094s)
[560.451060] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[560.544103] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.103s)
[560.553938] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[560.647331] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.099s)
[560.659317] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[560.740443] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.092s)
[560.751114] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[560.829903] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.089s)
[560.842239] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[560.927821] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.097s)
[560.938946] Starting dynamic subtest: drm_test_damage_iter_single_damage
[561.025721] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.096s)
[561.037268] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[561.117827] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.090s)
[561.129727] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[561.212849] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.091s)
[561.223707] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[561.308018] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.096s)
[561.318701] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[561.407160] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.097s)
[561.418888] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[561.496263] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.088s)
[561.507734] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[561.595932] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.099s)
[561.607453] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[561.685246] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.088s)
[561.695820] Starting dynamic subtest: drm_test_damage_iter_damage
[561.784117] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.098s)
[561.794491] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[561.872048] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.087s)
[561.882480] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[561.975235] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.102s)
[561.984927] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[562.070782] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.095s)
[562.080256] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[562.166812] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.095s)
[562.168322] Subtest drm_damage_helper: SUCCESS (2.090s)
[562.323554] [099/131] (460s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[562.409142] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[562.411094] Starting dynamic subtest: pipe-A-default-mode
[565.104376] Dynamic subtest pipe-A-default-mode: SUCCESS (2.696s)
[565.106813] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.697s)
[565.960964] [100/131] (456s left) kms_cursor_legacy (forked-move)
[566.057115] Starting subtest: forked-move
[566.059272] Starting dynamic subtest: pipe-A
[571.513169] Dynamic subtest pipe-A: SUCCESS (5.454s)
[571.527555] Starting dynamic subtest: pipe-B
[577.009080] Dynamic subtest pipe-B: SUCCESS (5.493s)
[577.022233] Starting dynamic subtest: pipe-C
[582.476907] Dynamic subtest pipe-C: SUCCESS (5.466s)
[582.489525] Starting dynamic subtest: pipe-D
[587.951452] Dynamic subtest pipe-D: SUCCESS (5.472s)
[587.964240] Starting dynamic subtest: all-pipes
[593.437165] Dynamic subtest all-pipes: SUCCESS (5.483s)
[593.439514] Subtest forked-move: SUCCESS (27.379s)
[593.584602] [101/131] (429s left) kms_cursor_crc (cursor-offscreen-512x512)
[593.859191] Starting subtest: cursor-offscreen-512x512
[593.863819] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[594.007349] [102/131] (428s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[594.095966] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[594.100731] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[594.188280] [103/131] (428s left) prime_vgem (fence-read-hang)
[594.249730] Subtest fence-read-hang: SKIP (0.000s)
[594.355133] [104/131] (428s left) kms_psr2_su (frontbuffer-xrgb8888)
[594.405081] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[594.461503] [105/131] (428s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[594.547573] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[595.339303] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[595.505358] [106/131] (427s left) gem_linear_blits (interruptible)
[596.051383] Starting subtest: interruptible
[600.121383] Subtest interruptible: SUCCESS (4.069s)
[600.234130] [107/131] (422s left) gem_exec_flush (basic-batch-kernel-default-wb)
[600.326398] Starting subtest: basic-batch-kernel-default-wb
[606.244769] Subtest basic-batch-kernel-default-wb: SUCCESS (5.917s)
[606.442015] [108/131] (416s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[606.518082] Starting subtest: flip-vs-dpms-off-vs-modeset
[606.520095] Starting dynamic subtest: A-eDP1
[610.201313] Dynamic subtest A-eDP1: SUCCESS (3.681s)
[610.213667] Starting dynamic subtest: B-eDP1
[613.394110] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[613.406171] Starting dynamic subtest: C-eDP1
[616.502201] Dynamic subtest C-eDP1: SUCCESS (3.106s)
[616.514441] Starting dynamic subtest: D-eDP1
[619.707621] Dynamic subtest D-eDP1: SUCCESS (3.203s)
[619.709946] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.191s)
[620.520333] [109/131] (402s left) kms_content_protection (dp-mst-type-0-hdcp14)
[620.659359] Starting subtest: dp-mst-type-0-hdcp14
[620.664375] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[620.802408] [110/131] (402s left) gem_mmap_gtt (big-copy-odd)
[620.865291] Subtest big-copy-odd: SKIP (0.000s)
[620.943278] [111/131] (402s left) gem_mmap_offset (bad-flags)
[621.004083] Starting subtest: bad-flags
[621.006307] Subtest bad-flags: SUCCESS (0.000s)
[621.123668] [112/131] (402s left) device_reset (unbind-reset-rebind)
[621.176245] Starting subtest: unbind-reset-rebind
[626.248058] Subtest unbind-reset-rebind: SUCCESS (5.066s)
[626.298462] [113/131] (396s left) i915_pm_rc6_residency (media-rc6-accuracy)
[626.363366] Starting subtest: media-rc6-accuracy
[626.367386] Subtest media-rc6-accuracy: SKIP (0.000s)
[626.456644] [114/131] (396s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[626.544198] Starting subtest: bad-rotation-90-yf-tiled-ccs
[626.546490] Starting dynamic subtest: pipe-A-eDP-1
[626.568023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[626.579948] Starting dynamic subtest: pipe-B-eDP-1
[626.600612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[626.611465] Starting dynamic subtest: pipe-C-eDP-1
[626.631990] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[626.641965] Starting dynamic subtest: pipe-D-eDP-1
[626.663107] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[626.667464] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.013s)
[628.840782] [115/131] (394s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[628.926481] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[635.618793] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.693s)
[635.763015] [116/131] (387s left) gem_render_copy_redux (interruptible)
[635.839281] Starting subtest: interruptible
[636.176289] Subtest interruptible: SUCCESS (0.337s)
[636.295817] [117/131] (387s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[636.373676] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[636.377905] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[636.448002] [118/131] (387s left) kms_cursor_crc (cursor-sliding-128x128)
[636.625385] Starting subtest: cursor-sliding-128x128
[636.632622] Starting dynamic subtest: pipe-A-eDP-1
[639.893443] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.260s)
[639.921432] Starting dynamic subtest: pipe-D-eDP-1
[643.752918] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.841s)
[643.755255] Subtest cursor-sliding-128x128: SUCCESS (7.130s)
[644.628847] [119/131] (378s left) sw_sync (sync_busy_fork_unixsocket)
[644.668706] Starting subtest: sync_busy_fork_unixsocket
[644.675344] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[644.747421] [120/131] (378s left) gem_spin_batch (engines)
[644.812847] Starting subtest: engines
[644.814797] Starting dynamic subtest: rcs0
[648.046008] Dynamic subtest rcs0: SUCCESS (3.231s)
[648.059965] Starting dynamic subtest: bcs0
[651.283175] Dynamic subtest bcs0: SUCCESS (3.234s)
[651.294135] Starting dynamic subtest: vcs0
[654.518684] Dynamic subtest vcs0: SUCCESS (3.233s)
[654.532669] Starting dynamic subtest: vcs1
[657.752028] Dynamic subtest vcs1: SUCCESS (3.231s)
[657.765673] Starting dynamic subtest: vecs0
[660.987402] Dynamic subtest vecs0: SUCCESS (3.232s)
[661.000192] Starting dynamic subtest: ccs0
[664.222653] Dynamic subtest ccs0: SUCCESS (3.232s)
[664.225344] Subtest engines: SUCCESS (19.408s)
[664.461081] [121/131] (359s left) kms_psr (pr-primary-page-flip)
[664.533950] Starting subtest: pr-primary-page-flip
[664.537951] Subtest pr-primary-page-flip: SKIP (0.000s)
[664.621126] [122/131] (359s left) kms_plane_scaling (2x-scaler-multi-pipe)
[664.686873] Starting subtest: 2x-scaler-multi-pipe
[664.691383] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[664.792043] [123/131] (358s left) gem_exec_schedule (submit-late-slice)
[664.856129] Starting subtest: submit-late-slice
[664.858451] Starting dynamic subtest: rcs0
[664.879704] Dynamic subtest rcs0: SUCCESS (0.031s)
[664.894954] Starting dynamic subtest: bcs0
[664.908340] Dynamic subtest bcs0: SUCCESS (0.028s)
[664.919986] Starting dynamic subtest: vcs0
[664.937074] Dynamic subtest vcs0: SUCCESS (0.028s)
[664.948285] Starting dynamic subtest: vcs1
[664.964302] Dynamic subtest vcs1: SUCCESS (0.026s)
[664.975874] Starting dynamic subtest: vecs0
[664.991385] Dynamic subtest vecs0: SUCCESS (0.026s)
[665.003441] Starting dynamic subtest: ccs0
[665.023237] Dynamic subtest ccs0: SUCCESS (0.031s)
[665.025431] Subtest submit-late-slice: SUCCESS (0.175s)
[666.750319] [124/131] (357s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[666.833305] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[666.837299] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[666.931689] [125/131] (356s left) kms_addfb_basic (bad-pitch-1024)
[666.983645] Starting subtest: bad-pitch-1024
[666.985939] Subtest bad-pitch-1024: SUCCESS (0.000s)
[667.098735] [126/131] (356s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[667.203978] Starting subtest: cursor-vs-flip-atomic
[696.833826] Subtest cursor-vs-flip-atomic: SUCCESS (29.628s)
[697.647029] [127/131] (326s left) gem_exec_balancer (nop)
[697.704592] Starting subtest: nop
[744.408521] Subtest nop: SUCCESS (46.703s)
[744.725954] [128/131] (279s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[744.816272] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[744.820386] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[744.917945] [129/131] (279s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[744.993712] Starting subtest: primary-yf-tiled-reflect-x-180
[745.054027] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[745.157531] [130/131] (278s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[745.251971] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[745.256229] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[745.347203] [131/131] (278s left) gem_userptr_blits (vma-merge)
[745.430085] Starting subtest: vma-merge
[745.469276] Subtest vma-merge: SUCCESS (0.042s)
[745.608846] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_chamelium_hpd
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: i915_suspend
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_cursor_edge_walk
results: parsing output: 11/ for test: gem_media_vme
results: parsing output: 12/ for test: kms_plane_cursor
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gen9_exec_parse
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_render_copy
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: i915_query
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: sysfs_timeslice_duration
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_plane_alpha_blend
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: kms_draw_crc
results: parsing output: 34/ for test: prime_mmap_kms
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: sriov_basic
results: parsing output: 38/ for test: gem_workarounds
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: gem_ctx_exec
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_vrr
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_hdr
results: parsing output: 58/ for test: kms_pm_rpm
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: gem_pxp
results: parsing output: 62/ for test: gem_create
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: gem_busy
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: gem_flink_basic
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_atomic
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_chamelium_edid
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_hangman
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_atomic_interruptible
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_scaling_modes
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_selftest
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: prime_vgem
results: parsing output: 103/ for test: kms_psr2_su
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_linear_blits
results: parsing output: 106/ for test: gem_exec_flush
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: device_reset
results: parsing output: 112/ for test: i915_pm_rc6_residency
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_render_copy_redux
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: sw_sync
results: parsing output: 119/ for test: gem_spin_batch
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_userptr_blits
Done.