[61.397459] Initializing watchdogs
[61.397502]   /dev/watchdog0
[61.411559] [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]
[61.416019] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.418776] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.421031] [001/134] (960s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[61.536071] Starting subtest: 2x-long-cursor-vs-flip-atomic
[61.537980] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[61.697183] [002/134] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[61.792533] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[61.794616] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[61.925382] [003/134] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[62.021616] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[62.023363] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[62.137622] [004/134] (959s left) kms_big_fb (linear-64bpp-rotate-180)
[62.237884] Starting subtest: linear-64bpp-rotate-180
[63.765942] Subtest linear-64bpp-rotate-180: SUCCESS (1.533s)
[63.982196] [005/134] (958s left) gem_render_copy (y-tiled-to-vebox-linear)
[64.045176] Starting subtest: y-tiled-to-vebox-linear
[64.046980] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[64.236124] [006/134] (957s left) kms_atomic (atomic-plane-damage)
[64.323478] Starting subtest: atomic-plane-damage
[64.371775] Starting dynamic subtest: pipe-A-eDP-1
[64.900858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[64.901989] Subtest atomic-plane-damage: SUCCESS (0.579s)
[65.706738] [007/134] (956s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[65.999139] Starting subtest: cursor-rapid-movement-max-size
[66.002055] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[66.132655] [008/134] (955s left) syncobj_timeline (device-submit-unordered)
[66.190017] Starting subtest: device-submit-unordered
[66.191537] Subtest device-submit-unordered: SUCCESS (0.000s)
[66.305898] [009/134] (955s left) kms_async_flips (async-flip-dpms)
[66.384193] Starting subtest: async-flip-dpms
[66.755131] Starting dynamic subtest: pipe-A-eDP-1
[70.597974] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.849s)
[70.975482] Starting dynamic subtest: pipe-B-eDP-1
[73.747986] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.782s)
[74.151039] Starting dynamic subtest: pipe-C-eDP-1
[76.925100] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.785s)
[77.298893] Starting dynamic subtest: pipe-D-eDP-1
[80.095482] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[80.096437] Subtest async-flip-dpms: SUCCESS (13.724s)
[81.283253] [010/134] (940s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[81.369406] Starting subtest: coverage-vs-premult-vs-constant
[81.656118] Starting dynamic subtest: pipe-A-eDP-1
[82.198065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[82.204888] Starting dynamic subtest: pipe-D-eDP-1
[83.487676] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.288s)
[83.490231] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.121s)
[84.348919] [011/134] (937s left) fbdev (nullptr)
[84.392443] Starting subtest: nullptr
[84.393283] Subtest nullptr: SUCCESS (0.000s)
[84.464206] [012/134] (937s left) kms_color (ctm-0-25)
[84.560688] Starting subtest: ctm-0-25
[84.561751] Starting dynamic subtest: pipe-A-eDP-1
[87.973151] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[87.979679] Starting dynamic subtest: pipe-B-eDP-1
[92.235976] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.262s)
[92.242030] Starting dynamic subtest: pipe-C-eDP-1
[96.281119] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.044s)
[96.288221] Starting dynamic subtest: pipe-D-eDP-1
[100.282743] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.000s)
[100.283652] Subtest ctm-0-25: SUCCESS (15.722s)
[101.124707] [013/134] (921s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[101.220302] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[105.379783] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.160s)
[106.540526] [014/134] (915s left) vgem_basic (mmap)
[106.631229] Starting subtest: mmap
[106.636174] Subtest mmap: SUCCESS (0.006s)
[106.700484] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[106.702360] [015/134] (915s left) gem_mmap_offset (mmap-unmap)
[106.750917] Starting subtest: mmap-unmap
[106.751946] Starting dynamic subtest: smem0
[129.638983] Dynamic subtest smem0: SUCCESS (22.885s)
[129.640821] Subtest mmap-unmap: SUCCESS (22.886s)
[129.783321] [016/134] (892s left) kms_properties (invalid-properties-legacy)
[129.876104] Starting subtest: invalid-properties-legacy
[129.986238] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[130.075688] [017/134] (892s left) dumb_buffer (invalid-bpp)
[130.142878] Starting subtest: invalid-bpp
[130.143943] Subtest invalid-bpp: SUCCESS (0.000s)
[130.253869] [018/134] (892s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[130.341536] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[130.342484] Starting dynamic subtest: pipe-A-default-mode
[130.646926] Dynamic subtest pipe-A-default-mode: SKIP (0.304s)
[130.648736] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.305s)
[131.480116] [019/134] (891s left) kms_psr (fbc-pr-sprite-plane-move)
[131.575107] Starting subtest: fbc-pr-sprite-plane-move
[131.576766] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[131.666747] [020/134] (890s left) gem_fenced_exec_thrash (no-spare-fences)
[131.721019] Subtest no-spare-fences: SKIP (0.000s)
[131.782041] [021/134] (890s left) perf (create-destroy-userspace-config)
[131.912836] Starting subtest: create-destroy-userspace-config
[131.930609] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[131.961390] [022/134] (890s left) kms_chamelium_frames (hdmi-crc-fast)
[132.342546] Subtest hdmi-crc-fast: SKIP (0.000s)
[133.141015] [023/134] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[133.229287] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[133.230929] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[133.358469] [024/134] (889s left) i915_selftest (live)
[136.779080] Starting subtest: live
[136.780349] Starting dynamic subtest: sanitycheck
[141.207206] Dynamic subtest sanitycheck: SUCCESS (4.428s)
[141.213897] Starting dynamic subtest: uncore
[145.572221] Dynamic subtest uncore: SUCCESS (4.363s)
[145.578623] Starting dynamic subtest: workarounds
[163.939344] Dynamic subtest workarounds: FAIL (18.143s)
[163.949005] Starting dynamic subtest: gt_engines
[168.304891] Dynamic subtest gt_engines: SUCCESS (4.583s)
[168.312264] Starting dynamic subtest: gt_timelines
[185.663639] Dynamic subtest gt_timelines: SUCCESS (17.356s)
[185.670973] Starting dynamic subtest: gt_contexts
[188.502586] Dynamic subtest gt_contexts: SUCCESS (2.837s)
[188.511810] Starting dynamic subtest: gt_lrc
[192.869202] Dynamic subtest gt_lrc: SUCCESS (4.363s)
[192.876572] Starting dynamic subtest: gt_mocs
[195.953864] Dynamic subtest gt_mocs: SUCCESS (3.084s)
[195.961063] Starting dynamic subtest: gt_pm
[202.743877] Dynamic subtest gt_pm: SUCCESS (6.788s)
[202.750687] Starting dynamic subtest: gt_heartbeat
[205.565835] Dynamic subtest gt_heartbeat: SUCCESS (2.819s)
[205.578332] Starting dynamic subtest: gt_tlb
[214.891040] Dynamic subtest gt_tlb: SUCCESS (9.322s)
[214.896250] Starting dynamic subtest: requests
[228.480038] Dynamic subtest requests: SUCCESS (13.587s)
[228.487208] Starting dynamic subtest: migrate
[236.489900] Dynamic subtest migrate: SUCCESS (8.008s)
[236.496999] Starting dynamic subtest: active
[240.874929] Dynamic subtest active: SUCCESS (4.383s)
[240.882315] Starting dynamic subtest: objects
[245.629929] Dynamic subtest objects: SUCCESS (4.753s)
[245.637192] Starting dynamic subtest: mman
[250.590632] Dynamic subtest mman: SUCCESS (4.959s)
[250.598171] Starting dynamic subtest: dmabuf
[254.986614] Dynamic subtest dmabuf: SUCCESS (4.394s)
[254.999537] Starting dynamic subtest: vma
[259.353624] Dynamic subtest vma: SUCCESS (4.364s)
[259.360238] Starting dynamic subtest: coherency
[264.474798] Dynamic subtest coherency: SUCCESS (5.118s)
[264.482164] Starting dynamic subtest: gtt
[274.463870] Dynamic subtest gtt: SUCCESS (9.987s)
[274.471580] Starting dynamic subtest: gem
[282.722745] Dynamic subtest gem: SUCCESS (8.258s)
[282.730525] Starting dynamic subtest: evict
[288.128808] Dynamic subtest evict: SUCCESS (5.404s)
[288.136442] Starting dynamic subtest: hugepages
[297.100737] Dynamic subtest hugepages: SUCCESS (8.970s)
[297.106693] Starting dynamic subtest: gem_contexts
[325.691906] Dynamic subtest gem_contexts: SUCCESS (28.589s)
[325.699024] Starting dynamic subtest: client
[330.096102] Dynamic subtest client: SUCCESS (4.403s)
[330.108709] Starting dynamic subtest: gem_migrate
[334.484656] Dynamic subtest gem_migrate: SUCCESS (4.387s)
[334.491495] Starting dynamic subtest: reset
[337.313039] Dynamic subtest reset: SUCCESS (2.826s)
[337.320771] Starting dynamic subtest: memory_region
[341.695299] Dynamic subtest memory_region: SUCCESS (4.380s)
[341.703165] Starting dynamic subtest: hangcheck
[355.168775] Dynamic subtest hangcheck: SUCCESS (13.471s)
[355.176424] Starting dynamic subtest: execlists
[359.522841] Dynamic subtest execlists: SUCCESS (4.352s)
[359.530489] Starting dynamic subtest: ring_submission
[363.884778] Dynamic subtest ring_submission: SUCCESS (4.360s)
[363.892567] Starting dynamic subtest: perf
[368.224376] Dynamic subtest perf: SUCCESS (4.338s)
[368.231705] Starting dynamic subtest: slpc
[380.466365] Dynamic subtest slpc: SUCCESS (12.239s)
[380.473814] Starting dynamic subtest: guc
[384.415249] Dynamic subtest guc: SUCCESS (3.947s)
[384.423279] Starting dynamic subtest: guc_multi_lrc
[388.783922] Dynamic subtest guc_multi_lrc: SUCCESS (4.367s)
[388.791240] Starting dynamic subtest: guc_hang
[393.730941] Dynamic subtest guc_hang: SUCCESS (4.944s)
[393.738398] Starting dynamic subtest: late_gt_pm
[396.569794] Dynamic subtest late_gt_pm: SUCCESS (2.837s)
[396.571654] Subtest live: FAIL (259.783s)
[396.591469] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[396.592192] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[396.593975] [025/134] (626s left) kms_pm_rpm (modeset-non-lpsp-stress)
[400.079031] Starting subtest: modeset-non-lpsp-stress
[401.229488] Subtest modeset-non-lpsp-stress: SKIP (1.151s)
[401.635515] [FACT kms_pm_rpm (modeset-non-lpsp-stress)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[401.636688] [FACT kms_pm_rpm (modeset-non-lpsp-stress)] new: kernel.kmod_is_loaded.i915: true
[401.639143] [026/134] (621s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[401.695759] Starting subtest: invalid-multi-wait-all-unsubmitted
[401.696690] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[401.829783] [027/134] (620s left) gem_mmap_offset (perf)
[401.881074] Starting subtest: perf
[401.882112] Starting dynamic subtest: smem0
[402.210305] Dynamic subtest smem0: SUCCESS (0.329s)
[402.211450] Subtest perf: SUCCESS (0.330s)
[402.336246] [028/134] (620s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[402.435211] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[402.436931] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[402.542745] [029/134] (620s left) gem_exec_balancer (parallel-balancer)
[402.799378] Starting subtest: parallel-balancer
[403.669578] Subtest parallel-balancer: SUCCESS (0.870s)
[403.797987] [030/134] (619s left) kms_chamelium_hpd (hdmi-hpd)
[404.189965] Subtest hdmi-hpd: SKIP (0.000s)
[404.976101] [031/134] (617s left) gem_exec_whisper (basic-fds-priority)
[405.043516] Starting subtest: basic-fds-priority
[428.623583] Subtest basic-fds-priority: SUCCESS (23.575s)
[428.818818] [032/134] (594s left) kms_lease (cursor-implicit-plane)
[428.924018] Starting subtest: cursor-implicit-plane
[428.924928] Starting dynamic subtest: pipe-A-eDP-1
[429.383756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[429.390227] Starting dynamic subtest: pipe-B-eDP-1
[430.537993] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[430.545528] Starting dynamic subtest: pipe-C-eDP-1
[431.635783] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.096s)
[431.642614] Starting dynamic subtest: pipe-D-eDP-1
[432.773339] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[432.774415] Subtest cursor-implicit-plane: SUCCESS (3.851s)
[433.651849] [033/134] (589s left) vgem_basic (bad-handle)
[433.697275] Starting subtest: bad-handle
[433.698190] Subtest bad-handle: SUCCESS (0.000s)
[433.773955] [034/134] (589s left) gem_ctx_persistence (heartbeat-hang)
[433.832381] Starting subtest: heartbeat-hang
[433.834297] Subtest heartbeat-hang: SKIP (0.000s)
[433.953584] [035/134] (589s left) kms_lease (setcrtc-implicit-plane)
[434.050957] Starting subtest: setcrtc-implicit-plane
[434.051817] Starting dynamic subtest: pipe-A-eDP-1
[434.511205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[434.526014] Starting dynamic subtest: pipe-B-eDP-1
[435.671803] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[435.680198] Starting dynamic subtest: pipe-C-eDP-1
[436.782976] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[436.790949] Starting dynamic subtest: pipe-D-eDP-1
[437.917072] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[437.917988] Subtest setcrtc-implicit-plane: SUCCESS (3.867s)
[438.792969] [036/134] (584s left) gem_exec_schedule (submit-early-slice)
[438.848897] Starting subtest: submit-early-slice
[438.849756] Starting dynamic subtest: rcs0
[438.895847] Dynamic subtest rcs0: SUCCESS (0.047s)
[438.905591] Starting dynamic subtest: bcs0
[438.933143] Dynamic subtest bcs0: SUCCESS (0.037s)
[438.940962] Starting dynamic subtest: vcs0
[438.972667] Dynamic subtest vcs0: SUCCESS (0.039s)
[438.980766] Starting dynamic subtest: vcs1
[439.010266] Dynamic subtest vcs1: SUCCESS (0.037s)
[439.017927] Starting dynamic subtest: vecs0
[439.050793] Dynamic subtest vecs0: SUCCESS (0.039s)
[439.057377] Starting dynamic subtest: ccs0
[439.090859] Dynamic subtest ccs0: SUCCESS (0.039s)
[439.092361] Subtest submit-early-slice: SUCCESS (0.243s)
[441.053638] [037/134] (582s left) gem_reg_read (timestamp-moving)
[441.100665] Starting subtest: timestamp-moving
[442.104855] Subtest timestamp-moving: SUCCESS (1.001s)
[442.199699] [038/134] (580s left) kms_dp_linktrain_fallback (dsc-fallback)
[442.299144] Starting subtest: dsc-fallback
[442.301655] Subtest dsc-fallback: SKIP (0.000s)
[442.389490] [039/134] (580s left) gem_tiled_blits (basic)
[442.450581] Subtest basic: SKIP (0.000s)
[442.531565] [040/134] (580s left) syncobj_timeline (wait-delayed-signal)
[442.580923] Starting subtest: wait-delayed-signal
[442.683950] Subtest wait-delayed-signal: SUCCESS (0.102s)
[442.776867] [041/134] (580s left) gem_lmem_swapping (massive)
[442.809840] Subtest massive: SKIP (0.000s)
[442.848181] [042/134] (580s left) kms_big_fb (4-tiled-addfb-size-overflow)
[442.954379] Starting subtest: 4-tiled-addfb-size-overflow
[442.955411] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[443.086460] [043/134] (580s left) kms_hdr (static-swap)
[443.179775] Starting subtest: static-swap
[443.182439] Subtest static-swap: SKIP (0.000s)
[443.266355] [044/134] (580s left) kms_flip (plain-flip-ts-check)
[443.360156] Starting subtest: plain-flip-ts-check
[443.361025] Starting dynamic subtest: A-eDP1
[452.263846] Dynamic subtest A-eDP1: SUCCESS (8.903s)
[452.273116] Starting dynamic subtest: B-eDP1
[461.094227] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[461.102331] Starting dynamic subtest: C-eDP1
[469.919215] Dynamic subtest C-eDP1: SUCCESS (8.823s)
[469.929138] Starting dynamic subtest: D-eDP1
[478.751654] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[478.753928] Subtest plain-flip-ts-check: SUCCESS (35.394s)
[479.950359] [045/134] (543s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[480.029576] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[480.030540] Starting dynamic subtest: pipe-A
[480.269293] Dynamic subtest pipe-A: SUCCESS (0.241s)
[480.280621] Starting dynamic subtest: pipe-B
[481.614643] Dynamic subtest pipe-B: SUCCESS (1.344s)
[481.622709] Starting dynamic subtest: pipe-C
[482.944907] Dynamic subtest pipe-C: SUCCESS (1.329s)
[482.951884] Starting dynamic subtest: pipe-D
[484.293990] Dynamic subtest pipe-D: SUCCESS (1.348s)
[484.294972] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.266s)
[485.474514] [046/134] (537s left) prime_vgem (busy)
[485.548089] Starting subtest: busy
[485.549049] Starting dynamic subtest: rcs0
[485.624257] Dynamic subtest rcs0: SUCCESS (0.078s)
[485.631090] Starting dynamic subtest: bcs0
[485.706477] Dynamic subtest bcs0: SUCCESS (0.081s)
[485.713474] Starting dynamic subtest: vcs0
[485.759176] Dynamic subtest vcs0: SUCCESS (0.052s)
[485.765757] Starting dynamic subtest: vcs1
[485.803869] Dynamic subtest vcs1: SUCCESS (0.044s)
[485.810534] Starting dynamic subtest: vecs0
[485.848854] Dynamic subtest vecs0: SUCCESS (0.044s)
[485.855603] Starting dynamic subtest: ccs0
[485.893427] Dynamic subtest ccs0: SUCCESS (0.044s)
[485.894274] Subtest busy: SUCCESS (0.348s)
[486.060354] [047/134] (537s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[486.125504] Starting subtest: mixed-tiled-to-y-tiled-ccs
[486.127372] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[486.324800] [048/134] (537s left) gem_ctx_isolation (clean)
[486.380025] Starting subtest: clean
[486.380961] Starting dynamic subtest: rcs0
[486.432746] Dynamic subtest rcs0: SUCCESS (0.052s)
[486.441720] Starting dynamic subtest: bcs0
[486.518904] Dynamic subtest bcs0: SUCCESS (0.084s)
[486.527713] Starting dynamic subtest: vcs0
[486.600047] Dynamic subtest vcs0: SUCCESS (0.081s)
[486.608968] Starting dynamic subtest: vcs1
[487.902090] Dynamic subtest vcs1: SUCCESS (1.301s)
[487.909495] Starting dynamic subtest: vecs0
[489.891683] Dynamic subtest vecs0: SUCCESS (1.988s)
[489.900961] Starting dynamic subtest: ccs0
[491.935422] Dynamic subtest ccs0: SUCCESS (2.042s)
[491.936566] Subtest clean: SUCCESS (5.555s)
[492.137598] [049/134] (531s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-render)
[492.235540] Starting subtest: psr-abgr161616f-draw-render
[492.237292] Subtest psr-abgr161616f-draw-render: SKIP (0.000s)
[492.358034] [050/134] (531s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[492.469108] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[493.517279] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.048s)
[493.687322] [051/134] (529s left) gem_spin_batch (legacy)
[493.752754] Starting subtest: legacy
[493.753630] Starting dynamic subtest: default
[496.998268] Dynamic subtest default: SUCCESS (3.241s)
[497.007113] Starting dynamic subtest: render
[500.232060] Dynamic subtest render: SUCCESS (3.231s)
[500.241843] Starting dynamic subtest: bsd
[503.470702] Dynamic subtest bsd: SUCCESS (3.235s)
[503.480305] Starting dynamic subtest: bsd1
[506.707672] Dynamic subtest bsd1: SUCCESS (3.234s)
[506.716283] Starting dynamic subtest: bsd2
[509.944868] Dynamic subtest bsd2: SUCCESS (3.233s)
[509.955743] Starting dynamic subtest: blt
[513.185459] Dynamic subtest blt: SUCCESS (3.237s)
[513.193888] Starting dynamic subtest: vebox
[516.426778] Dynamic subtest vebox: SUCCESS (3.238s)
[516.428307] Subtest legacy: SUCCESS (22.671s)
[516.963156] [052/134] (506s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[521.915837] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[521.918661] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[522.788400] [053/134] (500s left) perf_pmu (init-busy)
[522.826918] Starting subtest: init-busy
[522.827852] Starting dynamic subtest: rcs0
[522.828709] Dynamic subtest rcs0: SUCCESS (0.001s)
[522.836294] Starting dynamic subtest: bcs0
[522.837071] Dynamic subtest bcs0: SUCCESS (0.000s)
[522.843740] Starting dynamic subtest: vcs0
[522.844564] Dynamic subtest vcs0: SUCCESS (0.001s)
[522.851141] Starting dynamic subtest: vcs1
[522.851937] Dynamic subtest vcs1: SUCCESS (0.001s)
[522.858647] Starting dynamic subtest: vecs0
[522.859543] Dynamic subtest vecs0: SUCCESS (0.001s)
[522.866362] Starting dynamic subtest: ccs0
[522.867236] Dynamic subtest ccs0: SUCCESS (0.001s)
[522.868067] Subtest init-busy: SUCCESS (0.008s)
[522.943548] [054/134] (500s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[523.032134] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[523.033820] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[523.148486] [055/134] (500s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[523.230095] Starting subtest: primary-y-tiled-reflect-x-90
[523.231869] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[523.323544] [056/134] (500s left) prime_mmap (test_correct)
[523.375315] Starting subtest: test_correct
[523.376224] Starting dynamic subtest: test_correct-smem
[523.408135] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[523.409331] Subtest test_correct: SUCCESS (0.034s)
[523.535613] [057/134] (500s left) kms_cursor_crc (cursor-sliding-max-size)
[523.805169] Starting subtest: cursor-sliding-max-size
[523.807852] Subtest cursor-sliding-max-size: SKIP (0.000s)
[523.969741] [058/134] (499s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[524.087742] Starting subtest: cursorB-vs-flipA-legacy
[524.090771] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[524.253972] [059/134] (499s left) gem_mmap_gtt (basic-wc)
[524.315961] Subtest basic-wc: SKIP (0.000s)
[524.384773] [060/134] (499s left) gem_softpin (noreloc)
[524.457555] Starting subtest: noreloc
[529.839544] Subtest noreloc: SUCCESS (5.380s)
[529.992344] [061/134] (493s left) sw_sync (alloc_timeline)
[530.027073] Starting subtest: alloc_timeline
[530.028037] Subtest alloc_timeline: SUCCESS (0.000s)
[530.100991] [062/134] (493s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[530.198858] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[530.200806] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[530.321801] [063/134] (493s left) kms_pm_backlight (bad-brightness)
[530.412374] Starting subtest: bad-brightness
[530.466146] Starting dynamic subtest: eDP-1
[530.770906] Dynamic subtest eDP-1: SUCCESS (0.305s)
[530.771859] Subtest bad-brightness: SUCCESS (0.359s)
[531.622274] [064/134] (492s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[532.186890] Starting subtest: syncobj-timeline-invalid-wait
[532.190256] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[534.008810] [065/134] (489s left) syncobj_timeline (signal-point-0)
[534.070522] Starting subtest: signal-point-0
[534.071505] Subtest signal-point-0: SUCCESS (0.000s)
[534.206465] [066/134] (489s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[534.299951] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[534.301539] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[534.425728] [067/134] (489s left) kms_content_protection (atomic)
[534.560481] Starting subtest: atomic
[534.562470] Subtest atomic: SKIP (0.000s)
[534.729945] [068/134] (489s left) i915_pm_rps (reset)
[534.781963] Starting subtest: reset
[543.249411] Subtest reset: SUCCESS (8.465s)
[543.392320] [069/134] (480s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[543.482982] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[551.927934] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.445s)
[552.061410] [070/134] (472s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[552.153755] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[559.129200] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.975s)
[559.261522] [071/134] (464s left) gem_close (many-handles-one-vma)
[559.321882] Starting subtest: many-handles-one-vma
[559.345653] Subtest many-handles-one-vma: SUCCESS (0.024s)
[559.506588] [072/134] (464s left) kms_psr (fbc-psr-sprite-render)
[559.590439] Starting subtest: fbc-psr-sprite-render
[559.591394] Starting dynamic subtest: eDP-1
[559.593169] Dynamic subtest eDP-1: SKIP (0.000s)
[559.594891] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[559.681916] [073/134] (464s left) kms_vblank (wait-idle-hang)
[559.774521] Starting subtest: wait-idle-hang
[559.775480] Starting dynamic subtest: pipe-A-eDP-1
[586.725135] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.947s)
[586.739772] Starting dynamic subtest: pipe-D-eDP-1
[601.681122] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.953s)
[601.682087] Subtest wait-idle-hang: SUCCESS (41.904s)
[602.531808] [074/134] (421s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[602.620217] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[602.621928] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[602.737431] [075/134] (421s left) gem_userptr_blits (create-destroy-unsync)
[602.804067] Subtest create-destroy-unsync: SKIP (0.000s)
[602.967244] [076/134] (421s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[603.014719] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[603.124503] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[603.238578] [077/134] (421s left) kms_psr (psr2-cursor-blt)
[603.334598] Starting subtest: psr2-cursor-blt
[603.335623] Starting dynamic subtest: eDP-1
[605.076738] Dynamic subtest eDP-1: SUCCESS (1.742s)
[605.077718] Subtest psr2-cursor-blt: SUCCESS (1.743s)
[605.890754] [078/134] (418s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[605.970303] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[605.971250] Starting dynamic subtest: pipe-A-default-mode
[606.265823] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[606.267597] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.295s)
[607.122981] [079/134] (417s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[607.215572] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[607.216552] Starting dynamic subtest: pipe-A-eDP-1
[607.237394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[607.246561] Starting dynamic subtest: pipe-B-eDP-1
[607.259396] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[607.268905] Starting dynamic subtest: pipe-C-eDP-1
[607.282883] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[607.291567] Starting dynamic subtest: pipe-D-eDP-1
[607.303395] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[607.304313] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.089s)
[609.576859] [080/134] (414s left) kms_cursor_crc (cursor-onscreen-512x170)
[609.873719] Starting subtest: cursor-onscreen-512x170
[609.875868] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[610.059028] [081/134] (414s left) syncobj_wait (invalid-reset-illegal-handle)
[610.122916] Starting subtest: invalid-reset-illegal-handle
[610.123867] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[610.255603] [082/134] (414s left) gem_sync (basic-store-all)
[610.325463] Starting subtest: basic-store-all
[614.287065] Subtest basic-store-all: SUCCESS (3.962s)
[614.490333] [083/134] (410s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[614.600017] Starting subtest: y-tiled-64bpp-rotate-0
[614.601878] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[614.715084] [084/134] (409s left) gem_mmap_gtt (basic)
[614.765764] Subtest basic: SKIP (0.000s)
[614.831511] [085/134] (409s left) kms_psr (psr-dpms)
[614.919482] Starting subtest: psr-dpms
[614.920395] Starting dynamic subtest: eDP-1
[617.882369] Dynamic subtest eDP-1: SUCCESS (2.963s)
[617.883239] Subtest psr-dpms: SUCCESS (2.964s)
[618.762085] [086/134] (405s left) gem_lmem_swapping (verify-ccs)
[618.796056] Subtest verify-ccs: SKIP (0.000s)
[618.834665] [087/134] (405s left) gem_pread (snoop)
[618.889442] Subtest snoop: SKIP (0.000s)
[618.951724] [088/134] (405s left) kms_rotation_crc (exhaust-fences)
[619.051387] Starting subtest: exhaust-fences
[619.053038] Subtest exhaust-fences: SKIP (0.000s)
[619.139146] [089/134] (405s left) gem_softpin (softpin)
[619.196991] Starting subtest: softpin
[651.508281] Subtest softpin: SUCCESS (32.305s)
[651.636063] [090/134] (373s left) i915_drm_fdinfo (virtual-busy-hang-all)
[651.669240] Starting subtest: virtual-busy-hang-all
[651.670931] Subtest virtual-busy-hang-all: SKIP (0.000s)
[651.756296] [091/134] (373s left) gem_render_copy (y-tiled-ccs-to-linear)
[651.813164] Starting subtest: y-tiled-ccs-to-linear
[651.814786] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[652.017855] [092/134] (372s left) gem_watchdog (default-physical)
[652.085238] Starting subtest: default-physical
[653.860239] Subtest default-physical: SUCCESS (1.774s)
[653.979821] [093/134] (370s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[654.035310] Starting subtest: multi-wait-available-unsubmitted-submitted
[654.036200] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[654.158073] [094/134] (370s left) gem_mmap_gtt (basic-short)
[654.202297] Subtest basic-short: SKIP (0.000s)
[654.263175] [095/134] (370s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[654.349925] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[654.351787] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[654.485805] [096/134] (370s left) gem_flink_basic (bad-open)
[654.535477] Starting subtest: bad-open
[654.536426] Subtest bad-open: SUCCESS (0.000s)
[654.662784] [097/134] (370s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[654.783182] Starting subtest: cursor-vs-flip-toggle
[685.655551] Subtest cursor-vs-flip-toggle: SUCCESS (30.870s)
[686.484436] [098/134] (338s left) gem_flink_basic (double-flink)
[686.543383] Starting subtest: double-flink
[686.544294] Subtest double-flink: SUCCESS (0.000s)
[686.682900] [099/134] (338s left) gen9_exec_parse (batch-zero-length)
[686.755406] Subtest batch-zero-length: SKIP (0.000s)
[686.832171] [100/134] (338s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[686.936572] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[686.938438] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[687.068296] [101/134] (338s left) api_intel_allocator (simple-allocator)
[687.123512] Starting subtest: simple-allocator
[687.124435] Starting dynamic subtest: basic
[687.126681] Dynamic subtest basic: SUCCESS (0.004s)
[687.135386] Starting dynamic subtest: parallel-one
[687.324087] Dynamic subtest parallel-one: SUCCESS (0.194s)
[687.332772] Starting dynamic subtest: print
[687.333758] Dynamic subtest print: SUCCESS (0.000s)
[687.341476] Starting dynamic subtest: reuse
[687.342391] Dynamic subtest reuse: SUCCESS (0.000s)
[687.349572] Starting dynamic subtest: reserve
[687.350457] Dynamic subtest reserve: SUCCESS (0.000s)
[687.358103] Starting dynamic subtest: fork-reopen-allocator
[687.358957] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[687.359859] Subtest simple-allocator: SUCCESS (0.220s)
[687.488513] [102/134] (337s left) gem_exec_balancer (parallel-keep-in-fence)
[687.763421] Starting subtest: parallel-keep-in-fence
[688.919672] Subtest parallel-keep-in-fence: SUCCESS (1.158s)
[689.056083] [103/134] (336s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[689.141083] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[689.141896] Starting dynamic subtest: pipe-A-eDP-1
[689.150191] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[689.157507] Starting dynamic subtest: pipe-B-eDP-1
[689.165414] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[689.173043] Starting dynamic subtest: pipe-C-eDP-1
[689.181067] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[689.188234] Starting dynamic subtest: pipe-D-eDP-1
[689.196235] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[689.197828] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[691.357469] [104/134] (333s left) gem_ctx_create (basic)
[691.417916] Starting subtest: basic
[691.418999] Subtest basic: SUCCESS (0.000s)
[691.617660] [105/134] (333s left) syncobj_wait (invalid-reset-zero-handles)
[691.671070] Starting subtest: invalid-reset-zero-handles
[691.672045] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[691.797506] [106/134] (333s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[691.900408] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[691.902058] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[692.039203] [107/134] (333s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[692.134625] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[699.571994] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.437s)
[699.752462] [108/134] (325s left) gem_ctx_shared (detached-shared-gtt)
[699.813413] Starting subtest: detached-shared-gtt
[701.969340] Subtest detached-shared-gtt: SUCCESS (2.153s)
[702.370465] [109/134] (323s left) kms_cdclk (mode-transition)
[702.462038] Starting subtest: mode-transition
[702.463079] Starting dynamic subtest: pipe-A-eDP-1
[702.746869] Dynamic subtest pipe-A-eDP-1: SKIP (0.284s)
[702.754181] Starting dynamic subtest: pipe-B-eDP-1
[702.755837] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[702.762892] Starting dynamic subtest: pipe-C-eDP-1
[702.764546] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[702.771715] Starting dynamic subtest: pipe-D-eDP-1
[702.773422] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[702.775032] Subtest mode-transition: SKIP (0.291s)
[703.578930] [110/134] (321s left) kms_prop_blob (invalid-set-prop)
[703.641308] Starting subtest: invalid-set-prop
[703.642199] Subtest invalid-set-prop: SUCCESS (0.000s)
[703.759700] [111/134] (321s left) gem_exec_params (rs-invalid)
[703.829261] Starting subtest: rs-invalid
[703.832107] Subtest rs-invalid: SUCCESS (0.003s)
[703.989869] [112/134] (321s left) gem_create (create-valid-nonaligned)
[704.053044] Starting subtest: create-valid-nonaligned
[704.054043] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[704.255465] [113/134] (321s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[704.362084] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[711.802848] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.441s)
[711.991901] [114/134] (313s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[712.084423] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[712.085278] Starting dynamic subtest: pipe-A-eDP-1
[712.093322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[712.101192] Starting dynamic subtest: pipe-B-eDP-1
[712.109468] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[712.117710] Starting dynamic subtest: pipe-C-eDP-1
[712.125682] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[712.133106] Starting dynamic subtest: pipe-D-eDP-1
[712.141275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[712.142822] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[714.293896] [115/134] (311s left) kms_feature_discovery (dp-mst)
[714.394375] Starting subtest: dp-mst
[714.396093] Subtest dp-mst: SKIP (0.000s)
[714.486702] [116/134] (311s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-cpu)
[714.580855] Starting subtest: fbc-abgr161616f-draw-mmap-cpu
[714.582552] Subtest fbc-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[714.711453] [117/134] (311s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[714.810920] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[714.812754] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[714.957322] [118/134] (310s left) kms_psr (fbc-psr-basic)
[715.052280] Starting subtest: fbc-psr-basic
[715.053104] Starting dynamic subtest: eDP-1
[715.054705] Dynamic subtest eDP-1: SKIP (0.000s)
[715.056316] Subtest fbc-psr-basic: SKIP (0.001s)
[715.147030] [119/134] (310s left) kms_universal_plane (universal-plane-functional)
[715.239048] Starting subtest: universal-plane-functional
[715.239993] Starting dynamic subtest: pipe-A-eDP-1
[719.107228] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.866s)
[719.115098] Starting dynamic subtest: pipe-B-eDP-1
[723.701058] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.592s)
[723.709796] Starting dynamic subtest: pipe-C-eDP-1
[727.973766] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.271s)
[727.981733] Starting dynamic subtest: pipe-D-eDP-1
[732.330837] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.355s)
[732.331840] Subtest universal-plane-functional: SUCCESS (17.091s)
[733.137617] [120/134] (292s left) kms_plane (planar-pixel-format-settings)
[733.238397] Starting subtest: planar-pixel-format-settings
[733.304367] Subtest planar-pixel-format-settings: SUCCESS (0.066s)
[733.445427] [121/134] (292s left) kms_flip (2x-flip-vs-panning)
[733.535809] Starting subtest: 2x-flip-vs-panning
[733.546805] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[733.646087] [122/134] (292s left) gem_exec_schedule (implicit-write-read)
[733.720264] Starting subtest: implicit-write-read
[733.721173] Starting dynamic subtest: rcs0
[733.829031] Dynamic subtest rcs0: SUCCESS (0.109s)
[733.839101] Starting dynamic subtest: vcs0
[733.909030] Dynamic subtest vcs0: SUCCESS (0.079s)
[733.921149] Starting dynamic subtest: vcs1
[733.989101] Dynamic subtest vcs1: SUCCESS (0.078s)
[733.999478] Starting dynamic subtest: vecs0
[734.068118] Dynamic subtest vecs0: SUCCESS (0.078s)
[734.078394] Starting dynamic subtest: ccs0
[734.156089] Dynamic subtest ccs0: SUCCESS (0.087s)
[734.157278] Subtest implicit-write-read: SUCCESS (0.437s)
[735.063491] [123/134] (290s left) gem_render_copy (x-tiled)
[735.118227] Starting subtest: x-tiled
[735.119096] Starting dynamic subtest: smem
[735.161253] Dynamic subtest smem: SUCCESS (0.044s)
[735.162264] Subtest x-tiled: SUCCESS (0.044s)
[735.401386] [124/134] (290s left) kms_vblank (wait-forked-busy)
[735.490340] Starting subtest: wait-forked-busy
[735.491235] Starting dynamic subtest: pipe-A-eDP-1
[737.375644] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.883s)
[737.386305] Starting dynamic subtest: pipe-D-eDP-1
[739.989383] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s)
[739.990248] Subtest wait-forked-busy: SUCCESS (4.500s)
[740.812415] [125/134] (285s left) gem_mmap (big-bo)
[740.879303] Subtest big-bo: SKIP (0.000s)
[740.947325] [126/134] (285s left) gem_reg_read (bad-register)
[741.001511] Starting subtest: bad-register
[741.002463] Subtest bad-register: SUCCESS (0.000s)
[741.131821] [127/134] (284s left) kms_flip (nonexisting-fb)
[741.225942] Starting subtest: nonexisting-fb
[741.229455] Starting dynamic subtest: A-eDP1
[742.376769] Dynamic subtest A-eDP1: SUCCESS (1.149s)
[742.385188] Starting dynamic subtest: B-eDP1
[743.516992] Dynamic subtest B-eDP1: SUCCESS (1.139s)
[743.525506] Starting dynamic subtest: C-eDP1
[744.651312] Dynamic subtest C-eDP1: SUCCESS (1.133s)
[744.659810] Starting dynamic subtest: D-eDP1
[745.775176] Dynamic subtest D-eDP1: SUCCESS (1.123s)
[745.778384] Subtest nonexisting-fb: SUCCESS (4.552s)
[747.069134] [128/134] (279s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[747.161398] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[747.162333] Starting dynamic subtest: pipe-A-eDP-1
[747.170937] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[747.179522] Starting dynamic subtest: pipe-B-eDP-1
[747.188834] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[747.196806] Starting dynamic subtest: pipe-C-eDP-1
[747.204830] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[747.212350] Starting dynamic subtest: pipe-D-eDP-1
[747.220490] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[747.222141] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[749.342531] [129/134] (276s left) i915_query (query-topology-coherent-slice-mask)
[749.393492] Starting subtest: query-topology-coherent-slice-mask
[749.395268] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[749.529448] [130/134] (276s left) gem_close_race (multigpu-basic-process)
[749.605631] Starting subtest: multigpu-basic-process
[749.607580] Subtest multigpu-basic-process: SKIP (0.000s)
[749.840966] [131/134] (276s left) i915_drm_fdinfo (memory-info-idle)
[749.880195] Starting subtest: memory-info-idle
[749.881130] Starting dynamic subtest: smem0
[749.956726] Dynamic subtest smem0: SUCCESS (0.076s)
[749.957910] Subtest memory-info-idle: SUCCESS (0.077s)
[750.048060] [132/134] (276s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[755.011837] Starting subtest: psr2-cursor-plane-update-sf
[755.012628] Starting dynamic subtest: pipe-A-eDP-1
[756.311925] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.298s)
[756.321403] Starting dynamic subtest: pipe-B-eDP-1
[757.557797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[757.558786] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.547s)
[758.454285] [133/134] (267s left) api_intel_bb (object-reloc-purge-cache)
[758.522542] Starting subtest: object-reloc-purge-cache
[758.527079] Subtest object-reloc-purge-cache: SKIP (0.003s)
[758.679876] [134/134] (267s left) gem_workarounds (reset)
[758.746629] Starting subtest: reset
[758.936911] Subtest reset: SUCCESS (0.190s)
[759.091414] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: kms_plane_alpha_blend
results: parsing output: 10/ for test: fbdev
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: dumb_buffer
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_fenced_exec_thrash
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_selftest
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: gem_exec_whisper
results: parsing output: 31/ for test: kms_lease
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: gem_reg_read
results: parsing output: 37/ for test: kms_dp_linktrain_fallback
results: parsing output: 38/ for test: gem_tiled_blits
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_lmem_swapping
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_hdr
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: prime_vgem
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: gem_ctx_isolation
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_spin_batch
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: prime_mmap
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pm_backlight
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: i915_pm_rps
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_close
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_sync
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: gem_pread
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_watchdog
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_flink_basic
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_flink_basic
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: api_intel_allocator
results: parsing output: 101/ for test: gem_exec_balancer
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_ctx_create
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_ctx_shared
results: parsing output: 108/ for test: kms_cdclk
results: parsing output: 109/ for test: kms_prop_blob
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: gem_create
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_feature_discovery
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_universal_plane
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: gem_mmap
results: parsing output: 125/ for test: gem_reg_read
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: i915_query
results: parsing output: 129/ for test: gem_close_race
results: parsing output: 130/ for test: i915_drm_fdinfo
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: api_intel_bb
results: parsing output: 133/ for test: gem_workarounds
Done.