[55.234879] Initializing watchdogs
[55.234957]   /dev/watchdog0
[55.257033] [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]
[55.261086] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.263301] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.266752] [001/130] (960s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[55.364641] Starting subtest: plane-upscale-20x20-with-rotation
[55.367122] Starting dynamic subtest: pipe-A
[55.600352] Dynamic subtest pipe-A: SUCCESS (0.236s)
[55.609615] Starting dynamic subtest: pipe-B
[56.842061] Dynamic subtest pipe-B: SUCCESS (1.241s)
[56.849169] Starting dynamic subtest: pipe-C
[58.178092] Dynamic subtest pipe-C: SUCCESS (1.335s)
[58.187231] Starting dynamic subtest: pipe-D
[59.519010] Dynamic subtest pipe-D: SUCCESS (1.340s)
[59.521446] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.152s)
[60.729126] [002/130] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[60.832844] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[60.837586] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[60.930117] [003/130] (954s left) kms_big_fb (linear-8bpp-rotate-180)
[61.029811] Starting subtest: linear-8bpp-rotate-180
[62.176443] Subtest linear-8bpp-rotate-180: SUCCESS (1.146s)
[62.330785] [004/130] (953s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[62.422700] Starting subtest: blocking-absolute-wf_vblank-interruptible
[62.425063] Starting dynamic subtest: A-eDP1
[71.154142] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[71.162820] Starting dynamic subtest: B-eDP1
[79.905733] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[79.912564] Starting dynamic subtest: C-eDP1
[88.606123] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[88.614996] Starting dynamic subtest: D-eDP1
[97.333283] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[97.335988] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.908s)
[98.548302] [005/130] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[98.650970] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[98.655302] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[98.768654] [006/130] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[98.858387] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[105.388372] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.532s)
[105.547865] [007/130] (910s left) gem_ctx_exec (basic-norecovery)
[105.609560] Starting subtest: basic-norecovery
[105.887171] Subtest basic-norecovery: SUCCESS (0.277s)
[106.038542] [008/130] (909s left) kms_psr (psr-primary-page-flip)
[106.123701] Starting subtest: psr-primary-page-flip
[106.125823] Starting dynamic subtest: eDP-1
[107.882686] Dynamic subtest eDP-1: SUCCESS (1.758s)
[107.885197] Subtest psr-primary-page-flip: SUCCESS (1.759s)
[108.747593] [009/130] (907s left) core_getstats
[108.928084] [010/130] (907s left) i915_hangman (detector)
[108.991612] Starting subtest: detector
[108.993948] Starting dynamic subtest: rcs0
[120.883879] Dynamic subtest rcs0: SUCCESS (11.891s)
[120.894812] Starting dynamic subtest: bcs0
[132.851271] Dynamic subtest bcs0: SUCCESS (11.966s)
[132.860603] Starting dynamic subtest: vcs0
[144.819335] Dynamic subtest vcs0: SUCCESS (11.967s)
[144.830094] Starting dynamic subtest: vcs1
[155.828342] Dynamic subtest vcs1: SUCCESS (11.007s)
[155.837451] Starting dynamic subtest: vecs0
[166.836553] Dynamic subtest vecs0: SUCCESS (11.006s)
[166.847480] Starting dynamic subtest: ccs0
[178.803261] Dynamic subtest ccs0: SUCCESS (11.965s)
[178.806056] Subtest detector: SUCCESS (69.809s)
[178.890590] [011/130] (837s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[178.994757] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[178.997225] Starting dynamic subtest: pipe-A-eDP-1
[180.996642] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.004s)
[181.004908] Starting dynamic subtest: pipe-B-eDP-1
[183.123059] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.126s)
[183.130907] Starting dynamic subtest: pipe-C-eDP-1
[185.184721] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.061s)
[185.194511] Starting dynamic subtest: pipe-D-eDP-1
[187.222156] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.037s)
[187.224614] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.230s)
[188.489154] [012/130] (827s left) gem_lmem_swapping (parallel-random-engines)
[188.532888] Subtest parallel-random-engines: SKIP (0.000s)
[188.571506] [013/130] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[188.667600] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[188.671596] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[188.771135] [014/130] (827s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[188.864384] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[188.868702] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[188.968278] [015/130] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[189.055386] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[189.059655] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[189.189427] [016/130] (827s left) gem_ctx_persistence (legacy-engines-hostile)
[189.239836] Starting subtest: legacy-engines-hostile
[189.242317] Starting dynamic subtest: render
[189.370616] Dynamic subtest render: SUCCESS (0.130s)
[189.380546] Starting dynamic subtest: bsd1
[189.488615] Dynamic subtest bsd1: SUCCESS (0.116s)
[189.498699] Starting dynamic subtest: bsd2
[189.632317] Dynamic subtest bsd2: SUCCESS (0.142s)
[189.642773] Starting dynamic subtest: blt
[189.749228] Dynamic subtest blt: SUCCESS (0.116s)
[189.763376] Starting dynamic subtest: vebox
[189.866602] Dynamic subtest vebox: SUCCESS (0.115s)
[189.869034] Subtest legacy-engines-hostile: SUCCESS (0.627s)
[189.952728] [017/130] (826s left) prime_vgem (shrink)
[190.072591] Starting subtest: shrink
[190.085915] Subtest shrink: SUCCESS (0.013s)
[190.234225] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[190.237670] [018/130] (826s left) gem_exec_schedule (preempt-queue-chain)
[190.315982] Subtest preempt-queue-chain: SKIP (0.000s)
[190.614443] [019/130] (825s left) kms_flip (flip-vs-panning-vs-hang)
[190.709812] Starting subtest: flip-vs-panning-vs-hang
[190.712312] Starting dynamic subtest: A-eDP1
[230.397038] Dynamic subtest A-eDP1: SUCCESS (39.686s)
[230.408024] Starting dynamic subtest: D-eDP1
[269.379233] Dynamic subtest D-eDP1: SUCCESS (38.981s)
[269.381426] Subtest flip-vs-panning-vs-hang: SUCCESS (78.670s)
[270.602444] [020/130] (745s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[270.848209] Starting subtest: cursor-rapid-movement-256x256
[270.853793] Starting dynamic subtest: pipe-A-eDP-1
[271.393105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[271.417120] Starting dynamic subtest: pipe-D-eDP-1
[272.607083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.194s)
[272.609062] Subtest cursor-rapid-movement-256x256: SUCCESS (1.756s)
[273.451420] [021/130] (743s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[273.539283] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[273.543722] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[273.661914] [022/130] (742s left) gem_exec_balancer (sliced)
[273.716838] Starting subtest: sliced
[273.721507] Subtest sliced: SKIP (0.000s)
[274.015722] [023/130] (742s left) kms_psr (fbc-psr-suspend)
[274.117160] Starting subtest: fbc-psr-suspend
[274.119055] Starting dynamic subtest: eDP-1
[274.123030] Dynamic subtest eDP-1: SKIP (0.000s)
[274.127087] Subtest fbc-psr-suspend: SKIP (0.001s)
[274.202484] [024/130] (742s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[274.306907] Starting subtest: fbcpsr-stridechange
[280.446536] Subtest fbcpsr-stridechange: SUCCESS (6.144s)
[280.607354] [025/130] (736s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[280.711415] Starting subtest: 4-tiled-32bpp-rotate-180
[282.143240] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.433s)
[282.302035] [026/130] (734s left) gem_mmap_gtt (basic-read-write-distinct)
[282.360909] Subtest basic-read-write-distinct: SKIP (0.000s)
[282.423799] [027/130] (734s left) perf_pmu (busy-accuracy-2)
[282.457055] Starting subtest: busy-accuracy-2
[282.458701] Starting dynamic subtest: rcs0
[285.499452] Dynamic subtest rcs0: SUCCESS (3.039s)
[285.513614] Starting dynamic subtest: bcs0
[288.553563] Dynamic subtest bcs0: SUCCESS (3.052s)
[288.563991] Starting dynamic subtest: vcs0
[291.599991] Dynamic subtest vcs0: SUCCESS (3.044s)
[291.608885] Starting dynamic subtest: vcs1
[294.644116] Dynamic subtest vcs1: SUCCESS (3.043s)
[294.654902] Starting dynamic subtest: vecs0
[297.693803] Dynamic subtest vecs0: SUCCESS (3.048s)
[297.704660] Starting dynamic subtest: ccs0
[300.753542] Dynamic subtest ccs0: SUCCESS (3.058s)
[300.756087] Subtest busy-accuracy-2: SUCCESS (18.293s)
[300.894238] [028/130] (715s left) gem_create (create-ext-set-pat)
[301.059911] Starting subtest: create-ext-set-pat
[301.062783] Subtest create-ext-set-pat: SUCCESS (0.001s)
[301.186885] [029/130] (715s left) gem_exec_reloc (basic-wc-cpu-active)
[301.238482] Subtest basic-wc-cpu-active: SKIP (0.000s)
[301.319255] [030/130] (715s left) gem_ctx_persistence (userptr)
[301.380032] Starting subtest: userptr
[301.624095] Subtest userptr: SUCCESS (0.244s)
[301.727784] [031/130] (715s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[301.782477] Starting subtest: multi-wait-all-for-submit-unsubmitted
[301.888545] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[301.984078] [032/130] (714s left) gem_busy (close-race)
[302.053125] Starting subtest: close-race
[325.908724] Subtest close-race: SUCCESS (23.854s)
[326.311556] [033/130] (690s left) kms_addfb_basic (small-bo)
[326.453164] Starting subtest: small-bo
[326.455068] Subtest small-bo: SUCCESS (0.000s)
[326.584642] [034/130] (690s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[326.673297] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[331.127837] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.458s)
[332.249023] [035/130] (684s left) syncobj_timeline (invalid-transfer-non-existent-point)
[332.301411] Starting subtest: invalid-transfer-non-existent-point
[332.303734] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[332.434040] [036/130] (684s left) kms_lease (lease-revoke)
[332.534819] Starting subtest: lease-revoke
[332.537083] Starting dynamic subtest: pipe-A-eDP-1
[332.567388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[332.581519] Starting dynamic subtest: pipe-B-eDP-1
[332.599313] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[332.608475] Starting dynamic subtest: pipe-C-eDP-1
[332.623914] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[332.633300] Starting dynamic subtest: pipe-D-eDP-1
[332.654216] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[332.656347] Subtest lease-revoke: SUCCESS (0.119s)
[332.829457] [037/130] (684s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[332.939433] Starting subtest: psr-rgb101010-draw-pwrite
[340.460080] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.522s)
[340.592264] [038/130] (676s left) gem_mmap_offset (partial-remap)
[340.647322] Starting subtest: partial-remap
[340.649657] Starting dynamic subtest: smem0
[340.658601] Dynamic subtest smem0: SUCCESS (0.003s)
[340.660766] Subtest partial-remap: SUCCESS (0.004s)
[340.767348] [039/130] (676s left) gem_exec_whisper (basic-fds-priority)
[340.834368] Starting subtest: basic-fds-priority
[364.327777] Subtest basic-fds-priority: SUCCESS (23.488s)
[364.515907] [040/130] (652s left) gem_softpin (allocator-nopin)
[364.586668] Starting subtest: allocator-nopin
[364.676544] Subtest allocator-nopin: SUCCESS (0.090s)
[364.844818] [041/130] (652s left) gem_exec_reloc (basic-concurrent16)
[364.905485] Subtest basic-concurrent16: SKIP (0.000s)
[364.982838] [042/130] (652s left) kms_vrr (negative-basic)
[365.082974] Starting subtest: negative-basic
[365.089342] Starting dynamic subtest: pipe-A-eDP-1
[370.508933] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.417s)
[370.794806] Subtest negative-basic: SUCCESS (5.713s)
[371.655552] [043/130] (645s left) syncobj_timeline (single-wait-all-signaled)
[371.707354] Starting subtest: single-wait-all-signaled
[371.709249] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[371.818942] [044/130] (645s left) kms_psr (fbc-psr2-primary-page-flip)
[371.912965] Starting subtest: fbc-psr2-primary-page-flip
[371.915114] Starting dynamic subtest: eDP-1
[371.918997] Dynamic subtest eDP-1: SKIP (0.000s)
[371.923016] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[371.996317] [045/130] (645s left) kms_feature_discovery (display-4x)
[372.092932] Starting subtest: display-4x
[372.097413] Subtest display-4x: SKIP (0.000s)
[372.185092] [046/130] (645s left) kms_pm_rpm (universal-planes)
[374.038072] Starting subtest: universal-planes
[374.040484] Starting dynamic subtest: plane-33
[382.374379] Dynamic subtest plane-33: SUCCESS (8.335s)
[382.386159] Starting dynamic subtest: plane-43
[390.654916] Dynamic subtest plane-43: SUCCESS (8.278s)
[390.665394] Starting dynamic subtest: plane-53
[399.233660] Dynamic subtest plane-53: SUCCESS (8.576s)
[399.245885] Starting dynamic subtest: plane-63
[407.536569] Dynamic subtest plane-63: SUCCESS (8.301s)
[407.547628] Starting dynamic subtest: plane-73
[415.843048] Dynamic subtest plane-73: SUCCESS (8.305s)
[415.854987] Starting dynamic subtest: plane-83
[424.132028] Dynamic subtest plane-83: SUCCESS (8.287s)
[424.134662] Subtest universal-planes: SUCCESS (50.093s)
[424.523312] [047/130] (593s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[424.624183] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[425.570775] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.945s)
[425.736574] [048/130] (591s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[425.805287] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[425.887763] [049/130] (591s left) kms_scaling_modes (scaling-mode-full-aspect)
[425.968711] Starting subtest: scaling-mode-full-aspect
[425.970685] Starting dynamic subtest: pipe-A-eDP-1
[426.066615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[426.075961] Starting dynamic subtest: pipe-B-eDP-1
[427.226571] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[427.238783] Starting dynamic subtest: pipe-C-eDP-1
[428.338697] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[428.352050] Starting dynamic subtest: pipe-D-eDP-1
[429.473212] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[429.475464] Subtest scaling-mode-full-aspect: SUCCESS (3.504s)
[430.648253] [050/130] (587s left) kms_color (degamma)
[430.751911] Starting subtest: degamma
[430.753740] Starting dynamic subtest: pipe-A-eDP-1
[431.463058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[431.474619] Starting dynamic subtest: pipe-B-eDP-1
[432.808520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.345s)
[432.818250] Starting dynamic subtest: pipe-C-eDP-1
[434.097075] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[434.109304] Starting dynamic subtest: pipe-D-eDP-1
[435.437449] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[435.439689] Subtest degamma: SUCCESS (4.686s)
[436.296280] [051/130] (581s left) kms_cursor_crc (cursor-offscreen-256x85)
[436.563815] Starting subtest: cursor-offscreen-256x85
[436.606371] Subtest cursor-offscreen-256x85: SKIP (0.038s)
[436.819115] [052/130] (580s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[436.938487] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[436.943103] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[437.094008] [053/130] (580s left) perf_pmu (busy-start)
[437.130769] Starting subtest: busy-start
[437.132980] Starting dynamic subtest: rcs0
[439.679494] Dynamic subtest rcs0: SUCCESS (2.550s)
[439.691345] Starting dynamic subtest: bcs0
[442.229565] Dynamic subtest bcs0: SUCCESS (2.548s)
[442.241317] Starting dynamic subtest: vcs0
[445.909334] Dynamic subtest vcs0: SUCCESS (3.677s)
[445.920969] Starting dynamic subtest: vcs1
[449.876096] Dynamic subtest vcs1: SUCCESS (3.965s)
[449.888065] Starting dynamic subtest: vecs0
[453.908205] Dynamic subtest vecs0: SUCCESS (4.030s)
[453.920091] Starting dynamic subtest: ccs0
[456.456193] Dynamic subtest ccs0: SUCCESS (2.547s)
[456.458680] Subtest busy-start: SUCCESS (19.328s)
[456.562926] [054/130] (561s left) gem_spin_batch (spin-each)
[456.613728] Starting subtest: spin-each
[459.980518] Subtest spin-each: SUCCESS (3.364s)
[462.002658] [055/130] (555s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[462.102598] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[462.106647] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[462.231170] [056/130] (555s left) kms_chamelium_frames (hdmi-crc-multiple)
[462.619215] Subtest hdmi-crc-multiple: SKIP (0.000s)
[463.404786] [057/130] (554s left) gen9_exec_parse (bb-start-out)
[463.469984] Subtest bb-start-out: SKIP (0.000s)
[463.556373] [058/130] (554s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[463.664314] Starting subtest: cursorB-vs-flipA-atomic-transitions
[463.668596] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[463.828018] [059/130] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[463.922485] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[463.926765] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[464.060512] [060/130] (554s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[464.155467] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[464.157772] Starting dynamic subtest: pipe-A-eDP-1
[464.181820] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[464.193331] Starting dynamic subtest: pipe-B-eDP-1
[464.215516] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[464.225162] Starting dynamic subtest: pipe-C-eDP-1
[464.246877] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[464.256054] Starting dynamic subtest: pipe-D-eDP-1
[464.277922] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[464.282009] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[466.346105] [061/130] (551s left) kms_flip (absolute-wf_vblank)
[466.439618] Starting subtest: absolute-wf_vblank
[466.442027] Starting dynamic subtest: A-eDP1
[475.176724] Dynamic subtest A-eDP1: SUCCESS (8.737s)
[475.188679] Starting dynamic subtest: B-eDP1
[483.904854] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[483.916650] Starting dynamic subtest: C-eDP1
[492.616519] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[492.627850] Starting dynamic subtest: D-eDP1
[501.364183] Dynamic subtest D-eDP1: SUCCESS (8.746s)
[501.366681] Subtest absolute-wf_vblank: SUCCESS (34.928s)
[502.600704] [062/130] (515s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[502.653537] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[502.760786] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[502.851116] [063/130] (515s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[502.911180] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[502.913488] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[503.043076] [064/130] (515s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[503.141054] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[503.151764] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[503.285444] [065/130] (514s left) kms_cursor_crc (cursor-onscreen-128x42)
[503.493672] Starting subtest: cursor-onscreen-128x42
[503.538869] Subtest cursor-onscreen-128x42: SKIP (0.040s)
[503.773513] [066/130] (514s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[503.862110] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[503.863970] Starting dynamic subtest: pipe-A-eDP-1
[503.910537] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[503.918786] Starting dynamic subtest: pipe-B-eDP-1
[503.964720] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[503.974085] Starting dynamic subtest: pipe-C-eDP-1
[504.021227] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[504.030165] Starting dynamic subtest: pipe-D-eDP-1
[504.077300] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[504.080828] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[506.062763] [067/130] (512s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[506.162285] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[506.164617] Starting dynamic subtest: pipe-A-eDP-1
[506.188094] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[506.198274] Starting dynamic subtest: pipe-B-eDP-1
[506.220169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[506.229073] Starting dynamic subtest: pipe-C-eDP-1
[506.249963] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[506.258485] Starting dynamic subtest: pipe-D-eDP-1
[506.280322] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[506.284722] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[508.345165] [068/130] (510s left) kms_vblank (query-idle)
[508.437207] Starting subtest: query-idle
[508.439087] Starting dynamic subtest: pipe-A-eDP-1
[510.176471] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.740s)
[510.190794] Starting dynamic subtest: pipe-D-eDP-1
[512.576227] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.397s)
[512.578631] Subtest query-idle: SUCCESS (4.140s)
[513.416566] [069/130] (505s left) gem_exec_reloc (basic-cpu-read-active)
[513.472636] Subtest basic-cpu-read-active: SKIP (0.000s)
[513.543073] [070/130] (504s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[513.649775] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[513.654148] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[513.752954] [071/130] (504s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[518.798358] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[518.801022] Starting dynamic subtest: pipe-A-eDP-1
[519.577920] Dynamic subtest pipe-A-eDP-1: SKIP (0.773s)
[519.589047] Starting dynamic subtest: pipe-B-eDP-1
[520.720531] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[520.725105] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.920s)
[521.920579] [072/130] (496s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[522.018590] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[528.133183] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.118s)
[529.325428] [073/130] (489s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[529.415392] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[529.420014] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[529.549119] [074/130] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[529.656195] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[537.006184] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.355s)
[537.179332] [075/130] (481s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[537.285732] Starting subtest: fbc-modesetfrombusy
[541.096704] Subtest fbc-modesetfrombusy: SUCCESS (3.815s)
[542.284271] [076/130] (476s left) gem_tiled_blits (basic)
[542.349443] Subtest basic: SKIP (0.000s)
[542.433541] [077/130] (476s left) gem_eio (context-create)
[542.645541] Starting subtest: context-create
[542.955071] Subtest context-create: SUCCESS (0.310s)
[543.133878] [078/130] (475s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[543.190387] Starting subtest: x-tiled-to-vebox-y-tiled
[543.193971] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[543.394571] [079/130] (475s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[543.503926] Starting subtest: basic-busy-flip-before-cursor-varying-size
[543.508636] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[543.662395] [080/130] (475s left) kms_plane_alpha_blend (alpha-7efc)
[543.763140] Starting subtest: alpha-7efc
[544.040493] Starting dynamic subtest: pipe-A-eDP-1
[544.616204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[544.641061] Starting dynamic subtest: pipe-D-eDP-1
[545.922881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[545.925740] Subtest alpha-7efc: SUCCESS (2.160s)
[546.748367] [081/130] (472s left) i915_selftest (perf)
[548.702054] Starting subtest: perf
[548.704777] Starting dynamic subtest: engine_cs
[551.609915] Dynamic subtest engine_cs: SUCCESS (2.906s)
[551.619180] Starting dynamic subtest: request
[557.002181] Dynamic subtest request: SUCCESS (5.390s)
[557.011340] Starting dynamic subtest: migrate
[559.899229] Dynamic subtest migrate: SUCCESS (2.887s)
[559.909258] Starting dynamic subtest: region
[564.140204] Dynamic subtest region: SUCCESS (4.248s)
[564.142759] Subtest perf: SUCCESS (15.437s)
[564.173751] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[564.174509] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[564.177880] [082/130] (454s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[565.687278] Starting subtest: short-flip-before-cursor-toggle
[566.647563] Subtest short-flip-before-cursor-toggle: SUCCESS (0.958s)
[567.485875] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[567.487019] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[567.490469] [083/130] (451s left) kms_pm_rpm (modeset-lpsp-stress)
[569.110540] Starting subtest: modeset-lpsp-stress
[585.550745] Subtest modeset-lpsp-stress: SUCCESS (16.439s)
[585.662348] [084/130] (433s left) gem_exec_flush (basic-wb-rw-before-default)
[585.735047] Starting subtest: basic-wb-rw-before-default
[591.183095] Subtest basic-wb-rw-before-default: SUCCESS (5.449s)
[591.382349] [085/130] (427s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[591.485700] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[592.254247] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.770s)
[592.404477] [086/130] (426s left) i915_query (query-regions-unallocated)
[592.467602] Starting subtest: query-regions-unallocated
[592.469819] Subtest query-regions-unallocated: SUCCESS (0.000s)
[592.573959] [087/130] (426s left) gem_exec_flush (basic-batch-kernel-default-wb)
[592.634297] Starting subtest: basic-batch-kernel-default-wb
[599.599103] Subtest basic-batch-kernel-default-wb: SUCCESS (6.966s)
[599.798059] [088/130] (419s left) syncobj_wait (multi-wait-all-signaled)
[599.860773] Starting subtest: multi-wait-all-signaled
[599.863021] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[599.977898] [089/130] (419s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[600.076312] Starting subtest: fbc-dirtyfb-ioctl
[600.078606] Starting dynamic subtest: A-eDP-1
[602.673736] Dynamic subtest A-eDP-1: SUCCESS (2.595s)
[602.676082] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.596s)
[603.491970] [090/130] (415s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[608.453470] Starting subtest: psr2-overlay-plane-update-continuous-sf
[608.455880] Starting dynamic subtest: pipe-A-eDP-1
[610.207797] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.755s)
[610.222069] Starting dynamic subtest: pipe-B-eDP-1
[611.941049] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.731s)
[611.943428] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.491s)
[612.780243] [091/130] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[612.884266] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[612.888093] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[613.017955] [092/130] (406s left) kms_fbcon_fbt (fbc-suspend)
[613.081220] Starting subtest: fbc-suspend
[661.038857] Subtest fbc-suspend: SUCCESS (19.072s)
[662.159100] [093/130] (357s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[662.263937] Starting subtest: y-tiled-8bpp-rotate-270
[662.269044] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[662.391661] [094/130] (357s left) gem_exec_schedule (u-submit-early-slice)
[662.465508] Starting subtest: u-submit-early-slice
[662.468207] Starting dynamic subtest: rcs0
[662.497290] Dynamic subtest rcs0: SUCCESS (0.045s)
[662.510074] Starting dynamic subtest: bcs0
[662.530198] Dynamic subtest bcs0: SUCCESS (0.032s)
[662.539599] Starting dynamic subtest: vcs0
[662.567096] Dynamic subtest vcs0: SUCCESS (0.036s)
[662.576925] Starting dynamic subtest: vcs1
[662.600350] Dynamic subtest vcs1: SUCCESS (0.033s)
[662.610379] Starting dynamic subtest: vecs0
[662.633813] Dynamic subtest vecs0: SUCCESS (0.033s)
[662.643190] Starting dynamic subtest: ccs0
[662.670938] Dynamic subtest ccs0: SUCCESS (0.037s)
[662.673458] Subtest u-submit-early-slice: SUCCESS (0.218s)
[663.867519] [095/130] (355s left) vgem_basic (debugfs)
[663.911132] Starting subtest: debugfs
[663.913708] Subtest debugfs: SUCCESS (0.000s)
[663.981742] [096/130] (355s left) gen7_exec_parse (batch-without-end)
[664.041103] Subtest batch-without-end: SKIP (0.000s)
[664.123623] [097/130] (355s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[664.217085] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[686.403984] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.169s)
[686.550657] [098/130] (333s left) dmabuf_sync_file (export-basic)
[686.591498] Starting subtest: export-basic
[686.593548] Subtest export-basic: SUCCESS (0.001s)
[686.659407] [099/130] (332s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[686.743112] Starting subtest: random-ccs-data-y-tiled-ccs
[686.745031] Starting dynamic subtest: pipe-A-eDP-1
[686.766760] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[686.777157] Starting dynamic subtest: pipe-B-eDP-1
[686.798565] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[686.808058] Starting dynamic subtest: pipe-C-eDP-1
[686.829416] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[686.839065] Starting dynamic subtest: pipe-D-eDP-1
[686.861319] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[686.865523] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.006s)
[688.912595] [100/130] (330s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[689.038889] Starting subtest: cursorB-vs-flipB-atomic
[689.044225] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[689.206768] [101/130] (330s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[689.263606] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[689.336009] [102/130] (330s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[689.446107] Starting subtest: protected-encrypted-src-copy-not-readible
[689.556121] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[689.699010] [103/130] (330s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[689.795502] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[689.798021] Starting dynamic subtest: pipe-A-default-mode
[690.957637] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[690.961949] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.163s)
[691.134522] [104/130] (328s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[691.241632] Starting subtest: fbcpsr-tiling-y
[691.246022] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[691.381084] [105/130] (328s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[691.920670] Starting subtest: syncobj-timeline-invalid-flags
[691.923325] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[693.873727] [106/130] (326s left) gem_basic (create-close)
[693.935562] Starting subtest: create-close
[693.940941] Subtest create-close: SUCCESS (0.000s)
[694.057471] [107/130] (325s left) api_intel_allocator (reloc-allocator)
[694.113725] Starting subtest: reloc-allocator
[694.115911] Starting dynamic subtest: basic
[694.120854] Dynamic subtest basic: SUCCESS (0.007s)
[694.130012] Starting dynamic subtest: parallel-one
[694.132057] Dynamic subtest parallel-one: SUCCESS (0.008s)
[694.140971] Starting dynamic subtest: print
[694.143033] Dynamic subtest print: SUCCESS (0.000s)
[694.153046] Starting dynamic subtest: reuse
[694.154964] Dynamic subtest reuse: SUCCESS (0.000s)
[694.164090] Starting dynamic subtest: fork-reopen-allocator
[694.166096] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[694.167954] Subtest reloc-allocator: SUCCESS (0.034s)
[694.274634] [108/130] (325s left) kms_psr (pr-primary-blt)
[694.373328] Starting subtest: pr-primary-blt
[694.378092] Subtest pr-primary-blt: SKIP (0.000s)
[694.454594] [109/130] (325s left) gem_ctx_bad_destroy (double-destroy)
[694.513082] Starting subtest: double-destroy
[694.515448] Subtest double-destroy: SUCCESS (0.000s)
[694.599587] [110/130] (325s left) core_getclient
[694.756304] [111/130] (325s left) syncobj_wait (wait-all-delayed-signal)
[694.810874] Starting subtest: wait-all-delayed-signal
[694.911724] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[695.008595] [112/130] (325s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[695.107112] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[695.110813] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[695.228725] [113/130] (324s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[695.324562] Starting subtest: yf-tiled-16bpp-rotate-0
[695.328980] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[695.461704] [114/130] (324s left) kms_async_flips (test-time-stamp)
[695.554262] Starting subtest: test-time-stamp
[695.939110] Starting dynamic subtest: pipe-A-eDP-1
[696.734161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s)
[697.102851] Starting dynamic subtest: pipe-B-eDP-1
[697.870297] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.772s)
[698.238299] Starting dynamic subtest: pipe-C-eDP-1
[699.003215] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[699.367219] Starting dynamic subtest: pipe-D-eDP-1
[700.134281] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[700.136948] Subtest test-time-stamp: SUCCESS (4.580s)
[701.309642] [115/130] (318s left) kms_invalid_mode (bad-vsync-end)
[701.408507] Starting subtest: bad-vsync-end
[701.411192] Starting dynamic subtest: pipe-A-eDP-1
[701.700536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[701.710448] Starting dynamic subtest: pipe-B-eDP-1
[701.712921] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[701.722317] Starting dynamic subtest: pipe-C-eDP-1
[701.725004] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[701.734456] Starting dynamic subtest: pipe-D-eDP-1
[701.737115] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[701.739978] Subtest bad-vsync-end: SUCCESS (0.295s)
[702.539722] [116/130] (317s left) gem_exec_suspend (basic)
[702.600079] Starting subtest: basic
[702.602764] Starting dynamic subtest: smem
[704.763895] Dynamic subtest smem: SUCCESS (2.161s)
[704.767212] Subtest basic: SUCCESS (2.163s)
[704.960775] [117/130] (315s left) api_intel_bb (blit-noreloc-purge-cache)
[705.014954] Starting subtest: blit-noreloc-purge-cache
[705.033941] Subtest blit-noreloc-purge-cache: SUCCESS (0.019s)
[705.172404] [118/130] (315s left) kms_plane (pixel-format-source-clamping)
[705.261751] Starting subtest: pixel-format-source-clamping
[705.289598] Starting dynamic subtest: pipe-A-plane-0
[710.156556] Dynamic subtest pipe-A-plane-0: SUCCESS (4.867s)
[710.167042] Starting dynamic subtest: pipe-A-plane-3
[712.489573] Dynamic subtest pipe-A-plane-3: SUCCESS (2.333s)
[712.500099] Starting dynamic subtest: pipe-A-plane-5
[712.502182] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[713.615214] Starting dynamic subtest: pipe-B-plane-0
[718.683656] Dynamic subtest pipe-B-plane-0: SUCCESS (5.077s)
[718.695981] Starting dynamic subtest: pipe-B-plane-3
[721.039523] Dynamic subtest pipe-B-plane-3: SUCCESS (2.355s)
[721.051601] Starting dynamic subtest: pipe-B-plane-5
[721.053604] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[721.348218] Subtest pixel-format-source-clamping: SUCCESS (16.084s)
[722.203179] [119/130] (298s left) i915_query (query-topology-kernel-writes)
[722.328832] Starting subtest: query-topology-kernel-writes
[722.331530] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[722.532863] [120/130] (298s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[722.933951] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[723.714606] [121/130] (296s left) gem_exec_reloc (basic-cpu-active)
[723.780490] Subtest basic-cpu-active: SKIP (0.000s)
[723.858575] [122/130] (296s left) gem_exec_fence (concurrent)
[724.036627] Starting subtest: concurrent
[724.041919] Subtest concurrent: SKIP (0.000s)
[725.868633] [123/130] (294s left) perf (short-reads)
[726.024101] Starting subtest: short-reads
[726.039867] Subtest short-reads: SUCCESS (0.016s)
[726.080395] [124/130] (294s left) dumb_buffer (create-clear)
[726.136029] Starting subtest: create-clear
[760.494622] Subtest create-clear: SUCCESS (34.351s)
[760.609927] [125/130] (260s left) kms_psr2_su (page_flip-p010)
[760.668981] Subtest page_flip-P010: SKIP (0.000s)
[760.736646] [126/130] (260s left) i915_pm_rc6_residency (rc6-idle)
[760.799318] Starting subtest: rc6-idle
[760.852053] Starting dynamic subtest: gt0-rcs0
[785.118677] Dynamic subtest gt0-rcs0: SUCCESS (24.268s)
[785.131206] Starting dynamic subtest: gt0-bcs0
[809.328199] Dynamic subtest gt0-bcs0: SUCCESS (24.206s)
[809.340960] Starting dynamic subtest: gt0-ccs0
[833.645133] Dynamic subtest gt0-ccs0: SUCCESS (24.310s)
[833.657277] Starting dynamic subtest: gt1-vcs0
[839.819959] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[839.832919] Starting dynamic subtest: gt1-vecs0
[845.992110] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[845.995317] Subtest rc6-idle: SUCCESS (85.186s)
[846.086349] [127/130] (174s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[846.188068] Starting subtest: plane-scaler-unity-scaling-with-rotation
[846.190129] Starting dynamic subtest: pipe-A
[846.425203] Dynamic subtest pipe-A: SUCCESS (0.240s)
[846.435141] Starting dynamic subtest: pipe-B
[847.724205] Dynamic subtest pipe-B: SUCCESS (1.298s)
[847.735902] Starting dynamic subtest: pipe-C
[849.068289] Dynamic subtest pipe-C: SUCCESS (1.343s)
[849.080173] Starting dynamic subtest: pipe-D
[850.405423] Dynamic subtest pipe-D: SUCCESS (1.336s)
[850.408366] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.219s)
[851.614765] [128/130] (169s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[851.709476] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[851.714418] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[851.819500] [129/130] (169s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[851.937133] Starting subtest: cursor-vs-flip-legacy
[881.169167] Subtest cursor-vs-flip-legacy: SUCCESS (29.222s)
[882.069029] [130/130] (138s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[882.125533] Starting subtest: multi-wait-available-submitted-signaled
[882.128227] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[882.239296] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_exec
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: core_getstats
results: parsing output: 9/ for test: i915_hangman
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_feature_discovery
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_scaling_modes
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
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_frontbuffer_tracking
results: parsing output: 75/ for test: gem_tiled_blits
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_plane_alpha_blend
results: parsing output: 80/ for test: i915_selftest
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_query
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_dirtyfb
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_fbcon_fbt
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: gen7_exec_parse
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: dmabuf_sync_file
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_basic
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: core_getclient
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: gem_exec_suspend
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_chamelium_edid
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: dumb_buffer
results: parsing output: 124/ for test: kms_psr2_su
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: syncobj_timeline
Done.