[59.185897] Initializing watchdogs
[59.185942]   /dev/watchdog0
[59.199117] [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]
[59.203681] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.206181] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.209601] [001/132] (960s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[59.333611] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[59.335911] Starting dynamic subtest: pipe-A-eDP-1
[59.360586] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.369644] Starting dynamic subtest: pipe-B-eDP-1
[59.392807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.399227] Starting dynamic subtest: pipe-C-eDP-1
[59.422658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.430596] Starting dynamic subtest: pipe-D-eDP-1
[59.454520] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.458621] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[61.644303] [002/132] (958s left) perf (mi-rpc)
[61.773098] Starting subtest: mi-rpc
[61.777094] Subtest mi-rpc: SKIP (0.000s)
[61.815445] [003/132] (957s left) gem_mmap_gtt (isolation)
[61.867304] Subtest isolation: SKIP (0.000s)
[61.937716] [004/132] (957s left) api_intel_allocator (fork-simple-stress-signal)
[62.005777] Starting subtest: fork-simple-stress-signal
[67.462701] Subtest fork-simple-stress-signal: SUCCESS (5.406s)
[67.753833] [005/132] (952s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[67.931129] Starting subtest: fbc-psr-cursor-mmap-cpu
[67.933548] Starting dynamic subtest: eDP-1
[67.938038] Dynamic subtest eDP-1: SKIP (0.000s)
[67.942610] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[68.057094] [006/132] (951s left) gem_exec_reloc (basic-concurrent16)
[68.189693] Subtest basic-concurrent16: SKIP (0.000s)
[68.449935] [007/132] (951s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[68.631978] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[68.637065] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[68.812292] [008/132] (951s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[68.974674] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[69.173308] [009/132] (950s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[69.387848] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[69.392552] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[69.654315] [010/132] (950s left) sysfs_preempt_timeout (invalid)
[69.775384] Starting subtest: invalid
[69.778578] Starting dynamic subtest: vecs0
[69.781686] Dynamic subtest vecs0: SUCCESS (0.001s)
[69.791485] Starting dynamic subtest: ccs0
[69.793654] Dynamic subtest ccs0: SUCCESS (0.000s)
[69.800152] Starting dynamic subtest: vcs0
[69.802188] Dynamic subtest vcs0: SUCCESS (0.001s)
[69.808572] Starting dynamic subtest: bcs0
[69.810602] Dynamic subtest bcs0: SUCCESS (0.001s)
[69.817643] Starting dynamic subtest: rcs0
[69.819706] Dynamic subtest rcs0: SUCCESS (0.001s)
[69.826134] Starting dynamic subtest: vcs1
[69.828090] Dynamic subtest vcs1: SUCCESS (0.001s)
[69.830057] Subtest invalid: SUCCESS (0.007s)
[69.977074] [011/132] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[70.117322] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[78.861153] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.749s)
[78.971650] [012/132] (941s left) kms_cursor_crc (cursor-offscreen-512x512)
[79.236683] Starting subtest: cursor-offscreen-512x512
[79.241285] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[79.393100] [013/132] (940s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[79.446335] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[79.512212] [014/132] (940s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[79.605101] Starting subtest: fbc-psr2-primary-mmap-cpu
[79.607458] Starting dynamic subtest: eDP-1
[79.611690] Dynamic subtest eDP-1: SKIP (0.000s)
[79.615810] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[79.675484] [015/132] (940s left) kms_fb_coherency (memset-crc)
[79.768732] Starting subtest: memset-crc
[79.770673] Starting dynamic subtest: mmap-offset-wc
[80.178334] Dynamic subtest mmap-offset-wc: SUCCESS (0.411s)
[80.470110] Starting dynamic subtest: mmap-offset-uc
[86.472117] Dynamic subtest mmap-offset-uc: SUCCESS (6.008s)
[86.768733] Subtest memset-crc: SUCCESS (7.000s)
[87.600859] [016/132] (932s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[87.712566] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[94.326286] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.615s)
[94.449868] [017/132] (926s left) gem_mmap (pf-nonblock)
[94.519454] Subtest pf-nonblock: SKIP (0.000s)
[94.584732] [018/132] (925s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[94.674057] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[94.676402] Starting dynamic subtest: pipe-A
[94.696126] Dynamic subtest pipe-A: SKIP (0.018s)
[94.704710] Starting dynamic subtest: pipe-B
[94.746711] Dynamic subtest pipe-B: SKIP (0.046s)
[94.755598] Starting dynamic subtest: pipe-C
[94.777413] Dynamic subtest pipe-C: SKIP (0.035s)
[94.784816] Starting dynamic subtest: pipe-D
[94.807485] Dynamic subtest pipe-D: SKIP (0.030s)
[94.812060] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.131s)
[94.914992] [019/132] (925s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[95.013154] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[95.017195] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[95.077081] [020/132] (925s left) kms_flip (2x-nonexisting-fb-interruptible)
[95.164078] Starting subtest: 2x-nonexisting-fb-interruptible
[95.175846] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[95.244807] [021/132] (925s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[95.329768] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[95.333647] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[95.394097] [022/132] (925s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[95.492555] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[95.496038] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[95.579405] [023/132] (925s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[95.667212] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[95.669211] Starting dynamic subtest: pipe-A-eDP-1
[96.498329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s)
[96.506874] Starting dynamic subtest: pipe-B-eDP-1
[98.092771] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s)
[98.101501] Starting dynamic subtest: pipe-C-eDP-1
[99.557513] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.466s)
[99.566161] Starting dynamic subtest: pipe-D-eDP-1
[101.006411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.445s)
[101.008754] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.329s)
[102.207457] [024/132] (918s left) syncobj_timeline (device-signal-unordered)
[102.279304] Starting subtest: device-signal-unordered
[102.281750] Subtest device-signal-unordered: SUCCESS (0.002s)
[102.379800] [025/132] (918s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[102.679066] Starting subtest: parallel-dmabuf-import-out-fence
[103.798364] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.120s)
[103.898837] [026/132] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[104.000780] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[104.004966] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[104.092865] [027/132] (916s left) gem_exec_schedule (semaphore-user)
[104.174238] Starting subtest: semaphore-user
[104.229415] Subtest semaphore-user: SUCCESS (0.059s)
[105.929147] [028/132] (915s left) gem_ctx_engines (execute-one)
[105.986629] Starting subtest: execute-one
[109.322063] Subtest execute-one: SUCCESS (3.336s)
[109.505501] [029/132] (911s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[109.605383] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[109.609418] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[109.683700] [030/132] (911s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[109.738989] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[109.741445] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[109.817548] [031/132] (911s left) gem_userptr_blits (probe)
[109.878599] Starting subtest: probe
[109.952366] Subtest probe: SUCCESS (0.074s)
[110.051698] [032/132] (911s left) gem_spin_batch (engines)
[110.108749] Starting subtest: engines
[110.110719] Starting dynamic subtest: rcs0
[113.350781] Dynamic subtest rcs0: SUCCESS (3.239s)
[113.360798] Starting dynamic subtest: bcs0
[116.595046] Dynamic subtest bcs0: SUCCESS (3.234s)
[116.602566] Starting dynamic subtest: vcs0
[119.875688] Dynamic subtest vcs0: SUCCESS (3.236s)
[119.888512] Starting dynamic subtest: vcs1
[123.115579] Dynamic subtest vcs1: SUCCESS (3.238s)
[123.125377] Starting dynamic subtest: vecs0
[126.352808] Dynamic subtest vecs0: SUCCESS (3.236s)
[126.363191] Starting dynamic subtest: ccs0
[129.590183] Dynamic subtest ccs0: SUCCESS (3.236s)
[129.592429] Subtest engines: SUCCESS (19.429s)
[129.762953] [033/132] (891s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[129.859408] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[133.479953] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.626s)
[134.601745] [034/132] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[134.694916] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[134.698974] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[134.793213] [035/132] (886s left) gem_ctx_bad_destroy (invalid-default-ctx)
[134.846561] Starting subtest: invalid-default-ctx
[134.848934] Subtest invalid-default-ctx: SUCCESS (0.000s)
[134.921020] [036/132] (886s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[135.040388] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[136.003647] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.963s)
[136.814134] [037/132] (884s left) i915_suspend (forcewake)
[136.863306] Starting subtest: forcewake
[168.687270] Subtest forcewake: SUCCESS (3.283s)
[168.759892] [038/132] (852s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[168.865339] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[168.869522] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[168.940180] [039/132] (852s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[169.035314] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[169.037636] Starting dynamic subtest: pipe-A-eDP-1
[169.061140] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.070526] Starting dynamic subtest: pipe-B-eDP-1
[169.092401] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.100098] Starting dynamic subtest: pipe-C-eDP-1
[169.121804] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.129713] Starting dynamic subtest: pipe-D-eDP-1
[169.151817] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.156630] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[171.213501] [040/132] (850s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[171.589176] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[172.419934] [041/132] (849s left) gem_exec_reloc (basic-write-wc-active)
[172.487331] Subtest basic-write-wc-active: SKIP (0.000s)
[172.552033] [042/132] (848s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[172.640261] Starting subtest: fbcpsr-tiling-y
[172.644174] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[172.727317] [043/132] (848s left) prime_mmap (test_errors)
[172.775143] Starting subtest: test_errors
[172.777405] Starting dynamic subtest: test_errors-smem
[172.868065] Dynamic subtest test_errors-smem: SUCCESS (0.095s)
[172.870607] Subtest test_errors: SUCCESS (0.095s)
[172.976346] [044/132] (848s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[173.035018] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[173.137863] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[173.225020] [045/132] (848s left) kms_vblank (accuracy-idle)
[173.310353] Starting subtest: accuracy-idle
[173.312658] Starting dynamic subtest: pipe-A-eDP-1
[175.077739] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.765s)
[175.091557] Starting dynamic subtest: pipe-D-eDP-1
[177.485934] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.407s)
[177.488324] Subtest accuracy-idle: SUCCESS (4.176s)
[178.309867] [046/132] (843s left) syncobj_wait (multi-wait-signaled)
[178.365110] Starting subtest: multi-wait-signaled
[178.367047] Subtest multi-wait-signaled: SUCCESS (0.000s)
[178.451581] [047/132] (843s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[178.551117] Starting subtest: y-tiled-64bpp-rotate-0
[178.555308] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[178.644345] [048/132] (843s left) gem_ccs (block-copy-compressed)
[178.699796] Starting subtest: block-copy-compressed
[178.704236] Subtest block-copy-compressed: SKIP (0.000s)
[178.797178] [049/132] (842s left) syncobj_wait (single-wait-submitted)
[178.854763] Starting subtest: single-wait-submitted
[178.962426] Subtest single-wait-submitted: SUCCESS (0.106s)
[179.034825] [050/132] (842s left) kms_vrr (negative-basic)
[179.115351] Starting subtest: negative-basic
[179.121942] Starting dynamic subtest: pipe-A-eDP-1
[185.050654] Dynamic subtest pipe-A-eDP-1: FAIL (5.432s)
[185.052596] Subtest negative-basic: FAIL (5.735s)
[185.660364] [051/132] (836s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[185.753155] Starting subtest: x-tiled-64bpp-rotate-270
[185.772892] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[185.872476] [052/132] (836s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[185.964526] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[185.966839] Starting dynamic subtest: pipe-A-eDP-1
[186.048402] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[186.057947] Starting dynamic subtest: pipe-B-eDP-1
[187.224769] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s)
[187.229192] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.264s)
[188.399833] [053/132] (833s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[188.495603] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[188.499746] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[188.591101] [054/132] (833s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[188.656827] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[188.726500] [055/132] (833s left) gem_partial_pwrite_pread (reads-uncached)
[188.803459] Subtest reads-uncached: SKIP (0.000s)
[188.862717] [056/132] (833s left) gen9_exec_parse (batch-without-end)
[188.917199] Subtest batch-without-end: SKIP (0.000s)
[188.985782] [057/132] (833s left) kms_content_protection (lic-type-1)
[189.123569] Starting subtest: lic-type-1
[189.128064] Subtest lic-type-1: SKIP (0.000s)
[189.230062] [058/132] (832s left) gem_userptr_blits (stress-mm-invalidate-close)
[189.307624] Starting subtest: stress-mm-invalidate-close
[191.457547] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[191.568434] [059/132] (830s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[191.629086] Starting subtest: x-tiled-to-vebox-y-tiled
[191.633428] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[191.810891] [060/132] (830s left) syncobj_wait (invalid-signal-zero-handles)
[191.869391] Starting subtest: invalid-signal-zero-handles
[191.871254] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[191.955970] [061/132] (830s left) gem_fence_thrash (bo-write-verify-none)
[191.997626] Starting subtest: bo-write-verify-none
[192.013308] Subtest bo-write-verify-none: SKIP (0.014s)
[192.070794] [062/132] (830s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[192.180413] Starting subtest: psr2-overlay-plane-move-continuous-sf
[192.182611] Starting dynamic subtest: pipe-A-eDP-1
[198.163791] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.986s)
[198.175045] Starting dynamic subtest: pipe-B-eDP-1
[204.878189] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.710s)
[204.880174] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.699s)
[205.750714] [063/132] (816s left) prime_vgem (shrink)
[205.882570] Starting subtest: shrink
[205.897185] Subtest shrink: SUCCESS (0.012s)
[206.002913] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[206.007347] [064/132] (816s left) perf (per-context-mode-unprivileged)
[206.104459] Starting subtest: per-context-mode-unprivileged
[206.109157] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[206.147297] [065/132] (816s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[206.203705] Starting subtest: yf-tiled-to-vebox-x-tiled
[206.208244] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[206.403721] [066/132] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[206.504142] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[206.508280] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[206.599401] [067/132] (815s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[206.707084] Starting subtest: random-ccs-data-y-tiled-ccs
[206.709264] Starting dynamic subtest: pipe-A-eDP-1
[206.734395] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[206.744272] Starting dynamic subtest: pipe-B-eDP-1
[206.767988] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[206.776081] Starting dynamic subtest: pipe-C-eDP-1
[206.800368] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[206.809269] Starting dynamic subtest: pipe-D-eDP-1
[206.832377] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[206.836165] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.006s)
[209.040450] [068/132] (813s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[209.142177] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[209.144541] Starting dynamic subtest: pipe-A-eDP-1
[209.999396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s)
[210.007844] Starting dynamic subtest: pipe-B-eDP-1
[211.537394] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.535s)
[211.546224] Starting dynamic subtest: pipe-C-eDP-1
[213.025896] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s)
[213.035244] Starting dynamic subtest: pipe-D-eDP-1
[214.564582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.537s)
[214.566827] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.415s)
[215.738127] [069/132] (806s left) gem_ctx_persistence (processes)
[215.788449] Starting subtest: processes
[217.438622] Subtest processes: SUCCESS (1.650s)
[217.516533] [070/132] (805s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[217.571977] Starting subtest: multi-wait-all-available-submitted-signaled
[217.574304] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[217.689616] [071/132] (804s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[217.780539] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[217.782954] Starting dynamic subtest: pipe-A
[218.154987] Dynamic subtest pipe-A: SUCCESS (0.374s)
[218.163453] Starting dynamic subtest: pipe-B
[219.537369] Dynamic subtest pipe-B: SUCCESS (1.381s)
[219.547046] Starting dynamic subtest: pipe-C
[220.971316] Dynamic subtest pipe-C: SUCCESS (1.431s)
[220.982371] Starting dynamic subtest: pipe-D
[222.403139] Dynamic subtest pipe-D: SUCCESS (1.430s)
[222.405442] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.624s)
[223.562442] [072/132] (799s left) kms_atomic_transition (plane-all-transition-nonblocking)
[223.658076] Starting subtest: plane-all-transition-nonblocking
[223.660170] Starting dynamic subtest: pipe-A-eDP-1
[226.151074] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[226.468704] Starting dynamic subtest: pipe-B-eDP-1
[229.705425] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.246s)
[230.007695] Subtest plane-all-transition-nonblocking: SUCCESS (6.349s)
[230.828356] [073/132] (791s left) kms_vblank (ts-continuation-idle)
[230.926834] Starting subtest: ts-continuation-idle
[230.929355] Starting dynamic subtest: pipe-A-eDP-1
[231.320930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[231.335097] Starting dynamic subtest: pipe-D-eDP-1
[232.423988] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[232.426424] Subtest ts-continuation-idle: SUCCESS (1.501s)
[233.304472] [074/132] (789s left) api_intel_bb (object-reloc-keep-cache)
[233.363056] Starting subtest: object-reloc-keep-cache
[233.367478] Subtest object-reloc-keep-cache: SKIP (0.003s)
[233.475029] [075/132] (789s left) kms_psr (pr-suspend)
[233.569725] Starting subtest: pr-suspend
[233.574410] Subtest pr-suspend: SKIP (0.000s)
[233.681331] [076/132] (789s left) gem_exec_schedule (preempt-other)
[233.768379] Starting subtest: preempt-other
[233.770680] Starting dynamic subtest: rcs0
[233.839041] Dynamic subtest rcs0: SUCCESS (0.073s)
[233.851576] Starting dynamic subtest: bcs0
[233.907523] Dynamic subtest bcs0: SUCCESS (0.067s)
[233.919802] Starting dynamic subtest: vcs0
[233.975176] Dynamic subtest vcs0: SUCCESS (0.066s)
[233.989216] Starting dynamic subtest: vcs1
[234.041028] Dynamic subtest vcs1: SUCCESS (0.065s)
[234.055766] Starting dynamic subtest: vecs0
[234.107250] Dynamic subtest vecs0: SUCCESS (0.066s)
[234.119814] Starting dynamic subtest: ccs0
[234.172125] Dynamic subtest ccs0: SUCCESS (0.064s)
[234.174602] Subtest preempt-other: SUCCESS (0.407s)
[235.494811] [077/132] (787s left) gem_exec_params (no-bsd)
[235.566424] Starting subtest: no-bsd
[235.568676] Subtest no-bsd: SUCCESS (0.002s)
[237.523917] [078/132] (785s left) kms_pm_dc (dc3co-vpb-simulation)
[238.630876] Starting subtest: dc3co-vpb-simulation
[247.378772] Subtest dc3co-vpb-simulation: SKIP (8.742s)
[247.500091] [079/132] (775s left) gem_exec_whisper (basic-queues-forked)
[247.557223] Starting subtest: basic-queues-forked
[270.734516] Subtest basic-queues-forked: SUCCESS (23.174s)
[270.922526] [080/132] (752s left) sw_sync (alloc_fence_invalid_timeline)
[270.967488] Starting subtest: alloc_fence_invalid_timeline
[270.969775] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[271.017387] [081/132] (752s left) kms_flip (2x-absolute-wf_vblank)
[271.112989] Starting subtest: 2x-absolute-wf_vblank
[271.124073] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[271.225766] [082/132] (751s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[271.791796] Starting subtest: syncobj-stationary-timeline-chain-engines
[271.895743] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.104s)
[273.521590] [083/132] (749s left) kms_flip (plain-flip-interruptible)
[273.624064] Starting subtest: plain-flip-interruptible
[273.626179] Starting dynamic subtest: A-eDP1
[275.312177] Dynamic subtest A-eDP1: SUCCESS (1.686s)
[275.330456] Starting dynamic subtest: B-eDP1
[276.946146] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[276.958733] Starting dynamic subtest: C-eDP1
[278.548659] Dynamic subtest C-eDP1: SUCCESS (1.600s)
[278.558902] Starting dynamic subtest: D-eDP1
[280.167362] Dynamic subtest D-eDP1: SUCCESS (1.617s)
[280.172291] Subtest plain-flip-interruptible: SUCCESS (6.549s)
[281.348525] [084/132] (741s left) kms_pm_rpm (pm-caching)
[283.682180] Starting subtest: pm-caching
[283.687008] Subtest pm-caching: SKIP (0.000s)
[284.069412] [085/132] (739s left) i915_drm_fdinfo (busy)
[284.105717] Starting subtest: busy
[284.108105] Starting dynamic subtest: rcs0
[284.120649] Dynamic subtest rcs0: SKIP (0.013s)
[284.130064] Starting dynamic subtest: bcs0
[284.134434] Dynamic subtest bcs0: SKIP (0.009s)
[284.142690] Starting dynamic subtest: vcs0
[284.146732] Dynamic subtest vcs0: SKIP (0.000s)
[284.154686] Starting dynamic subtest: vcs1
[284.158972] Dynamic subtest vcs1: SKIP (0.000s)
[284.166792] Starting dynamic subtest: vecs0
[284.170691] Dynamic subtest vecs0: SKIP (0.000s)
[284.178448] Starting dynamic subtest: ccs0
[284.182298] Dynamic subtest ccs0: SKIP (0.000s)
[284.186114] Subtest busy: SKIP (0.026s)
[284.222785] [086/132] (739s left) kms_properties (connector-properties-legacy)
[284.307203] Starting subtest: connector-properties-legacy
[284.309480] Starting dynamic subtest: pipe-A-eDP-1
[292.251636] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.942s)
[292.263719] Starting dynamic subtest: pipe-None-DP-1
[292.268050] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[292.276591] Starting dynamic subtest: pipe-None-HDMI-A-1
[292.281131] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[292.290810] Starting dynamic subtest: pipe-None-DP-2
[292.294903] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[292.302809] Starting dynamic subtest: pipe-None-HDMI-A-2
[292.306969] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[292.315397] Starting dynamic subtest: pipe-None-DP-3
[292.320357] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[292.328584] Starting dynamic subtest: pipe-None-DP-4
[292.333215] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[292.335532] Subtest connector-properties-legacy: SUCCESS (7.954s)
[293.119513] [087/132] (730s left) kms_async_flips (alternate-sync-async-flip-atomic)
[293.202084] Starting subtest: alternate-sync-async-flip-atomic
[293.576385] Starting dynamic subtest: pipe-A-eDP-1
[296.409468] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.833s)
[296.783166] Starting dynamic subtest: pipe-B-eDP-1
[299.535765] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[299.913026] Starting dynamic subtest: pipe-C-eDP-1
[302.677050] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[303.049455] Starting dynamic subtest: pipe-D-eDP-1
[305.808387] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[305.810444] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.609s)
[306.988586] [088/132] (716s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[307.092267] Starting subtest: primary-y-tiled-reflect-x-270
[307.096182] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[307.162275] [089/132] (716s left) gem_close (basic)
[307.226573] Starting subtest: basic
[307.228779] Subtest basic: SUCCESS (0.000s)
[307.326337] [090/132] (716s left) perf (oa-exponents)
[307.433712] Starting subtest: oa-exponents
[307.435810] Starting dynamic subtest: 0-rcs0
[309.212969] Dynamic subtest 0-rcs0: SUCCESS (1.781s)
[309.222333] Starting dynamic subtest: 1-vcs1
[311.043285] Dynamic subtest 1-vcs1: SUCCESS (1.829s)
[311.046089] Subtest oa-exponents: SUCCESS (3.612s)
[311.093050] [091/132] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[311.199315] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[311.203298] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[311.291386] [092/132] (712s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[311.395345] Starting subtest: 4-tiled-16bpp-rotate-270
[311.414653] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[311.524268] [093/132] (712s left) kms_cursor_crc (cursor-random-128x128)
[311.745407] Starting subtest: cursor-random-128x128
[311.751175] Starting dynamic subtest: pipe-A-eDP-1
[315.090480] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s)
[315.122551] Starting dynamic subtest: pipe-D-eDP-1
[319.097099] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.984s)
[319.099258] Subtest cursor-random-128x128: SUCCESS (7.352s)
[319.960856] [094/132] (703s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[320.012069] Starting subtest: multi-wait-all-for-submit-signaled
[320.014468] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[320.104281] [095/132] (703s left) kms_psr (psr2-sprite-mmap-cpu)
[320.190073] Starting subtest: psr2-sprite-mmap-cpu
[320.192310] Starting dynamic subtest: eDP-1
[321.875044] Dynamic subtest eDP-1: SUCCESS (1.684s)
[321.877445] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.685s)
[322.734901] [096/132] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[322.839880] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[322.844270] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[322.925437] [097/132] (700s left) syncobj_timeline (signal-array)
[322.982429] Starting subtest: signal-array
[322.984718] Subtest signal-array: SUCCESS (0.000s)
[323.094331] [098/132] (700s left) kms_prop_blob (invalid-set-prop)
[323.151831] Starting subtest: invalid-set-prop
[323.154119] Subtest invalid-set-prop: SUCCESS (0.000s)
[323.259453] [099/132] (700s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[323.347906] Starting subtest: blocking-absolute-wf_vblank-interruptible
[323.350401] Starting dynamic subtest: A-eDP1
[332.121532] Dynamic subtest A-eDP1: SUCCESS (8.741s)
[332.134300] Starting dynamic subtest: B-eDP1
[340.852536] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[340.863167] Starting dynamic subtest: C-eDP1
[349.581639] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[349.591639] Starting dynamic subtest: D-eDP1
[358.265491] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[358.270904] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.920s)
[359.487670] [100/132] (664s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[359.582861] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[367.228446] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.648s)
[367.326794] [101/132] (656s left) kms_addfb_basic (tile-pitch-mismatch)
[367.381926] Starting subtest: tile-pitch-mismatch
[367.386147] Subtest tile-pitch-mismatch: SKIP (0.000s)
[367.515942] [102/132] (656s left) kms_psr (psr-sprite-mmap-cpu)
[367.606066] Starting subtest: psr-sprite-mmap-cpu
[367.608266] Starting dynamic subtest: eDP-1
[369.379315] Dynamic subtest eDP-1: SUCCESS (1.771s)
[369.381551] Subtest psr-sprite-mmap-cpu: SUCCESS (1.772s)
[370.223517] [103/132] (653s left) gem_ctx_isolation (clean)
[370.293581] Starting subtest: clean
[370.296103] Starting dynamic subtest: rcs0
[370.335138] Dynamic subtest rcs0: SUCCESS (0.042s)
[370.344141] Starting dynamic subtest: bcs0
[370.409606] Dynamic subtest bcs0: SUCCESS (0.073s)
[370.419415] Starting dynamic subtest: vcs0
[370.480531] Dynamic subtest vcs0: SUCCESS (0.070s)
[370.493086] Starting dynamic subtest: vcs1
[372.429068] Dynamic subtest vcs1: SUCCESS (1.948s)
[372.440257] Starting dynamic subtest: vecs0
[374.413324] Dynamic subtest vecs0: SUCCESS (1.982s)
[374.424573] Starting dynamic subtest: ccs0
[376.494518] Dynamic subtest ccs0: SUCCESS (2.051s)
[376.497035] Subtest clean: SUCCESS (6.172s)
[376.701061] [104/132] (647s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[377.082330] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[377.930897] [105/132] (646s left) prime_vgem (basic-read)
[378.007815] Starting subtest: basic-read
[378.023630] Subtest basic-read: SKIP (0.014s)
[378.139424] [106/132] (645s left) kms_frontbuffer_tracking (basic)
[378.228394] Starting subtest: basic
[381.526837] Subtest basic: SUCCESS (3.302s)
[381.634322] [107/132] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[381.732181] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[381.735821] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[381.829102] [108/132] (642s left) i915_pm_freq_api (freq-suspend)
[381.902680] Starting subtest: freq-suspend
[381.904575] Starting dynamic subtest: gt0
[397.808631] Dynamic subtest gt0: SUCCESS (1.359s)
[397.819386] Starting dynamic subtest: gt1
[413.692984] Dynamic subtest gt1: SUCCESS (1.222s)
[413.695988] Subtest freq-suspend: SUCCESS (2.583s)
[414.771071] [109/132] (610s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[414.907903] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[419.071089] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.159s)
[420.265297] [110/132] (605s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[420.376421] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[421.067788] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[421.217664] [111/132] (604s left) kms_color (invalid-degamma-lut-sizes)
[421.312020] Starting subtest: invalid-degamma-lut-sizes
[421.314777] Starting dynamic subtest: pipe-A
[421.602955] Dynamic subtest pipe-A: SUCCESS (0.293s)
[421.612690] Starting dynamic subtest: pipe-B
[421.615313] Dynamic subtest pipe-B: SUCCESS (0.000s)
[421.624498] Starting dynamic subtest: pipe-C
[421.627509] Dynamic subtest pipe-C: SUCCESS (0.000s)
[421.639871] Starting dynamic subtest: pipe-D
[421.642141] Dynamic subtest pipe-D: SUCCESS (0.000s)
[421.644605] Subtest invalid-degamma-lut-sizes: SUCCESS (0.297s)
[422.402963] [112/132] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[422.506910] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[422.512004] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[422.606988] [113/132] (602s left) gem_exec_balancer (indices)
[422.681159] Starting subtest: indices
[424.634492] Subtest indices: SUCCESS (1.949s)
[424.938604] [114/132] (600s left) perf_pmu (busy-idle-check-all)
[424.988518] Starting subtest: busy-idle-check-all
[424.991153] Starting dynamic subtest: rcs0
[425.655561] Dynamic subtest rcs0: SUCCESS (0.667s)
[425.668961] Starting dynamic subtest: bcs0
[426.314141] Dynamic subtest bcs0: SUCCESS (0.655s)
[426.326893] Starting dynamic subtest: vcs0
[427.612498] Dynamic subtest vcs0: SUCCESS (1.294s)
[427.625420] Starting dynamic subtest: vcs1
[428.347037] Dynamic subtest vcs1: FAIL (0.641s)
[428.358580] Starting dynamic subtest: vecs0
[429.597670] Dynamic subtest vecs0: SUCCESS (1.337s)
[429.623247] Starting dynamic subtest: ccs0
[430.270595] Dynamic subtest ccs0: SUCCESS (0.670s)
[430.273635] Subtest busy-idle-check-all: FAIL (5.281s)
[430.408520] [115/132] (595s left) kms_cursor_edge_walk (128x128-left-edge)
[430.502862] Starting subtest: 128x128-left-edge
[430.505949] Starting dynamic subtest: pipe-A-eDP-1
[433.993874] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[434.004862] Starting dynamic subtest: pipe-D-eDP-1
[437.204006] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.205s)
[437.206701] Subtest 128x128-left-edge: SUCCESS (6.697s)
[438.010663] [116/132] (587s left) core_setmaster (master-drop-set-user)
[438.099130] Starting subtest: master-drop-set-user
[438.109133] Subtest master-drop-set-user: SUCCESS (0.014s)
[438.149744] [117/132] (587s left) gem_mmap_gtt (basic-small-bo)
[438.202951] Subtest basic-small-bo: SKIP (0.000s)
[438.271237] [118/132] (587s left) gem_exec_reloc (basic-cpu-noreloc)
[438.349828] Subtest basic-cpu-noreloc: SKIP (0.000s)
[438.431701] [119/132] (587s left) kms_async_flips (invalid-async-flip)
[438.537945] Starting subtest: invalid-async-flip
[438.911297] Starting dynamic subtest: pipe-A-eDP-1
[439.736082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[440.100933] Starting dynamic subtest: pipe-B-eDP-1
[440.860127] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.768s)
[441.218948] Starting dynamic subtest: pipe-C-eDP-1
[441.979011] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[442.329775] Starting dynamic subtest: pipe-D-eDP-1
[443.103836] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[443.106310] Subtest invalid-async-flip: SUCCESS (4.564s)
[444.261436] [120/132] (581s left) i915_pm_rpm (debugfs-forcewake-user)
[445.779953] Starting subtest: debugfs-forcewake-user
[457.172951] Subtest debugfs-forcewake-user: SUCCESS (11.397s)
[457.542124] [121/132] (568s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[457.648907] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[457.654017] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[457.722037] [122/132] (568s left) kms_dp_link_training (uhbr-mst)
[457.820141] Starting subtest: uhbr-mst
[457.830894] Subtest uhbr-mst: SKIP (0.000s)
[457.893339] [123/132] (567s left) kms_big_fb (linear-32bpp-rotate-90)
[457.999514] Starting subtest: linear-32bpp-rotate-90
[458.018786] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[458.147623] [124/132] (567s left) gem_render_copy_redux (flink-interruptible)
[458.204053] Starting subtest: flink-interruptible
[458.966638] Subtest flink-interruptible: SUCCESS (0.763s)
[459.108690] [125/132] (566s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[459.201815] Starting subtest: psr-rgb101010-draw-blt
[466.562598] Subtest psr-rgb101010-draw-blt: SUCCESS (7.363s)
[466.671589] [126/132] (559s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[466.778637] Starting subtest: disable-crc-after-crtc
[466.780870] Starting dynamic subtest: pipe-A-eDP-1
[468.474920] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.697s)
[468.485514] Starting dynamic subtest: pipe-B-eDP-1
[470.861193] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.382s)
[470.871446] Starting dynamic subtest: pipe-C-eDP-1
[473.115013] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.255s)
[473.127553] Starting dynamic subtest: pipe-D-eDP-1
[475.381404] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.264s)
[475.384056] Subtest disable-crc-after-crtc: SUCCESS (8.604s)
[476.221999] [127/132] (549s left) kms_lease (multimaster-lease)
[476.330900] Starting subtest: multimaster-lease
[476.333621] Subtest multimaster-lease: SUCCESS (0.003s)
[476.436566] [128/132] (549s left) gem_exec_whisper (basic-fds-all)
[476.502707] Starting subtest: basic-fds-all
[486.765498] Subtest basic-fds-all: SUCCESS (10.260s)
[486.955810] [129/132] (539s left) kms_invalid_mode (bad-hsync-start)
[487.061860] Starting subtest: bad-hsync-start
[487.064487] Starting dynamic subtest: pipe-A-eDP-1
[487.341440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[487.353009] Starting dynamic subtest: pipe-B-eDP-1
[487.355514] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[487.365122] Starting dynamic subtest: pipe-C-eDP-1
[487.367934] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[487.377415] Starting dynamic subtest: pipe-D-eDP-1
[487.380161] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[487.383014] Subtest bad-hsync-start: SUCCESS (0.288s)
[488.149860] [130/132] (538s left) gem_partial_pwrite_pread (writes-after-reads-display)
[488.223156] Subtest writes-after-reads-display: SKIP (0.000s)
[488.294792] [131/132] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[488.387012] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[488.392325] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[488.483529] [132/132] (537s left) gem_mmap_gtt (medium-copy-odd)
[488.549715] Subtest medium-copy-odd: SKIP (0.000s)
[488.610559] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: sysfs_preempt_timeout
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_fb_coherency
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_mmap
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_ctx_engines
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_spin_batch
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_bad_destroy
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: i915_suspend
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_chamelium_hpd
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: prime_mmap
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_ccs
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_vrr
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_partial_pwrite_pread
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: gem_fence_thrash
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_atomic_transition
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_pm_dc
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: sw_sync
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_properties
results: parsing output: 86/ for test: kms_async_flips
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: gem_close
results: parsing output: 89/ for test: perf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_prop_blob
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_ctx_isolation
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: prime_vgem
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_pm_freq_api
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_color
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_cursor_edge_walk
results: parsing output: 115/ for test: core_setmaster
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_dp_link_training
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_render_copy_redux
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_invalid_mode
results: parsing output: 129/ for test: gem_partial_pwrite_pread
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_gtt
Done.