[54.644716] Initializing watchdogs
[54.644762]   /dev/watchdog0
[54.660127] [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]
[54.664593] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.667366] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.670652] [001/130] (960s left) gem_exec_params (invalid-ring)
[54.748510] Starting subtest: invalid-ring
[54.751060] Subtest invalid-ring: SUCCESS (0.000s)
[54.867931] [002/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[54.969089] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[61.581333] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.474s)
[61.728188] [003/130] (953s left) gem_spin_batch (legacy)
[61.785369] Starting subtest: legacy
[61.787787] Starting dynamic subtest: default
[65.147065] Dynamic subtest default: SUCCESS (3.321s)
[65.156562] Starting dynamic subtest: render
[68.492829] Dynamic subtest render: SUCCESS (3.323s)
[68.501307] Starting dynamic subtest: bsd
[71.829066] Dynamic subtest bsd: SUCCESS (3.320s)
[71.835531] Starting dynamic subtest: bsd1
[75.166058] Dynamic subtest bsd1: SUCCESS (3.326s)
[75.174646] Starting dynamic subtest: bsd2
[78.397237] Dynamic subtest bsd2: SUCCESS (3.226s)
[78.406960] Starting dynamic subtest: blt
[81.632609] Dynamic subtest blt: SUCCESS (3.231s)
[81.641657] Starting dynamic subtest: vebox
[84.866580] Dynamic subtest vebox: SUCCESS (3.230s)
[84.868712] Subtest legacy: SUCCESS (22.982s)
[86.923711] [004/130] (928s left) perf (gen12-group-exclusive-stream-ctx-handle)
[87.032752] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[87.055683] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.022s)
[87.101622] [005/130] (928s left) i915_pm_rps (thresholds-idle)
[88.892309] Starting subtest: thresholds-idle
[88.896730] Subtest thresholds-idle: SKIP (0.000s)
[88.977781] [006/130] (926s left) tools_test (tools_test)
[89.024597] Starting subtest: tools_test
[89.073393] Subtest tools_test: SUCCESS (0.067s)
[89.133963] [007/130] (926s left) gem_mmap_gtt (medium-copy-xy)
[89.190962] Subtest medium-copy-XY: SKIP (0.000s)
[89.249469] [008/130] (926s left) kms_invalid_mode (int-max-clock)
[89.351267] Starting subtest: int-max-clock
[89.353386] Starting dynamic subtest: pipe-A-eDP-1
[89.638365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[89.645316] Starting dynamic subtest: pipe-B-eDP-1
[89.647557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[89.653862] Starting dynamic subtest: pipe-C-eDP-1
[89.656077] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[89.662639] Starting dynamic subtest: pipe-D-eDP-1
[89.664582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[89.666502] Subtest int-max-clock: SUCCESS (0.291s)
[90.438706] [009/130] (925s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[90.554647] Starting subtest: yf-tiled-64bpp-rotate-0
[90.559222] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[90.660712] [010/130] (924s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[90.716035] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[90.823164] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[90.897337] [011/130] (924s left) gem_exec_reloc (basic-range)
[90.961691] Subtest basic-range: SKIP (0.000s)
[91.056668] [012/130] (924s left) gem_userptr_blits (forbidden-operations)
[91.124708] Starting subtest: forbidden-operations
[91.129441] Subtest forbidden-operations: SKIP (0.000s)
[91.261601] [013/130] (924s left) kms_pm_rpm (pm-caching)
[93.016844] Starting subtest: pm-caching
[93.021852] Subtest pm-caching: SKIP (0.000s)
[93.586984] [014/130] (922s left) gem_exec_schedule (u-submit-golden-slice)
[93.663427] Starting subtest: u-submit-golden-slice
[93.665367] Starting dynamic subtest: rcs0
[93.687365] Dynamic subtest rcs0: SUCCESS (0.033s)
[93.697437] Starting dynamic subtest: bcs0
[93.715841] Dynamic subtest bcs0: SUCCESS (0.029s)
[93.722640] Starting dynamic subtest: vcs0
[93.756898] Dynamic subtest vcs0: SUCCESS (0.041s)
[93.765435] Starting dynamic subtest: vcs1
[93.786387] Dynamic subtest vcs1: SUCCESS (0.029s)
[93.793755] Starting dynamic subtest: vecs0
[93.816940] Dynamic subtest vecs0: SUCCESS (0.030s)
[93.824317] Starting dynamic subtest: ccs0
[93.845984] Dynamic subtest ccs0: SUCCESS (0.029s)
[93.848285] Subtest u-submit-golden-slice: SUCCESS (0.191s)
[95.028533] [015/130] (920s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[100.050835] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[100.055410] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.004s)
[100.887322] [016/130] (914s left) gem_exec_params (dr4-dirt)
[100.945639] Starting subtest: DR4-dirt
[100.948126] Subtest DR4-dirt: SUCCESS (0.000s)
[101.038824] [017/130] (914s left) kms_flip (flip-vs-rmfb)
[101.135335] Starting subtest: flip-vs-rmfb
[101.137584] Starting dynamic subtest: A-eDP1
[109.789080] Dynamic subtest A-eDP1: SUCCESS (8.650s)
[109.798079] Starting dynamic subtest: B-eDP1
[118.419901] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[118.428910] Starting dynamic subtest: C-eDP1
[127.053995] Dynamic subtest C-eDP1: SUCCESS (8.632s)
[127.062354] Starting dynamic subtest: D-eDP1
[135.686354] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[135.690594] Subtest flip-vs-rmfb: SUCCESS (34.548s)
[136.871773] [018/130] (878s left) prime_self_import (basic-with_one_bo_two_files)
[136.903739] Starting subtest: basic-with_one_bo_two_files
[136.920727] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[137.035083] [019/130] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[137.129521] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[141.546484] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.420s)
[142.683292] [020/130] (873s left) gem_wait (busy)
[142.749114] Starting subtest: busy
[142.751603] Starting dynamic subtest: all-engines
[143.890772] Dynamic subtest all-engines: SUCCESS (1.140s)
[143.901224] Starting dynamic subtest: rcs0
[144.432081] Dynamic subtest rcs0: SUCCESS (0.540s)
[144.441853] Starting dynamic subtest: bcs0
[144.970224] Dynamic subtest bcs0: SUCCESS (0.537s)
[144.980550] Starting dynamic subtest: vcs0
[146.897722] Dynamic subtest vcs0: SUCCESS (1.926s)
[146.906986] Starting dynamic subtest: vcs1
[148.881955] Dynamic subtest vcs1: SUCCESS (1.982s)
[148.892444] Starting dynamic subtest: vecs0
[150.930067] Dynamic subtest vecs0: SUCCESS (2.046s)
[150.940851] Starting dynamic subtest: ccs0
[151.472681] Dynamic subtest ccs0: SUCCESS (0.541s)
[151.475215] Subtest busy: SUCCESS (8.723s)
[151.663649] [021/130] (864s left) kms_addfb_basic (bad-pitch-128)
[151.727463] Starting subtest: bad-pitch-128
[151.729924] Subtest bad-pitch-128: SUCCESS (0.000s)
[151.875068] [022/130] (864s left) kms_psr (fbc-psr-sprite-plane-onoff)
[151.985344] Starting subtest: fbc-psr-sprite-plane-onoff
[151.987366] Starting dynamic subtest: eDP-1
[151.991541] Dynamic subtest eDP-1: SKIP (0.000s)
[151.995719] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[152.052435] [023/130] (863s left) device_reset (unbind-reset-rebind)
[152.096214] Starting subtest: unbind-reset-rebind
[156.778391] Subtest unbind-reset-rebind: SUCCESS (4.680s)
[156.819524] [024/130] (859s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[156.920165] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[156.922487] Starting dynamic subtest: pipe-A-eDP-1
[156.983882] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[156.993174] Starting dynamic subtest: pipe-B-eDP-1
[157.051823] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[157.061459] Starting dynamic subtest: pipe-C-eDP-1
[157.120101] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[157.128896] Starting dynamic subtest: pipe-D-eDP-1
[157.185299] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[157.189728] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[159.109920] [025/130] (856s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[159.160065] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[159.162293] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[159.239924] [026/130] (856s left) kms_lease (lease-again)
[159.336053] Starting subtest: lease-again
[159.338292] Starting dynamic subtest: pipe-A-eDP-1
[159.340621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[159.349800] Starting dynamic subtest: pipe-B-eDP-1
[159.351714] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[159.358994] Starting dynamic subtest: pipe-C-eDP-1
[159.360834] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[159.368249] Starting dynamic subtest: pipe-D-eDP-1
[159.370148] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[159.371975] Subtest lease-again: SUCCESS (0.011s)
[159.451808] [027/130] (856s left) gem_ctx_isolation (preservation-s3)
[159.507667] Starting subtest: preservation-S3
[159.510056] Starting dynamic subtest: rcs0
[175.611019] Dynamic subtest rcs0: SUCCESS (1.393s)
[175.621819] Starting dynamic subtest: bcs0
[191.544278] Dynamic subtest bcs0: SUCCESS (1.262s)
[191.553361] Starting dynamic subtest: vcs0
[207.547318] Dynamic subtest vcs0: SUCCESS (2.750s)
[207.557138] Starting dynamic subtest: vcs1
[225.627274] Dynamic subtest vcs1: SUCCESS (4.962s)
[225.639897] Starting dynamic subtest: vecs0
[243.617159] Dynamic subtest vecs0: SUCCESS (4.841s)
[243.626609] Starting dynamic subtest: ccs0
[261.557178] Dynamic subtest ccs0: SUCCESS (3.038s)
[261.559436] Subtest preservation-S3: SUCCESS (18.251s)
[261.807234] [028/130] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[261.903704] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[265.537762] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.542s)
[266.664925] [029/130] (749s left) syncobj_timeline (wait-for-submit-delayed-submit)
[266.723280] Starting subtest: wait-for-submit-delayed-submit
[266.826946] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[266.900074] [030/130] (749s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[266.951355] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[267.058469] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[267.134973] [031/130] (749s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[267.236093] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[267.880870] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[268.040828] [032/130] (748s left) gem_ctx_persistence (legacy-engines-persistence)
[268.103223] Starting subtest: legacy-engines-persistence
[268.105155] Starting dynamic subtest: render
[268.914614] Dynamic subtest render: SUCCESS (0.802s)
[268.926737] Starting dynamic subtest: bsd1
[269.687297] Dynamic subtest bsd1: SUCCESS (0.759s)
[269.699642] Starting dynamic subtest: bsd2
[270.458976] Dynamic subtest bsd2: SUCCESS (0.760s)
[270.470689] Starting dynamic subtest: blt
[271.227259] Dynamic subtest blt: SUCCESS (0.757s)
[271.239400] Starting dynamic subtest: vebox
[272.047229] Dynamic subtest vebox: SUCCESS (0.809s)
[272.049817] Subtest legacy-engines-persistence: SUCCESS (3.899s)
[272.126224] [033/130] (744s left) gem_exec_schedule (preempt-other-chain)
[272.197990] Starting subtest: preempt-other-chain
[272.200302] Starting dynamic subtest: rcs0
[272.331578] Dynamic subtest rcs0: SUCCESS (0.136s)
[272.343234] Starting dynamic subtest: bcs0
[272.463019] Dynamic subtest bcs0: SUCCESS (0.131s)
[272.473424] Starting dynamic subtest: vcs0
[272.595892] Dynamic subtest vcs0: SUCCESS (0.130s)
[272.604672] Starting dynamic subtest: vcs1
[272.720647] Dynamic subtest vcs1: SUCCESS (0.122s)
[272.732847] Starting dynamic subtest: vecs0
[272.849849] Dynamic subtest vecs0: SUCCESS (0.128s)
[272.864273] Starting dynamic subtest: ccs0
[272.978852] Dynamic subtest ccs0: SUCCESS (0.128s)
[272.981731] Subtest preempt-other-chain: SUCCESS (0.779s)
[273.491632] [034/130] (742s left) kms_cursor_edge_walk (256x256-top-edge)
[273.588188] Starting subtest: 256x256-top-edge
[273.590592] Starting dynamic subtest: pipe-A-eDP-1
[277.030574] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[277.042857] Starting dynamic subtest: pipe-D-eDP-1
[280.157597] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[280.159533] Subtest 256x256-top-edge: SUCCESS (6.531s)
[280.973884] [035/130] (735s left) gem_mmap_gtt (medium-copy)
[281.035157] Subtest medium-copy: SKIP (0.000s)
[281.102085] [036/130] (735s left) api_intel_bb (blit-noreloc-purge-cache)
[281.162547] Starting subtest: blit-noreloc-purge-cache
[281.169981] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[281.307184] [037/130] (735s left) kms_chamelium_color (gamma)
[281.400175] Subtest gamma: SKIP (0.000s)
[281.442878] [038/130] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[281.540177] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[281.544400] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[281.630077] [039/130] (734s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[281.734871] Starting subtest: blocking-absolute-wf_vblank-interruptible
[281.737216] Starting dynamic subtest: A-eDP1
[290.458436] Dynamic subtest A-eDP1: SUCCESS (8.705s)
[290.470290] Starting dynamic subtest: B-eDP1
[299.189638] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[299.200778] Starting dynamic subtest: C-eDP1
[307.904209] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[307.914041] Starting dynamic subtest: D-eDP1
[316.633457] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[316.635837] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.880s)
[317.846987] [040/130] (698s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[317.938226] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[317.940606] Starting dynamic subtest: pipe-A-default-mode
[320.682725] Dynamic subtest pipe-A-default-mode: SUCCESS (2.739s)
[320.684929] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.740s)
[321.543381] [041/130] (695s left) kms_cursor_crc (cursor-onscreen-128x128)
[321.728243] Starting subtest: cursor-onscreen-128x128
[321.733039] Starting dynamic subtest: pipe-A-eDP-1
[323.827210] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.092s)
[323.854767] Starting dynamic subtest: pipe-D-eDP-1
[326.612833] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[326.614799] Subtest cursor-onscreen-128x128: SUCCESS (4.880s)
[327.420497] [042/130] (689s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[327.544171] Starting subtest: cursorB-vs-flipB-varying-size
[327.548761] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[327.689090] [043/130] (689s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[327.813142] Starting subtest: cursorB-vs-flipB-toggle
[327.817483] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[327.953805] [044/130] (688s left) kms_dp_link_training (non-uhbr-mst)
[328.049043] Starting subtest: non-uhbr-mst
[328.057561] Subtest non-uhbr-mst: SKIP (0.000s)
[328.117487] [045/130] (688s left) gem_exec_params (secure-non-master)
[328.184925] Starting subtest: secure-non-master
[328.189316] Subtest secure-non-master: SKIP (0.000s)
[328.303992] [046/130] (688s left) gem_exec_params (rel-constants-invalid-ring)
[328.356010] Starting subtest: rel-constants-invalid-ring
[328.358078] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[328.453544] [047/130] (688s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[328.541700] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[328.543730] Starting dynamic subtest: pipe-A-eDP-1
[328.564939] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.574752] Starting dynamic subtest: pipe-B-eDP-1
[328.594339] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.604492] Starting dynamic subtest: pipe-C-eDP-1
[328.624191] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.633210] Starting dynamic subtest: pipe-D-eDP-1
[328.652655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.656135] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[330.685008] [048/130] (686s left) fbdev (unaligned-read)
[330.725641] Starting subtest: unaligned-read
[330.740124] Subtest unaligned-read: SUCCESS (0.014s)
[330.792115] [049/130] (686s left) core_auth (many-magics)
[330.852214] Starting subtest: many-magics
[331.718786] Subtest many-magics: SUCCESS (0.867s)
[331.890579] [050/130] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[331.987046] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[331.990958] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[332.091959] [051/130] (684s left) i915_hangman (gt-engine-hang)
[332.144768] Starting subtest: gt-engine-hang
[332.146691] Starting dynamic subtest: rcs0
[333.381988] Dynamic subtest rcs0: SUCCESS (1.237s)
[333.393640] Starting dynamic subtest: bcs0
[335.364779] Dynamic subtest bcs0: SUCCESS (1.980s)
[335.378402] Starting dynamic subtest: vcs0
[337.348001] Dynamic subtest vcs0: SUCCESS (1.980s)
[337.358200] Starting dynamic subtest: vcs1
[339.331266] Dynamic subtest vcs1: SUCCESS (1.980s)
[339.343490] Starting dynamic subtest: vecs0
[341.316734] Dynamic subtest vecs0: SUCCESS (1.982s)
[341.326816] Starting dynamic subtest: ccs0
[343.363973] Dynamic subtest ccs0: SUCCESS (2.044s)
[343.366880] Subtest gt-engine-hang: SUCCESS (11.217s)
[343.439813] [052/130] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[343.540582] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[343.544967] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[343.633122] [053/130] (673s left) kms_plane_scaling (intel-max-src-size)
[343.727977] Starting subtest: intel-max-src-size
[343.734183] Subtest intel-max-src-size: SKIP (0.000s)
[343.818659] [054/130] (673s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[343.907807] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[347.874963] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.970s)
[348.989287] [055/130] (668s left) perf_pmu (multi-client)
[349.026233] Starting subtest: multi-client
[349.028494] Starting dynamic subtest: rcs0
[350.098007] Dynamic subtest rcs0: SUCCESS (1.070s)
[350.109964] Starting dynamic subtest: bcs0
[351.147431] Dynamic subtest bcs0: SUCCESS (1.047s)
[351.159623] Starting dynamic subtest: vcs0
[352.199635] Dynamic subtest vcs0: SUCCESS (1.048s)
[352.210695] Starting dynamic subtest: vcs1
[353.375144] Dynamic subtest vcs1: SUCCESS (1.174s)
[353.387595] Starting dynamic subtest: vecs0
[355.418835] Dynamic subtest vecs0: SUCCESS (2.040s)
[355.429990] Starting dynamic subtest: ccs0
[357.406016] Dynamic subtest ccs0: SUCCESS (1.985s)
[357.408555] Subtest multi-client: SUCCESS (8.377s)
[357.539158] [056/130] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[357.636577] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[357.641050] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[357.743845] [057/130] (659s left) kms_async_flips (crc-atomic)
[357.831278] Starting subtest: crc-atomic
[358.202931] Starting dynamic subtest: pipe-A-eDP-1
[361.102513] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.900s)
[361.481989] Starting dynamic subtest: pipe-B-eDP-1
[364.420520] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.948s)
[364.795932] Starting dynamic subtest: pipe-C-eDP-1
[367.627195] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.844s)
[368.001810] Starting dynamic subtest: pipe-D-eDP-1
[370.865822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.876s)
[370.868177] Subtest crc-atomic: SUCCESS (13.037s)
[372.025817] [058/130] (645s left) gem_close_race (multigpu-basic-process)
[372.111849] Starting subtest: multigpu-basic-process
[372.116308] Subtest multigpu-basic-process: SKIP (0.000s)
[372.351835] [059/130] (644s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[372.463417] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[372.467704] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[372.572796] [060/130] (644s left) kms_cursor_crc (cursor-random-max-size)
[372.852827] Starting subtest: cursor-random-max-size
[372.859189] Subtest cursor-random-max-size: SKIP (0.000s)
[372.963810] [061/130] (644s left) kms_lease (simple-lease)
[373.058040] Starting subtest: simple-lease
[373.060293] Starting dynamic subtest: pipe-A-eDP-1
[373.553729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.493s)
[373.563089] Starting dynamic subtest: pipe-B-eDP-1
[374.956048] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.402s)
[374.965796] Starting dynamic subtest: pipe-C-eDP-1
[376.353986] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[376.363954] Starting dynamic subtest: pipe-D-eDP-1
[377.744835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s)
[377.747105] Subtest simple-lease: SUCCESS (4.687s)
[378.551278] [062/130] (638s left) gem_softpin (overlap)
[378.609284] Starting subtest: overlap
[379.428629] Subtest overlap: SUCCESS (0.817s)
[379.559072] [063/130] (637s left) kms_vrr (flip-basic)
[379.653966] Starting subtest: flip-basic
[379.660744] Subtest flip-basic: SKIP (0.000s)
[379.723836] [064/130] (637s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[379.807960] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[379.810280] Starting dynamic subtest: pipe-A
[380.145962] Dynamic subtest pipe-A: SUCCESS (0.338s)
[380.154980] Starting dynamic subtest: pipe-B
[381.538294] Dynamic subtest pipe-B: SUCCESS (1.391s)
[381.547104] Starting dynamic subtest: pipe-C
[382.979267] Dynamic subtest pipe-C: SUCCESS (1.440s)
[382.988106] Starting dynamic subtest: pipe-D
[384.408308] Dynamic subtest pipe-D: SUCCESS (1.428s)
[384.410550] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.601s)
[385.571230] [065/130] (631s left) kms_atomic_transition (plane-all-transition-fencing)
[385.670140] Starting subtest: plane-all-transition-fencing
[385.672410] Starting dynamic subtest: pipe-A-eDP-1
[388.174124] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[388.492159] Starting dynamic subtest: pipe-B-eDP-1
[391.719814] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.236s)
[392.029538] Subtest plane-all-transition-fencing: SUCCESS (6.359s)
[392.849346] [066/130] (624s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[392.962827] Starting subtest: y-tiled-64bpp-rotate-90
[392.967366] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[393.076406] [067/130] (624s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[393.182050] Starting subtest: fbcpsr-rgb565-draw-blt
[400.087747] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.908s)
[400.231233] [068/130] (617s left) gem_ctx_persistence (engines-mixed-process)
[400.294909] Starting subtest: engines-mixed-process
[400.297353] Starting dynamic subtest: rcs0
[402.388502] Dynamic subtest rcs0: SUCCESS (2.091s)
[402.397696] Starting dynamic subtest: bcs0
[404.386831] Dynamic subtest bcs0: SUCCESS (2.000s)
[404.399638] Starting dynamic subtest: vcs0
[406.398752] Dynamic subtest vcs0: SUCCESS (2.011s)
[406.410735] Starting dynamic subtest: vcs1
[408.374638] Dynamic subtest vcs1: SUCCESS (1.974s)
[408.384604] Starting dynamic subtest: vecs0
[410.429701] Dynamic subtest vecs0: SUCCESS (2.053s)
[410.442282] Starting dynamic subtest: ccs0
[412.414756] Dynamic subtest ccs0: SUCCESS (1.983s)
[412.417440] Subtest engines-mixed-process: SUCCESS (12.118s)
[412.494741] [069/130] (605s left) kms_dsc (dsc-with-output-formats-with-bpc)
[412.604170] Starting subtest: dsc-with-output-formats-with-bpc
[412.662026] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[412.698888] [070/130] (605s left) gem_softpin (invalid)
[412.754251] Starting subtest: invalid
[412.762241] Subtest invalid: SUCCESS (0.006s)
[412.876196] [071/130] (604s left) gem_lmem_swapping (random-engines)
[412.916878] Subtest random-engines: SKIP (0.000s)
[412.958842] [072/130] (604s left) gem_exec_reloc (basic-cpu-wc-active)
[413.006614] Subtest basic-cpu-wc-active: SKIP (0.000s)
[413.079797] [073/130] (604s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[413.179767] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[417.417834] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.243s)
[418.577090] [074/130] (599s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[418.674209] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[418.676485] Starting dynamic subtest: pipe-A-eDP-1
[418.699835] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.710286] Starting dynamic subtest: pipe-B-eDP-1
[418.732144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.743560] Starting dynamic subtest: pipe-C-eDP-1
[418.765145] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.774424] Starting dynamic subtest: pipe-D-eDP-1
[418.796015] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.800405] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[420.843287] [075/130] (597s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[425.836237] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[425.838677] Starting dynamic subtest: pipe-A-eDP-1
[437.870039] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.030s)
[437.879272] Starting dynamic subtest: pipe-B-eDP-1
[449.896459] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.022s)
[449.898821] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.055s)
[450.748922] [076/130] (567s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[450.857066] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[450.861508] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[450.963976] [077/130] (567s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[451.068136] Starting subtest: psr-rgb101010-draw-render
[458.343887] Subtest psr-rgb101010-draw-render: SUCCESS (7.276s)
[458.489120] [078/130] (559s left) kms_pm_rpm (cursor-dpms)
[460.609427] Starting subtest: cursor-dpms
[460.615806] Subtest cursor-dpms: SKIP (0.000s)
[460.970166] [079/130] (557s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[461.080080] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[467.801990] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.723s)
[467.934548] [080/130] (550s left) perf (sysctl-defaults)
[467.994183] Starting subtest: sysctl-defaults
[467.996485] Subtest sysctl-defaults: SUCCESS (0.000s)
[468.078019] [081/130] (550s left) kms_psr (fbc-psr2-cursor-plane-move)
[468.173961] Starting subtest: fbc-psr2-cursor-plane-move
[468.176180] Starting dynamic subtest: eDP-1
[468.180553] Dynamic subtest eDP-1: SKIP (0.000s)
[468.184999] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[468.242964] [082/130] (549s left) gen9_exec_parse (secure-batches)
[468.292275] Subtest secure-batches: SKIP (0.000s)
[468.361684] [083/130] (549s left) gem_mmap_offset (clear-via-pagefault)
[468.422197] Starting subtest: clear-via-pagefault
[468.424353] Starting dynamic subtest: smem0
[498.473074] Dynamic subtest smem0: SUCCESS (30.043s)
[498.475548] Subtest clear-via-pagefault: SUCCESS (30.045s)
[498.569199] [084/130] (519s left) kms_atomic_transition (modeset-transition-fencing)
[498.680766] Starting subtest: modeset-transition-fencing
[498.682989] Starting dynamic subtest: 1x-outputs
[509.220673] Dynamic subtest 1x-outputs: SUCCESS (10.542s)
[509.481179] Subtest modeset-transition-fencing: SUCCESS (10.804s)
[510.361892] [085/130] (507s left) gem_exec_schedule (in-order)
[510.437636] Starting subtest: in-order
[510.439873] Starting dynamic subtest: rcs0
[510.527209] Dynamic subtest rcs0: SUCCESS (0.097s)
[510.539343] Starting dynamic subtest: vcs0
[510.608470] Dynamic subtest vcs0: SUCCESS (0.081s)
[510.621037] Starting dynamic subtest: vcs1
[510.689190] Dynamic subtest vcs1: SUCCESS (0.080s)
[510.699151] Starting dynamic subtest: vecs0
[510.772190] Dynamic subtest vecs0: SUCCESS (0.082s)
[510.783909] Starting dynamic subtest: ccs0
[510.866252] Dynamic subtest ccs0: SUCCESS (0.093s)
[510.868956] Subtest in-order: SUCCESS (0.436s)
[512.472443] [086/130] (505s left) kms_psr (fbc-pr-dpms)
[512.568955] Starting subtest: fbc-pr-dpms
[512.573300] Subtest fbc-pr-dpms: SKIP (0.000s)
[512.636668] [087/130] (505s left) i915_selftest (perf)
[514.610644] Starting subtest: perf
[514.613474] Starting dynamic subtest: engine_cs
[518.987515] Dynamic subtest engine_cs: SUCCESS (4.378s)
[518.996985] Starting dynamic subtest: request
[526.230445] Dynamic subtest request: SUCCESS (7.242s)
[526.239582] Starting dynamic subtest: migrate
[529.213080] Dynamic subtest migrate: SUCCESS (2.981s)
[529.222579] Starting dynamic subtest: region
[535.062639] Dynamic subtest region: SUCCESS (5.848s)
[535.065113] Subtest perf: SUCCESS (20.455s)
[535.092852] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[535.095847] [088/130] (483s left) kms_psr (psr-primary-blt)
[536.575992] Starting subtest: psr-primary-blt
[536.578262] Starting dynamic subtest: eDP-1
[538.311494] Dynamic subtest eDP-1: SUCCESS (1.737s)
[538.313885] Subtest psr-primary-blt: SUCCESS (1.738s)
[539.169764] [FACT kms_psr (psr-primary-blt)] new: kernel.kmod_is_loaded.i915: true
[539.173468] [089/130] (479s left) kms_sequence (get-idle)
[539.283209] Starting subtest: get-idle
[539.285476] Starting dynamic subtest: pipe-A-eDP-1
[541.087617] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[541.096414] Starting dynamic subtest: pipe-B-eDP-1
[543.537344] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.449s)
[543.548639] Starting dynamic subtest: pipe-C-eDP-1
[545.948957] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.410s)
[545.957975] Starting dynamic subtest: pipe-D-eDP-1
[548.398094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.446s)
[548.400302] Subtest get-idle: SUCCESS (9.112s)
[549.199046] [090/130] (469s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[549.286729] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[549.289047] Starting dynamic subtest: A-eDP1
[552.825157] Dynamic subtest A-eDP1: SUCCESS (3.535s)
[552.833834] Starting dynamic subtest: B-eDP1
[556.026667] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[556.035550] Starting dynamic subtest: C-eDP1
[559.136175] Dynamic subtest C-eDP1: SUCCESS (3.110s)
[559.145059] Starting dynamic subtest: D-eDP1
[562.248932] Dynamic subtest D-eDP1: SUCCESS (3.113s)
[562.251259] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.964s)
[563.049046] [091/130] (455s left) gem_workarounds (basic-read-fd)
[563.123506] Starting subtest: basic-read-fd
[563.137456] Subtest basic-read-fd: SUCCESS (0.014s)
[563.254741] [092/130] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[563.353373] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[570.573154] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.223s)
[570.725533] [093/130] (447s left) prime_busy (after-wait)
[570.781089] Starting subtest: after-wait
[570.786835] Starting dynamic subtest: rcs0
[570.815033] Dynamic subtest rcs0: SUCCESS (0.030s)
[570.824985] Starting dynamic subtest: bcs0
[570.894788] Dynamic subtest bcs0: SUCCESS (0.079s)
[570.905434] Starting dynamic subtest: vcs0
[570.936145] Dynamic subtest vcs0: SUCCESS (0.040s)
[570.945565] Starting dynamic subtest: vcs1
[570.976123] Dynamic subtest vcs1: SUCCESS (0.039s)
[570.984576] Starting dynamic subtest: vecs0
[571.015852] Dynamic subtest vecs0: SUCCESS (0.040s)
[571.024451] Starting dynamic subtest: ccs0
[571.056027] Dynamic subtest ccs0: SUCCESS (0.039s)
[571.163956] Subtest after-wait: SUCCESS (0.381s)
[571.234492] [094/130] (447s left) gem_sync (basic-store-all)
[571.303036] Starting subtest: basic-store-all
[575.362130] Subtest basic-store-all: SUCCESS (4.067s)
[575.547448] [095/130] (443s left) gem_exec_balancer (bonded-true-hang)
[575.811608] Starting subtest: bonded-true-hang
[575.816234] Subtest bonded-true-hang: SKIP (0.000s)
[575.928342] [096/130] (442s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[576.027355] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[580.223445] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.200s)
[581.395267] [097/130] (437s left) gem_mmap_gtt (bad-object)
[581.456925] Subtest bad-object: SKIP (0.000s)
[581.529041] [098/130] (437s left) kms_flip (flip-vs-wf_vblank-interruptible)
[581.638947] Starting subtest: flip-vs-wf_vblank-interruptible
[581.641251] Starting dynamic subtest: A-eDP1
[583.531407] Dynamic subtest A-eDP1: SUCCESS (1.891s)
[583.540285] Starting dynamic subtest: B-eDP1
[585.467510] Dynamic subtest B-eDP1: SUCCESS (1.935s)
[585.476391] Starting dynamic subtest: C-eDP1
[587.394046] Dynamic subtest C-eDP1: SUCCESS (1.925s)
[587.403204] Starting dynamic subtest: D-eDP1
[589.230618] Dynamic subtest D-eDP1: SUCCESS (1.835s)
[589.232909] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.594s)
[590.462212] [099/130] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[590.568421] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[590.572508] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[590.656320] [100/130] (428s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[590.753876] Starting subtest: x-tiled-16bpp-rotate-270
[590.773802] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[590.895903] [101/130] (427s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[591.011392] Starting subtest: basic-flip-after-cursor-varying-size
[591.934180] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.924s)
[592.800756] [102/130] (426s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[592.865605] Starting subtest: mixed-tiled-to-y-tiled-ccs
[592.870085] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[593.049401] [103/130] (425s left) gem_softpin (allocator-nopin-reserve)
[593.101337] Starting subtest: allocator-nopin-reserve
[593.207177] Subtest allocator-nopin-reserve: SUCCESS (0.105s)
[593.350351] [104/130] (425s left) gem_ctx_param (invalid-size-get)
[593.405499] Starting subtest: invalid-size-get
[593.407959] Subtest invalid-size-get: SUCCESS (0.001s)
[593.516991] [105/130] (425s left) kms_psr (psr-sprite-mmap-gtt)
[593.618043] Starting subtest: psr-sprite-mmap-gtt
[593.620327] Starting dynamic subtest: eDP-1
[595.024949] Dynamic subtest eDP-1: SKIP (1.404s)
[595.029733] Subtest psr-sprite-mmap-gtt: SKIP (1.406s)
[595.202242] [106/130] (423s left) kms_color (legacy-gamma)
[595.302192] Starting subtest: legacy-gamma
[595.304497] Starting dynamic subtest: pipe-A-eDP-1
[595.992286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s)
[596.001605] Starting dynamic subtest: pipe-B-eDP-1
[597.426186] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s)
[597.440879] Starting dynamic subtest: pipe-C-eDP-1
[598.781915] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.354s)
[598.792017] Starting dynamic subtest: pipe-D-eDP-1
[600.145118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.363s)
[600.147308] Subtest legacy-gamma: SUCCESS (4.842s)
[600.969556] [107/130] (418s left) i915_drm_fdinfo (isolation)
[601.014627] Starting subtest: isolation
[601.016540] Starting dynamic subtest: rcs0
[601.028599] Dynamic subtest rcs0: SKIP (0.014s)
[601.037008] Starting dynamic subtest: bcs0
[601.048587] Dynamic subtest bcs0: SKIP (0.019s)
[601.057137] Starting dynamic subtest: vcs0
[601.061494] Dynamic subtest vcs0: SKIP (0.000s)
[601.069807] Starting dynamic subtest: vcs1
[601.073882] Dynamic subtest vcs1: SKIP (0.000s)
[601.082089] Starting dynamic subtest: vecs0
[601.087955] Dynamic subtest vecs0: SKIP (0.000s)
[601.098505] Starting dynamic subtest: ccs0
[601.102682] Dynamic subtest ccs0: SKIP (0.000s)
[601.107016] Subtest isolation: SKIP (0.038s)
[601.145190] [108/130] (417s left) gem_tiled_fence_blits (basic)
[601.206565] Subtest basic: SKIP (0.000s)
[601.282683] [109/130] (417s left) syncobj_timeline (invalid-transfer-illegal-handle)
[601.334606] Starting subtest: invalid-transfer-illegal-handle
[601.336938] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[601.432700] [110/130] (417s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[601.517819] Starting subtest: bad-rotation-90-y-tiled-ccs
[601.520196] Starting dynamic subtest: pipe-A-eDP-1
[601.543123] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[601.554376] Starting dynamic subtest: pipe-B-eDP-1
[601.575650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[601.583798] Starting dynamic subtest: pipe-C-eDP-1
[601.605498] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[601.613535] Starting dynamic subtest: pipe-D-eDP-1
[601.635528] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[601.639938] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[603.736842] [111/130] (415s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[603.784547] Starting subtest: multi-wait-for-submit-available-submitted
[603.786910] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[603.878509] [112/130] (415s left) api_intel_allocator (default-alignment)
[603.929549] Starting subtest: default-alignment
[603.932213] Subtest default-alignment: SUCCESS (0.004s)
[604.062668] [113/130] (415s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[604.449494] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[605.242495] [114/130] (414s left) kms_content_protection (type1)
[605.384777] Starting subtest: type1
[608.815217] Subtest type1: SKIP (3.428s)
[609.986412] [115/130] (409s left) kms_plane_lowres (tiling-x)
[610.083029] Starting subtest: tiling-x
[610.085367] Starting dynamic subtest: pipe-A-eDP-1
[610.089966] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[610.388500] Starting dynamic subtest: pipe-B-eDP-1
[610.393170] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[610.401889] Starting dynamic subtest: pipe-C-eDP-1
[610.406470] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[610.415030] Starting dynamic subtest: pipe-D-eDP-1
[610.419107] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[610.423113] Subtest tiling-x: SKIP (0.301s)
[611.228026] [116/130] (408s left) gem_exec_params (invalid-batch-start-offset)
[611.283499] Starting subtest: invalid-batch-start-offset
[611.288700] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[611.421531] [117/130] (408s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[611.528234] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[611.532162] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[611.640836] [118/130] (407s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[611.736657] Starting subtest: fbcpsr-tiling-y
[611.741103] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[611.843326] [119/130] (407s left) gem_exec_balancer (hog)
[611.904250] Starting subtest: hog
[611.908869] Subtest hog: SKIP (0.000s)
[612.202042] [120/130] (407s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[612.309078] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[613.398952] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.089s)
[613.550072] [121/130] (406s left) gem_exec_capture (pi)
[613.610481] Starting subtest: pi
[613.612187] Starting dynamic subtest: rcs0
[617.848610] Dynamic subtest rcs0: SUCCESS (4.239s)
[617.859156] Starting dynamic subtest: bcs0
[621.755600] Dynamic subtest bcs0: SUCCESS (3.904s)
[621.766974] Starting dynamic subtest: vcs0
[625.661840] Dynamic subtest vcs0: SUCCESS (3.905s)
[625.673633] Starting dynamic subtest: vcs1
[629.571468] Dynamic subtest vcs1: SUCCESS (3.907s)
[629.581482] Starting dynamic subtest: vecs0
[633.450249] Dynamic subtest vecs0: SUCCESS (3.876s)
[633.461926] Starting dynamic subtest: ccs0
[637.363115] Dynamic subtest ccs0: SUCCESS (3.911s)
[637.365461] Subtest pi: SUCCESS (23.750s)
[637.439292] [122/130] (382s left) gem_pwrite (basic-self)
[637.548671] Subtest basic-self: SKIP (0.000s)
[637.618003] [123/130] (382s left) kms_rotation_crc (primary-rotation-180)
[637.710938] Starting subtest: primary-rotation-180
[644.605958] Subtest primary-rotation-180: SUCCESS (6.892s)
[645.799878] [124/130] (373s left) gem_exec_whisper (basic-queues)
[645.870198] Starting subtest: basic-queues
[651.385847] Subtest basic-queues: SUCCESS (5.510s)
[651.564252] [125/130] (368s left) kms_flip (flip-vs-expired-vblank)
[651.665103] Starting subtest: flip-vs-expired-vblank
[651.667400] Starting dynamic subtest: A-eDP1
[660.420375] Dynamic subtest A-eDP1: SUCCESS (8.753s)
[660.431620] Starting dynamic subtest: B-eDP1
[669.060913] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[669.072331] Starting dynamic subtest: C-eDP1
[677.687569] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[677.698272] Starting dynamic subtest: D-eDP1
[686.333076] Dynamic subtest D-eDP1: SUCCESS (8.642s)
[686.336134] Subtest flip-vs-expired-vblank: SUCCESS (34.664s)
[687.505093] [126/130] (332s left) gem_eio (wait-wedge-immediate)
[687.731710] Starting subtest: wait-wedge-immediate
[689.463140] Subtest wait-wedge-immediate: SUCCESS (1.730s)
[689.590699] [127/130] (330s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[689.675064] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[689.677488] Starting dynamic subtest: pipe-A-eDP-1
[689.700357] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[689.711743] Starting dynamic subtest: pipe-B-eDP-1
[689.733243] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[689.743171] Starting dynamic subtest: pipe-C-eDP-1
[689.764231] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[689.774452] Starting dynamic subtest: pipe-D-eDP-1
[689.797538] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[689.801769] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[691.885614] [128/130] (328s left) kms_psr (pr-no-drrs)
[691.974701] Starting subtest: pr-no-drrs
[691.978570] Subtest pr-no-drrs: SKIP (0.000s)
[692.044299] [129/130] (327s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[692.145778] Starting subtest: y-tiled-8bpp-rotate-90
[692.149984] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[692.251442] [130/130] (327s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[692.352475] Starting subtest: fbcpsr-rgb565-draw-pwrite
[699.316393] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.965s)
[699.435884] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_spin_batch
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: i915_pm_rps
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_invalid_mode
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: prime_self_import
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: device_reset
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: gem_ctx_isolation
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_cursor_edge_walk
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_dp_link_training
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: core_auth
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_async_flips
results: parsing output: 57/ for test: gem_close_race
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_atomic_transition
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_dsc
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: gem_mmap_offset
results: parsing output: 83/ for test: kms_atomic_transition
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: i915_selftest
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_sequence
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_workarounds
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: prime_busy
results: parsing output: 93/ for test: gem_sync
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: gem_tiled_fence_blits
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: kms_plane_lowres
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_capture
results: parsing output: 121/ for test: gem_pwrite
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: gem_exec_whisper
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.