[57.002236] Initializing watchdogs
[57.002286]   /dev/watchdog0
[57.016259] [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]
[57.020626] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.023129] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.026335] [001/133] (960s left) i915_pm_rc6_residency (rc6-fence)
[57.110238] Starting subtest: rc6-fence
[57.130212] Starting dynamic subtest: gt0
[69.454900] Dynamic subtest gt0: SUCCESS (12.333s)
[69.466663] Starting dynamic subtest: gt1
[84.221113] Dynamic subtest gt1: SUCCESS (14.768s)
[84.224086] Subtest rc6-fence: SUCCESS (27.125s)
[84.290874] [002/133] (933s left) kms_chamelium_color (ctm-blue-to-red)
[84.396598] Subtest ctm-blue-to-red: SKIP (0.000s)
[84.440900] [003/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[84.526750] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[84.531051] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[84.605816] [004/133] (933s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[84.693711] Starting subtest: psr-rgb565-draw-pwrite
[91.629970] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.941s)
[91.729727] [005/133] (925s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[91.794693] Starting subtest: legacy-engines-hostile-preempt
[91.796978] Starting dynamic subtest: render
[91.882142] Dynamic subtest render: SUCCESS (0.086s)
[91.891746] Starting dynamic subtest: bsd1
[93.302180] Dynamic subtest bsd1: SUCCESS (1.418s)
[93.311654] Starting dynamic subtest: bsd2
[95.287358] Dynamic subtest bsd2: SUCCESS (1.983s)
[95.296872] Starting dynamic subtest: blt
[95.340957] Dynamic subtest blt: SUCCESS (0.053s)
[95.348722] Starting dynamic subtest: vebox
[97.281303] Dynamic subtest vebox: SUCCESS (1.938s)
[97.284034] Subtest legacy-engines-hostile-preempt: SUCCESS (5.486s)
[97.360673] [006/133] (920s left) gem_exec_whisper (basic-contexts)
[97.433488] Starting subtest: basic-contexts
[104.265817] Subtest basic-contexts: SUCCESS (6.833s)
[104.448012] [007/133] (913s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[104.553628] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[104.558406] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[105.724656] [008/133] (912s left) kms_flip (2x-flip-vs-fences-interruptible)
[105.817233] Starting subtest: 2x-flip-vs-fences-interruptible
[105.821236] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[105.890711] [009/133] (911s left) gem_exec_schedule (u-independent)
[105.971589] Starting subtest: u-independent
[105.973960] Starting dynamic subtest: rcs0
[107.263563] Dynamic subtest rcs0: SUCCESS (1.300s)
[107.275286] Starting dynamic subtest: vcs0
[109.320788] Dynamic subtest vcs0: SUCCESS (2.056s)
[109.332209] Starting dynamic subtest: vcs1
[111.308060] Dynamic subtest vcs1: SUCCESS (1.986s)
[111.318962] Starting dynamic subtest: vecs0
[113.288890] Dynamic subtest vecs0: SUCCESS (1.980s)
[113.300247] Starting dynamic subtest: ccs0
[115.261625] Dynamic subtest ccs0: SUCCESS (1.971s)
[115.264401] Subtest u-independent: SUCCESS (9.299s)
[115.561841] [010/133] (902s left) kms_atomic_transition (plane-toggle-modeset-transition)
[115.675166] Starting subtest: plane-toggle-modeset-transition
[115.677488] Starting dynamic subtest: pipe-A-eDP-1
[128.341688] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.665s)
[128.353081] Starting dynamic subtest: pipe-B-eDP-1
[140.788073] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.445s)
[140.790718] Subtest plane-toggle-modeset-transition: SUCCESS (25.115s)
[141.634927] [011/133] (876s left) gem_tiling_max_stride
[141.787653] [012/133] (876s left) kms_pm_rpm (dpms-non-lpsp)
[143.347981] Starting subtest: dpms-non-lpsp
[143.353234] Subtest dpms-non-lpsp: SKIP (0.001s)
[144.051527] [013/133] (874s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[144.163061] Starting subtest: fbc-1p-pri-indfb-multidraw
[157.013041] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.855s)
[158.381027] [014/133] (859s left) gem_exec_params (rs-invalid)
[158.447804] Starting subtest: rs-invalid
[158.452567] Subtest rs-invalid: SUCCESS (0.006s)
[158.575636] [015/133] (859s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[158.985344] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[159.787093] [016/133] (858s left) gen3_render_tiledy_blits
[159.913711] [017/133] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[160.004916] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[160.009402] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[160.099314] [018/133] (858s left) kms_color_pipeline (plane-lut1d)
[160.189476] Starting subtest: plane-lut1d
[160.315385] Starting dynamic subtest: pipe-A-plane-0
[160.459556] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[160.469619] Starting dynamic subtest: pipe-A-plane-1
[160.592774] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[160.602886] Starting dynamic subtest: pipe-A-plane-2
[160.738150] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[161.893070] Starting dynamic subtest: pipe-B-plane-0
[162.030139] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[162.040025] Starting dynamic subtest: pipe-B-plane-1
[162.162971] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[162.171688] Starting dynamic subtest: pipe-B-plane-2
[162.296700] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[163.531193] Starting dynamic subtest: pipe-C-plane-0
[163.668140] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[163.679213] Starting dynamic subtest: pipe-C-plane-1
[163.823810] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[163.832156] Starting dynamic subtest: pipe-C-plane-2
[163.968978] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[165.155121] Starting dynamic subtest: pipe-D-plane-0
[165.282473] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[165.291122] Starting dynamic subtest: pipe-D-plane-1
[165.415691] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[165.425273] Starting dynamic subtest: pipe-D-plane-2
[165.549427] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[165.834898] Subtest plane-lut1d: SUCCESS (5.643s)
[166.633306] [019/133] (851s left) kms_psr (psr-sprite-render)
[166.721232] Starting subtest: psr-sprite-render
[166.723647] Starting dynamic subtest: eDP-1
[168.461068] Dynamic subtest eDP-1: SUCCESS (1.739s)
[168.463356] Subtest psr-sprite-render: SUCCESS (1.740s)
[169.287125] [020/133] (849s left) gem_exec_schedule (preempt)
[169.351482] Starting subtest: preempt
[169.353485] Starting dynamic subtest: rcs0
[169.367648] Dynamic subtest rcs0: SUCCESS (0.024s)
[169.380187] Starting dynamic subtest: bcs0
[169.395792] Dynamic subtest bcs0: SUCCESS (0.027s)
[169.407073] Starting dynamic subtest: vcs0
[169.415698] Dynamic subtest vcs0: SUCCESS (0.019s)
[169.424039] Starting dynamic subtest: vcs1
[169.435240] Dynamic subtest vcs1: SUCCESS (0.019s)
[169.443548] Starting dynamic subtest: vecs0
[169.455288] Dynamic subtest vecs0: SUCCESS (0.020s)
[169.463600] Starting dynamic subtest: ccs0
[169.474705] Dynamic subtest ccs0: SUCCESS (0.019s)
[169.476993] Subtest preempt: SUCCESS (0.131s)
[171.345097] [021/133] (847s left) gem_exec_reloc (basic-wc-active)
[171.413601] Subtest basic-wc-active: SKIP (0.000s)
[171.485051] [022/133] (846s left) gem_barrier_race (remote-request)
[171.545806] Starting subtest: remote-request
[171.548081] Starting dynamic subtest: rcs0
[176.743583] Dynamic subtest rcs0: SUCCESS (5.198s)
[176.746568] Subtest remote-request: SUCCESS (5.199s)
[176.883769] [023/133] (841s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[176.983517] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[176.987302] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[177.077776] [024/133] (841s left) syncobj_timeline (wait-all-for-submit-snapshot)
[177.138360] Starting subtest: wait-all-for-submit-snapshot
[177.219486] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[177.304826] [025/133] (841s left) gem_mmap_gtt (hang)
[177.350930] Subtest hang: SKIP (0.000s)
[177.418809] [026/133] (841s left) kms_force_connector_basic (force-connector-state)
[177.494275] Starting subtest: force-connector-state
[178.120197] Subtest force-connector-state: SUCCESS (0.626s)
[179.044733] [027/133] (839s left) perf_pmu (most-busy-check-all)
[179.087918] Starting subtest: most-busy-check-all
[179.090267] Starting dynamic subtest: rcs0
[180.286362] Dynamic subtest rcs0: SUCCESS (1.199s)
[180.295838] Starting dynamic subtest: bcs0
[182.269079] Dynamic subtest bcs0: SUCCESS (1.981s)
[182.280865] Starting dynamic subtest: vcs0
[184.252801] Dynamic subtest vcs0: SUCCESS (1.982s)
[184.264287] Starting dynamic subtest: vcs1
[186.302046] Dynamic subtest vcs1: SUCCESS (2.047s)
[186.313375] Starting dynamic subtest: vecs0
[188.285690] Dynamic subtest vecs0: SUCCESS (1.981s)
[188.297259] Starting dynamic subtest: ccs0
[190.269924] Dynamic subtest ccs0: SUCCESS (1.982s)
[190.272872] Subtest most-busy-check-all: SUCCESS (11.184s)
[190.365323] [028/133] (828s left) sw_sync (sync_merge_same)
[190.400795] Starting subtest: sync_merge_same
[190.403062] Subtest sync_merge_same: SUCCESS (0.000s)
[190.449354] [029/133] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[190.546674] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[196.941189] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.399s)
[197.075061] [030/133] (821s left) gem_vm_create (execbuf)
[197.129876] Starting subtest: execbuf
[197.134272] Subtest execbuf: SUCCESS (0.007s)
[197.242346] [031/133] (821s left) gem_exec_flush (basic-uc-ro-default)
[197.310413] Starting subtest: basic-uc-ro-default
[202.763490] Subtest basic-uc-ro-default: SUCCESS (5.454s)
[202.953372] [032/133] (815s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[203.084229] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[204.043835] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.959s)
[204.929108] [033/133] (813s left) kms_addfb_basic (legacy-format)
[204.989359] Starting subtest: legacy-format
[205.015117] Subtest legacy-format: SUCCESS (0.023s)
[205.158755] [034/133] (813s left) kms_plane (pixel-format-x-tiled-modifier)
[205.241878] Starting subtest: pixel-format-x-tiled-modifier
[205.269064] Starting dynamic subtest: pipe-A-plane-0
[205.923975] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[205.935196] Starting dynamic subtest: pipe-A-plane-3
[206.324037] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[206.332534] Starting dynamic subtest: pipe-A-plane-5
[206.336070] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[207.389507] Starting dynamic subtest: pipe-B-plane-0
[208.010488] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[208.018667] Starting dynamic subtest: pipe-B-plane-3
[208.410108] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[208.418711] Starting dynamic subtest: pipe-B-plane-5
[208.422068] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[208.730542] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.490s)
[209.522826] [035/133] (809s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[209.624342] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[209.628670] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[209.697295] [036/133] (809s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[209.792394] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[217.041887] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.251s)
[217.172207] [037/133] (801s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[217.289899] Starting subtest: cursorA-vs-flipB-legacy
[217.294448] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[217.432508] [038/133] (801s left) kms_big_fb (linear-64bpp-rotate-270)
[217.530863] Starting subtest: linear-64bpp-rotate-270
[217.550063] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[217.663458] [039/133] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[217.753154] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[217.757129] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.832271] [040/133] (801s left) gem_exec_reloc (basic-range-active)
[217.887568] Subtest basic-range-active: SKIP (0.000s)
[217.952706] [041/133] (801s left) kms_chamelium_frames (dp-crc-fast)
[218.349080] Subtest dp-crc-fast: SKIP (0.000s)
[219.126801] [042/133] (800s left) kms_vrr (flip-basic)
[219.214374] Starting subtest: flip-basic
[219.220585] Subtest flip-basic: SKIP (0.000s)
[219.281825] [043/133] (799s left) gem_exec_balancer (bonded-semaphore)
[219.348650] Starting subtest: bonded-semaphore
[219.353136] Subtest bonded-semaphore: SKIP (0.000s)
[219.642323] [044/133] (799s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[219.693075] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[219.801046] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[219.879064] [045/133] (799s left) gem_workarounds (suspend-resume-context)
[219.944696] Starting subtest: suspend-resume-context
[235.720778] Subtest suspend-resume-context: SUCCESS (2.029s)
[235.860070] [046/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[235.960105] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[235.964550] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[236.041888] [047/133] (783s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[236.128086] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[236.130470] Starting dynamic subtest: pipe-A-eDP-1
[236.264768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.131s)
[236.276597] Starting dynamic subtest: pipe-B-eDP-1
[236.296666] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[236.305895] Starting dynamic subtest: pipe-C-eDP-1
[236.325369] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[236.334708] Starting dynamic subtest: pipe-D-eDP-1
[236.354217] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[236.356489] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.140s)
[238.535653] [048/133] (780s left) kms_pm_rpm (legacy-planes)
[240.156941] Starting subtest: legacy-planes
[240.159428] Starting dynamic subtest: plane-65
[248.454516] Dynamic subtest plane-65: SUCCESS (8.310s)
[248.467042] Starting dynamic subtest: plane-95
[256.764085] Dynamic subtest plane-95: SUCCESS (8.313s)
[256.776100] Starting dynamic subtest: plane-125
[265.056074] Dynamic subtest plane-125: SUCCESS (8.292s)
[265.068535] Starting dynamic subtest: plane-135
[273.381093] Dynamic subtest plane-135: SUCCESS (8.326s)
[273.383596] Subtest legacy-planes: SUCCESS (33.251s)
[273.760696] [049/133] (745s left) perf_pmu (rc6)
[273.801053] Starting subtest: rc6
[273.803097] Starting dynamic subtest: gt0
[280.155937] Dynamic subtest gt0: SUCCESS (6.356s)
[280.168328] Starting dynamic subtest: runtime-pm-gt0
[287.921462] Dynamic subtest runtime-pm-gt0: SUCCESS (7.766s)
[287.933756] Starting dynamic subtest: runtime-pm-long-gt0
[300.358018] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.439s)
[300.370517] Starting dynamic subtest: other-idle-gt0
[306.700530] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[306.712565] Starting dynamic subtest: gt1
[313.044416] Dynamic subtest gt1: SUCCESS (6.342s)
[313.056712] Starting dynamic subtest: runtime-pm-gt1
[320.545466] Dynamic subtest runtime-pm-gt1: SUCCESS (7.500s)
[320.557741] Starting dynamic subtest: runtime-pm-long-gt1
[332.993009] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.447s)
[333.006138] Starting dynamic subtest: other-idle-gt1
[339.339287] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[339.342420] Subtest rc6: SUCCESS (65.552s)
[340.509714] [050/133] (678s left) gem_pread (bench)
[340.564843] Subtest bench: SKIP (0.000s)
[340.631714] [051/133] (678s left) gem_userptr_blits (create-destroy-sync)
[340.685818] Starting subtest: create-destroy-sync
[345.699391] Subtest create-destroy-sync: SUCCESS (5.011s)
[345.789413] [052/133] (673s left) perf_pmu (busy)
[345.832799] Starting subtest: busy
[345.835064] Starting dynamic subtest: rcs0
[346.413259] Dynamic subtest rcs0: SUCCESS (0.582s)
[346.425216] Starting dynamic subtest: bcs0
[346.977158] Dynamic subtest bcs0: SUCCESS (0.562s)
[346.989076] Starting dynamic subtest: vcs0
[349.042573] Dynamic subtest vcs0: SUCCESS (2.061s)
[349.053825] Starting dynamic subtest: vcs1
[351.026069] Dynamic subtest vcs1: SUCCESS (1.980s)
[351.038728] Starting dynamic subtest: vecs0
[353.011147] Dynamic subtest vecs0: SUCCESS (1.981s)
[353.024064] Starting dynamic subtest: ccs0
[353.586571] Dynamic subtest ccs0: SUCCESS (0.572s)
[353.591565] Subtest busy: SUCCESS (7.752s)
[353.671137] [053/133] (665s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[353.781741] Starting subtest: psr-farfromfence-mmap-gtt
[353.786064] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[353.854292] [054/133] (665s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[353.936337] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[353.938660] Starting dynamic subtest: pipe-A
[353.998599] Dynamic subtest pipe-A: SUCCESS (0.064s)
[354.009863] Starting dynamic subtest: pipe-B
[355.185096] Dynamic subtest pipe-B: SUCCESS (1.185s)
[355.196381] Starting dynamic subtest: pipe-C
[356.364573] Dynamic subtest pipe-C: SUCCESS (1.178s)
[356.374002] Starting dynamic subtest: pipe-D
[357.455638] Dynamic subtest pipe-D: SUCCESS (1.090s)
[357.457808] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.521s)
[358.578847] [055/133] (661s left) prime_vgem (shrink)
[358.697015] Starting subtest: shrink
[358.711689] Subtest shrink: SUCCESS (0.012s)
[358.792021] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[358.795289] [056/133] (660s left) kms_cursor_crc (cursor-onscreen-256x85)
[359.043300] Starting subtest: cursor-onscreen-256x85
[359.089673] Subtest cursor-onscreen-256x85: SKIP (0.041s)
[359.250543] [057/133] (660s left) dmabuf_sync_file (export-multiwait)
[359.299803] Starting subtest: export-multiwait
[359.301737] Subtest export-multiwait: SUCCESS (0.001s)
[359.343305] [058/133] (660s left) i915_drm_fdinfo (idle)
[359.381971] Starting subtest: idle
[359.384129] Starting dynamic subtest: rcs0
[359.958803] Dynamic subtest rcs0: SUCCESS (0.579s)
[359.973643] Starting dynamic subtest: bcs0
[360.466927] Dynamic subtest bcs0: SUCCESS (0.503s)
[360.479198] Starting dynamic subtest: vcs0
[360.971936] Dynamic subtest vcs0: SUCCESS (0.502s)
[360.985673] Starting dynamic subtest: vcs1
[361.476760] Dynamic subtest vcs1: SUCCESS (0.503s)
[361.489197] Starting dynamic subtest: vecs0
[361.983707] Dynamic subtest vecs0: SUCCESS (0.503s)
[361.995935] Starting dynamic subtest: ccs0
[362.490578] Dynamic subtest ccs0: SUCCESS (0.503s)
[362.493291] Subtest idle: SUCCESS (3.111s)
[362.547991] [059/133] (657s left) syncobj_wait (wait-all-interrupted)
[362.600237] Starting subtest: wait-all-interrupted
[362.701874] Subtest wait-all-interrupted: SUCCESS (0.102s)
[362.756554] [060/133] (657s left) sw_sync (alloc_merge_fence)
[362.792564] Starting subtest: alloc_merge_fence
[362.794873] Subtest alloc_merge_fence: SUCCESS (0.000s)
[362.835476] [061/133] (657s left) gem_spin_batch (legacy-resubmit)
[362.901168] Starting subtest: legacy-resubmit
[362.904052] Starting dynamic subtest: default
[362.912118] Dynamic subtest default: SUCCESS (0.010s)
[362.923260] Starting dynamic subtest: render
[362.925114] Dynamic subtest render: SUCCESS (0.002s)
[362.934867] Starting dynamic subtest: bsd
[362.937005] Dynamic subtest bsd: SUCCESS (0.004s)
[362.945878] Starting dynamic subtest: bsd1
[362.948019] Dynamic subtest bsd1: SUCCESS (0.001s)
[362.957060] Starting dynamic subtest: bsd2
[362.959141] Dynamic subtest bsd2: SUCCESS (0.003s)
[362.967812] Starting dynamic subtest: blt
[362.969909] Dynamic subtest blt: SUCCESS (0.005s)
[362.978578] Starting dynamic subtest: vebox
[362.980723] Dynamic subtest vebox: SUCCESS (0.004s)
[362.982887] Subtest legacy-resubmit: SUCCESS (0.035s)
[363.127223] [062/133] (656s left) kms_frontbuffer_tracking (fbc-stridechange)
[363.239485] Starting subtest: fbc-stridechange
[366.521416] Subtest fbc-stridechange: SUCCESS (3.282s)
[367.671644] [063/133] (652s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[367.770829] Starting subtest: y-tiled-32bpp-rotate-180
[367.774826] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[367.836141] [064/133] (652s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[367.930267] Starting subtest: 4-tiled-addfb-size-offset-overflow
[367.932889] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[368.000161] [065/133] (652s left) kms_psr (fbc-psr2-sprite-blt)
[368.092590] Starting subtest: fbc-psr2-sprite-blt
[368.094879] Starting dynamic subtest: eDP-1
[368.099208] Dynamic subtest eDP-1: SKIP (0.000s)
[368.103621] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[368.143479] [066/133] (651s left) kms_busy (extended-pageflip-hang-oldfb)
[368.243861] Starting subtest: extended-pageflip-hang-oldfb
[368.245815] Starting dynamic subtest: pipe-A
[368.673079] Dynamic subtest pipe-A: SUCCESS (0.430s)
[368.682401] Starting dynamic subtest: pipe-D
[369.777042] Dynamic subtest pipe-D: SUCCESS (1.101s)
[369.779447] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.535s)
[370.569405] [067/133] (649s left) kms_flip (flip-vs-suspend)
[370.661538] Starting subtest: flip-vs-suspend
[370.663918] Starting dynamic subtest: A-eDP1
[515.722987] Dynamic subtest A-eDP1: SUCCESS (11.238s)
[515.725322] Subtest flip-vs-suspend: SUCCESS (11.241s)
[515.857865] [068/133] (504s left) prime_vgem (basic-gtt)
[515.942341] Starting subtest: basic-gtt
[515.946760] Subtest basic-gtt: SKIP (0.000s)
[516.039372] [069/133] (504s left) kms_psr (fbc-psr-sprite-render)
[516.141162] Starting subtest: fbc-psr-sprite-render
[516.143510] Starting dynamic subtest: eDP-1
[516.147893] Dynamic subtest eDP-1: SKIP (0.000s)
[516.152213] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[516.194138] [070/133] (504s left) kms_invalid_mode (int-max-clock)
[516.290245] Starting subtest: int-max-clock
[516.292602] Starting dynamic subtest: pipe-A-eDP-1
[516.579535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[516.589548] Starting dynamic subtest: pipe-B-eDP-1
[516.591861] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[516.600864] Starting dynamic subtest: pipe-C-eDP-1
[516.603129] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[516.612125] Starting dynamic subtest: pipe-D-eDP-1
[516.614345] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[516.616674] Subtest int-max-clock: SUCCESS (0.295s)
[517.394645] [071/133] (502s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[517.493146] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[518.261900] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.770s)
[518.425025] [072/133] (501s left) syncobj_wait (invalid-single-wait-unsubmitted)
[518.489859] Starting subtest: invalid-single-wait-unsubmitted
[518.492233] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[518.574260] [073/133] (501s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[518.687173] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[518.691292] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[518.776881] [074/133] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[518.886687] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[518.891179] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[518.958106] [075/133] (501s left) kms_psr (fbc-pr-cursor-plane-move)
[519.050473] Starting subtest: fbc-pr-cursor-plane-move
[519.054928] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[519.100546] [076/133] (501s left) kms_plane_multiple (2x-tiling-4)
[519.182519] Starting subtest: 2x-tiling-4
[519.186003] Subtest 2x-tiling-4: SKIP (0.000s)
[519.233625] [077/133] (501s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[519.325178] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[523.466283] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.143s)
[524.601659] [078/133] (496s left) kms_pipe_crc_basic (hang-read-crc)
[524.702181] Starting subtest: hang-read-crc
[524.704529] Starting dynamic subtest: pipe-A-eDP-1
[526.774455] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.071s)
[526.784896] Starting dynamic subtest: pipe-B-eDP-1
[529.549594] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.775s)
[529.560468] Starting dynamic subtest: pipe-C-eDP-1
[532.209330] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.658s)
[532.222717] Starting dynamic subtest: pipe-D-eDP-1
[534.795301] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.583s)
[534.797702] Subtest hang-read-crc: SUCCESS (10.093s)
[535.592247] [079/133] (485s left) gem_media_fill (media-fill)
[535.659996] Subtest media-fill: SKIP (0.000s)
[535.730725] [080/133] (485s left) kms_getfb (getfb-repeated-different-handles)
[535.832099] Starting subtest: getfb-repeated-different-handles
[535.834306] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[535.908322] [081/133] (484s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[535.999489] Starting subtest: pr-cursor-plane-update-sf
[536.003751] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[536.043097] [082/133] (484s left) gem_exec_reloc (basic-wc-cpu-active)
[536.103855] Subtest basic-wc-cpu-active: SKIP (0.000s)
[536.182073] [083/133] (484s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[536.258313] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[536.262506] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[536.420019] [084/133] (484s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[536.481182] Starting subtest: invalid-multi-wait-all-unsubmitted
[536.483537] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[536.555614] [085/133] (484s left) gem_exec_reloc (basic-write-gtt-active)
[536.607870] Subtest basic-write-gtt-active: SKIP (0.000s)
[536.688043] [086/133] (484s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[536.781662] Starting subtest: psr-rgb101010-draw-pwrite
[544.367865] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.589s)
[544.471233] [087/133] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[544.564174] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[544.568471] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[544.626028] [088/133] (476s left) gem_ctx_shared (q-in-order)
[544.693498] Starting subtest: Q-in-order
[544.695939] Starting dynamic subtest: rcs0
[544.799659] Dynamic subtest rcs0: SUCCESS (0.105s)
[544.818569] Starting dynamic subtest: vcs0
[544.882465] Dynamic subtest vcs0: SUCCESS (0.082s)
[544.900485] Starting dynamic subtest: vcs1
[544.966356] Dynamic subtest vcs1: SUCCESS (0.082s)
[544.983444] Starting dynamic subtest: vecs0
[545.072063] Dynamic subtest vecs0: SUCCESS (0.105s)
[545.089043] Starting dynamic subtest: ccs0
[545.160552] Dynamic subtest ccs0: SUCCESS (0.088s)
[545.163127] Subtest Q-in-order: SUCCESS (0.467s)
[546.936979] [089/133] (474s left) gem_exec_reloc (basic-write-read-noreloc)
[547.002688] Subtest basic-write-read-noreloc: SKIP (0.000s)
[547.080426] [090/133] (474s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[547.631412] Starting subtest: syncobj-stationary-timeline-chain-engines
[547.830559] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.199s)
[548.920274] [091/133] (472s left) kms_psr (fbc-psr-no-drrs)
[549.024709] Starting subtest: fbc-psr-no-drrs
[549.026897] Starting dynamic subtest: eDP-1
[549.030911] Dynamic subtest eDP-1: SKIP (0.000s)
[549.034988] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[549.075878] [092/133] (472s left) kms_flip (flip-vs-panning-vs-hang)
[549.164649] Starting subtest: flip-vs-panning-vs-hang
[549.166973] Starting dynamic subtest: A-eDP1
[600.348174] Dynamic subtest A-eDP1: SUCCESS (51.195s)
[600.363990] Starting dynamic subtest: D-eDP1
[640.350759] Dynamic subtest D-eDP1: SUCCESS (40.008s)
[640.356540] Subtest flip-vs-panning-vs-hang: SUCCESS (91.210s)
[641.560243] [093/133] (379s left) kms_draw_crc (draw-method-pwrite)
[641.658055] Starting subtest: draw-method-pwrite
[641.659994] Starting dynamic subtest: xrgb8888-untiled
[642.245239] Dynamic subtest xrgb8888-untiled: SUCCESS (0.589s)
[642.256221] Starting dynamic subtest: rgb565-untiled
[642.667209] Dynamic subtest rgb565-untiled: SUCCESS (0.422s)
[642.677579] Starting dynamic subtest: xrgb2101010-untiled
[643.211773] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[643.225395] Starting dynamic subtest: xbgr16161616f-untiled
[644.067245] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.853s)
[644.080408] Starting dynamic subtest: xrgb8888-xtiled
[645.800702] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.733s)
[645.819516] Starting dynamic subtest: rgb565-xtiled
[646.833306] Dynamic subtest rgb565-xtiled: SUCCESS (1.032s)
[646.843698] Starting dynamic subtest: xrgb2101010-xtiled
[648.533109] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.699s)
[648.543463] Starting dynamic subtest: xbgr16161616f-xtiled
[651.734111] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.199s)
[651.754935] Starting dynamic subtest: xrgb8888-4tiled
[652.811483] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.077s)
[652.821347] Starting dynamic subtest: rgb565-4tiled
[653.354244] Dynamic subtest rgb565-4tiled: SUCCESS (0.541s)
[653.363959] Starting dynamic subtest: xrgb2101010-4tiled
[654.431986] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.077s)
[654.442427] Starting dynamic subtest: xbgr16161616f-4tiled
[657.320963] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.888s)
[657.323311] Subtest draw-method-pwrite: SUCCESS (15.668s)
[657.406125] [094/133] (363s left) gen9_exec_parse (bb-start-cmd)
[657.465942] Subtest bb-start-cmd: SKIP (0.000s)
[657.564759] [095/133] (363s left) kms_flip (plain-flip-fb-recreate)
[657.666070] Starting subtest: plain-flip-fb-recreate
[657.668193] Starting dynamic subtest: A-eDP1
[666.540195] Dynamic subtest A-eDP1: SUCCESS (8.875s)
[666.552768] Starting dynamic subtest: B-eDP1
[675.446301] Dynamic subtest B-eDP1: SUCCESS (8.905s)
[675.460322] Starting dynamic subtest: C-eDP1
[684.326680] Dynamic subtest C-eDP1: SUCCESS (8.879s)
[684.336864] Starting dynamic subtest: D-eDP1
[693.219432] Dynamic subtest D-eDP1: SUCCESS (8.893s)
[693.224494] Subtest plain-flip-fb-recreate: SUCCESS (35.567s)
[694.394197] [096/133] (327s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[694.490130] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[694.494038] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[694.565814] [097/133] (326s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[694.668212] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[701.407908] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.744s)
[701.525099] [098/133] (320s left) gem_mmap_gtt (isolation)
[701.580531] Subtest isolation: SKIP (0.000s)
[701.648946] [099/133] (319s left) api_intel_bb (destroy-bb)
[701.722553] Starting subtest: destroy-bb
[701.731579] Subtest destroy-bb: SUCCESS (0.009s)
[701.826742] [100/133] (319s left) gem_exec_balancer (parallel-ordering)
[702.080322] Starting subtest: parallel-ordering
[703.022850] Subtest parallel-ordering: SUCCESS (0.942s)
[703.119408] [101/133] (318s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[703.239280] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[703.241607] Starting dynamic subtest: pipe-A-eDP-1
[703.300972] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[703.312709] Starting dynamic subtest: pipe-B-eDP-1
[703.369884] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[703.383066] Starting dynamic subtest: pipe-C-eDP-1
[703.440965] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[703.451873] Starting dynamic subtest: pipe-D-eDP-1
[703.509894] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[703.514473] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[705.439311] [102/133] (316s left) kms_setmode (invalid-clone-single-crtc)
[705.501785] Starting subtest: invalid-clone-single-crtc
[705.508614] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[705.575573] [103/133] (316s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[705.679838] Starting subtest: 4-tiled-16bpp-rotate-0
[706.946036] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.267s)
[707.040419] [104/133] (314s left) syncobj_wait (wait-all-for-submit-snapshot)
[707.099304] Starting subtest: wait-all-for-submit-snapshot
[707.179770] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[707.234141] [105/133] (314s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[707.319661] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[707.323548] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[708.434515] [106/133] (313s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[708.532078] Starting subtest: fb-8bpc-vs-panel-6bpc
[708.534466] Starting dynamic subtest: pipe-A-eDP-1
[709.901487] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.369s)
[709.903442] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.370s)
[710.740336] [107/133] (311s left) kms_plane (plane-position-covered)
[710.823927] Starting subtest: plane-position-covered
[711.326103] Starting dynamic subtest: pipe-A-plane-1
[712.588467] Dynamic subtest pipe-A-plane-1: SUCCESS (1.261s)
[712.599738] Starting dynamic subtest: pipe-A-plane-2
[713.877501] Dynamic subtest pipe-A-plane-2: SUCCESS (1.290s)
[713.888711] Starting dynamic subtest: pipe-A-plane-3
[715.197160] Dynamic subtest pipe-A-plane-3: SUCCESS (1.320s)
[715.209292] Starting dynamic subtest: pipe-A-plane-4
[716.497316] Dynamic subtest pipe-A-plane-4: SUCCESS (1.300s)
[716.509639] Starting dynamic subtest: pipe-A-plane-5
[716.527137] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[717.706800] Starting dynamic subtest: pipe-B-plane-1
[719.003177] Dynamic subtest pipe-B-plane-1: SUCCESS (1.304s)
[719.013150] Starting dynamic subtest: pipe-B-plane-2
[720.283391] Dynamic subtest pipe-B-plane-2: SUCCESS (1.280s)
[720.293372] Starting dynamic subtest: pipe-B-plane-3
[721.583881] Dynamic subtest pipe-B-plane-3: SUCCESS (1.299s)
[721.594826] Starting dynamic subtest: pipe-B-plane-4
[722.873731] Dynamic subtest pipe-B-plane-4: SUCCESS (1.289s)
[722.883856] Starting dynamic subtest: pipe-B-plane-5
[722.897230] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[722.899493] Subtest plane-position-covered: SUCCESS (12.077s)
[723.741657] [108/133] (298s left) kms_cursor_crc (cursor-sliding-256x85)
[724.006478] Starting subtest: cursor-sliding-256x85
[724.051000] Subtest cursor-sliding-256x85: SKIP (0.042s)
[724.219206] [109/133] (297s left) gem_pipe_control_store_loop (fresh-buffer)
[724.290488] Starting subtest: fresh-buffer
[726.442171] Subtest fresh-buffer: SUCCESS (2.151s)
[726.528530] [110/133] (295s left) api_intel_allocator (reloc-allocator)
[726.577739] Starting subtest: reloc-allocator
[726.579850] Starting dynamic subtest: basic
[726.582087] Dynamic subtest basic: SUCCESS (0.004s)
[726.599323] Starting dynamic subtest: parallel-one
[726.601453] Dynamic subtest parallel-one: SUCCESS (0.007s)
[726.612563] Starting dynamic subtest: print
[726.614418] Dynamic subtest print: SUCCESS (0.000s)
[726.623541] Starting dynamic subtest: reuse
[726.625392] Dynamic subtest reuse: SUCCESS (0.000s)
[726.635890] Starting dynamic subtest: fork-reopen-allocator
[726.637729] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[726.639531] Subtest reloc-allocator: SUCCESS (0.027s)
[726.698972] [111/133] (295s left) gem_ctx_engines (none)
[726.765382] Starting subtest: none
[726.767606] Subtest none: SUCCESS (0.001s)
[726.929708] [112/133] (295s left) syncobj_timeline (invalid-query-zero-handles)
[726.985883] Starting subtest: invalid-query-zero-handles
[726.988557] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[727.056383] [113/133] (295s left) gem_pxp (regular-baseline-src-copy-readible)
[727.171662] Starting subtest: regular-baseline-src-copy-readible
[727.234767] Subtest regular-baseline-src-copy-readible: SUCCESS (0.067s)
[727.322911] [114/133] (294s left) i915_selftest (live)
[730.623368] Starting subtest: live
[730.626044] Starting dynamic subtest: sanitycheck
[734.904265] Dynamic subtest sanitycheck: SUCCESS (4.282s)
[734.918462] Starting dynamic subtest: uncore
[739.222598] Dynamic subtest uncore: SUCCESS (4.317s)
[739.232761] Starting dynamic subtest: workarounds
[742.230869] Dynamic subtest workarounds: SUCCESS (3.008s)
[742.240337] Starting dynamic subtest: gt_engines
[746.797114] Dynamic subtest gt_engines: SUCCESS (4.566s)
[746.812527] Starting dynamic subtest: gt_timelines
[764.477001] Dynamic subtest gt_timelines: SUCCESS (17.681s)
[764.487783] Starting dynamic subtest: gt_contexts
[768.804092] Dynamic subtest gt_contexts: SUCCESS (4.327s)
[768.814227] Starting dynamic subtest: gt_lrc
[774.873872] Dynamic subtest gt_lrc: SUCCESS (6.069s)
[774.884223] Starting dynamic subtest: gt_mocs
[777.786581] Dynamic subtest gt_mocs: SUCCESS (2.910s)
[777.796854] Starting dynamic subtest: gt_pm
[784.544548] Dynamic subtest gt_pm: SUCCESS (6.758s)
[784.554591] Starting dynamic subtest: gt_heartbeat
[788.927830] Dynamic subtest gt_heartbeat: SUCCESS (4.383s)
[788.937612] Starting dynamic subtest: gt_tlb
[798.187506] Dynamic subtest gt_tlb: SUCCESS (9.261s)
[798.197282] Starting dynamic subtest: requests
[809.519844] Dynamic subtest requests: SUCCESS (11.333s)
[809.530192] Starting dynamic subtest: migrate
[817.254234] Dynamic subtest migrate: SUCCESS (7.734s)
[817.264495] Starting dynamic subtest: active
[821.546747] Dynamic subtest active: SUCCESS (4.291s)
[821.557295] Starting dynamic subtest: objects
[826.240778] Dynamic subtest objects: SUCCESS (4.692s)
[826.253906] Starting dynamic subtest: mman
[830.937393] Dynamic subtest mman: SUCCESS (4.697s)
[830.947374] Starting dynamic subtest: dmabuf
[833.708192] Dynamic subtest dmabuf: SUCCESS (2.760s)
[833.719993] Starting dynamic subtest: vma
[837.964229] Dynamic subtest vma: SUCCESS (4.264s)
[837.980047] Starting dynamic subtest: coherency
[843.865384] Dynamic subtest coherency: SUCCESS (5.900s)
[843.875696] Starting dynamic subtest: gtt
[855.824317] Dynamic subtest gtt: SUCCESS (11.959s)
[855.833032] Starting dynamic subtest: gem
[863.513159] Dynamic subtest gem: SUCCESS (7.689s)
[863.523838] Starting dynamic subtest: evict
[867.423246] Dynamic subtest evict: SUCCESS (3.910s)
[867.432706] Starting dynamic subtest: hugepages
[878.145271] Dynamic subtest hugepages: SUCCESS (10.722s)
[878.160554] Starting dynamic subtest: gem_contexts
[905.112444] Dynamic subtest gem_contexts: SUCCESS (26.970s)
[905.122449] Starting dynamic subtest: client
[909.429085] Dynamic subtest client: SUCCESS (4.317s)
[909.445479] Starting dynamic subtest: gem_migrate
[913.780768] Dynamic subtest gem_migrate: SUCCESS (4.350s)
[913.790859] Starting dynamic subtest: reset
[918.412824] Dynamic subtest reset: SUCCESS (4.631s)
[918.423693] Starting dynamic subtest: memory_region
[922.753000] Dynamic subtest memory_region: SUCCESS (4.340s)
[922.763707] Starting dynamic subtest: hangcheck
[935.849894] Dynamic subtest hangcheck: SUCCESS (13.097s)
[935.859871] Starting dynamic subtest: execlists
[940.134398] Dynamic subtest execlists: SUCCESS (4.283s)
[940.146292] Starting dynamic subtest: ring_submission
[944.462271] Dynamic subtest ring_submission: SUCCESS (4.326s)
[944.475433] Starting dynamic subtest: perf
[948.793019] Dynamic subtest perf: SUCCESS (4.329s)
[948.802447] Starting dynamic subtest: slpc
[962.818013] Dynamic subtest slpc: SUCCESS (14.026s)
[962.828337] Starting dynamic subtest: guc
[966.698151] Dynamic subtest guc: SUCCESS (3.878s)
[966.708491] Starting dynamic subtest: guc_multi_lrc
[971.031498] Dynamic subtest guc_multi_lrc: SUCCESS (4.333s)
[971.041774] Starting dynamic subtest: guc_hang
[975.875127] Dynamic subtest guc_hang: SUCCESS (4.842s)
[975.885385] Starting dynamic subtest: late_gt_pm
[978.632010] Dynamic subtest late_gt_pm: SUCCESS (2.755s)
[978.634724] Subtest live: SUCCESS (248.058s)
[978.663910] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[978.664606] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[978.667864] [115/133] ( 43s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[980.120756] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[980.124946] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[980.184402] [FACT kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[980.185635] [FACT kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)] new: kernel.kmod_is_loaded.i915: true
[980.189414] [116/133] ( 42s left) gem_ctx_persistence (engines-queued)
[980.257972] Starting subtest: engines-queued
[980.260364] Starting dynamic subtest: rcs0
[980.338326] Dynamic subtest rcs0: SUCCESS (0.080s)
[980.350451] Starting dynamic subtest: bcs0
[980.362988] Dynamic subtest bcs0: SUCCESS (0.023s)
[980.371367] Starting dynamic subtest: vcs0
[981.847796] Dynamic subtest vcs0: SUCCESS (1.482s)
[981.861138] Starting dynamic subtest: vcs1
[983.826272] Dynamic subtest vcs1: SUCCESS (1.976s)
[983.838087] Starting dynamic subtest: vecs0
[985.812988] Dynamic subtest vecs0: SUCCESS (1.984s)
[985.825601] Starting dynamic subtest: ccs0
[985.993676] Dynamic subtest ccs0: SUCCESS (0.180s)
[985.996172] Subtest engines-queued: SUCCESS (5.737s)
[986.087879] [117/133] ( 36s left) kms_lease (page-flip-implicit-plane)
[986.182533] Starting subtest: page-flip-implicit-plane
[986.184779] Starting dynamic subtest: pipe-A-eDP-1
[986.684002] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.500s)
[986.694176] Starting dynamic subtest: pipe-B-eDP-1
[987.812203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[987.821697] Starting dynamic subtest: pipe-C-eDP-1
[988.901913] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.089s)
[988.911698] Starting dynamic subtest: pipe-D-eDP-1
[990.037358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[990.039853] Subtest page-flip-implicit-plane: SUCCESS (3.858s)
[990.856229] [118/133] ( 31s left) sysfs_heartbeat_interval (nopreempt)
[990.923781] Starting subtest: nopreempt
[990.925999] Starting dynamic subtest: vecs0
[1000.884130] Dynamic subtest vecs0: SUCCESS (9.961s)
[1000.897788] Starting dynamic subtest: ccs0
[1004.806570] Dynamic subtest ccs0: SUCCESS (3.923s)
[1004.818403] Starting dynamic subtest: vcs0
[1014.837550] Dynamic subtest vcs0: SUCCESS (10.030s)
[1014.848583] Starting dynamic subtest: bcs0
[1018.709916] Dynamic subtest bcs0: SUCCESS (3.873s)
[1018.720872] Starting dynamic subtest: rcs0
[1022.724968] Dynamic subtest rcs0: SUCCESS (4.015s)
[1022.735449] Starting dynamic subtest: vcs1
[1031.862326] Dynamic subtest vcs1: SUCCESS (9.134s)
[1031.865076] Subtest nopreempt: SUCCESS (40.946s)
[1031.893728] Overall timeout time exceeded, stopping.
[1031.909546] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rc6_residency
results: parsing output: 1/ for test: kms_chamelium_color
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_atomic_transition
results: parsing output: 10/ for test: gem_tiling_max_stride
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_chamelium_hpd
results: parsing output: 15/ for test: gen3_render_tiledy_blits
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_color_pipeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: gem_barrier_race
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_force_connector_basic
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_vm_create
results: parsing output: 30/ for test: gem_exec_flush
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_chamelium_frames
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_workarounds
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: gem_pread
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: prime_vgem
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: dmabuf_sync_file
results: parsing output: 57/ for test: i915_drm_fdinfo
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: gem_spin_batch
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_busy
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_invalid_mode
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_plane_multiple
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pipe_crc_basic
results: parsing output: 78/ for test: gem_media_fill
results: parsing output: 79/ for test: kms_getfb
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_ctx_shared
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_draw_crc
results: parsing output: 93/ for test: gen9_exec_parse
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_setmode
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_dither
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_pipe_control_store_loop
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: gem_ctx_engines
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: i915_selftest
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: sysfs_heartbeat_interval
results: parsing output: 118/ for test: kms_content_protection
results: no output, setting notrun
results: parsing output: 119/ for test: sw_sync
results: no output, setting notrun
results: parsing output: 120/ for test: gem_lmem_swapping
results: no output, setting notrun
results: parsing output: 121/ for test: i915_pm_freq_api
results: no output, setting notrun
results: parsing output: 122/ for test: gem_userptr_blits
results: no output, setting notrun
results: parsing output: 123/ for test: kms_properties
results: no output, setting notrun
results: parsing output: 124/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 125/ for test: syncobj_basic
results: no output, setting notrun
results: parsing output: 126/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 128/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 129/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 130/ for test: kms_selftest
results: no output, setting notrun
results: parsing output: 131/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 132/ for test: kms_big_fb
results: no output, setting notrun
Done.