[58.131857] Initializing watchdogs
[58.131903]   /dev/watchdog0
[58.146598] [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]
[58.151429] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.153974] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.155974] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[58.250706] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[58.252381] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[58.334278] [002/132] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[58.420950] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[65.401052] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.982s)
[65.516054] [003/132] (953s left) syncobj_timeline (multi-wait-available-signaled)
[65.566342] Starting subtest: multi-wait-available-signaled
[65.567277] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[65.662755] [004/132] (953s left) gem_eio (wait-wedge-10ms)
[65.802860] Starting subtest: wait-wedge-10ms
[66.941676] Subtest wait-wedge-10ms: SUCCESS (1.139s)
[67.312736] [005/132] (951s left) gem_ctx_param (non-root-set)
[67.538205] Starting subtest: non-root-set
[67.607993] Subtest non-root-set: SUCCESS (0.079s)
[67.709493] [006/132] (951s left) core_setmaster (master-drop-set-shared-fd)
[67.811482] Starting subtest: master-drop-set-shared-fd
[67.833471] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[67.869055] [007/132] (951s left) gem_wait (write-wait)
[68.035073] Starting subtest: write-wait
[68.036117] Starting dynamic subtest: all-engines
[69.274056] Dynamic subtest all-engines: SUCCESS (1.239s)
[69.288620] Starting dynamic subtest: rcs0
[70.332028] Dynamic subtest rcs0: SUCCESS (1.057s)
[70.347450] Starting dynamic subtest: bcs0
[71.388613] Dynamic subtest bcs0: SUCCESS (1.056s)
[71.402842] Starting dynamic subtest: vcs0
[72.442083] Dynamic subtest vcs0: SUCCESS (1.052s)
[72.455855] Starting dynamic subtest: vcs1
[73.493870] Dynamic subtest vcs1: SUCCESS (1.051s)
[73.508482] Starting dynamic subtest: vecs0
[74.546051] Dynamic subtest vecs0: SUCCESS (1.051s)
[74.560314] Starting dynamic subtest: ccs0
[75.601851] Dynamic subtest ccs0: SUCCESS (1.055s)
[75.603159] Subtest write-wait: SUCCESS (7.567s)
[75.789651] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[75.791450] [008/132] (943s left) gem_softpin (noreloc-interruptible)
[75.849748] Starting subtest: noreloc-interruptible
[81.307645] Subtest noreloc-interruptible: SUCCESS (5.413s)
[81.407531] [009/132] (937s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[81.986038] Starting subtest: syncobj-backward-timeline-chain-engines
[82.173707] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.188s)
[82.991171] [010/132] (936s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[83.089198] Starting subtest: y-tiled-16bpp-rotate-90
[83.090831] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[83.187282] [011/132] (935s left) gem_exec_create (forked)
[83.248689] Starting subtest: forked
[83.249662] Starting dynamic subtest: smem
[103.904865] Dynamic subtest smem: SUCCESS (20.646s)
[103.906382] Subtest forked: SUCCESS (20.648s)
[104.089512] [012/132] (914s left) gem_ctx_bad_destroy (invalid-pad)
[104.139927] Starting subtest: invalid-pad
[104.140880] Subtest invalid-pad: SUCCESS (0.000s)
[104.207877] [013/132] (914s left) kms_invalid_mode (zero-hdisplay)
[104.290947] Starting subtest: zero-hdisplay
[104.291878] Starting dynamic subtest: pipe-A-eDP-1
[104.577728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[104.584180] Starting dynamic subtest: pipe-B-eDP-1
[104.584983] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[104.590762] Starting dynamic subtest: pipe-C-eDP-1
[104.591628] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[104.597394] Starting dynamic subtest: pipe-D-eDP-1
[104.598401] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[104.599257] Subtest zero-hdisplay: SUCCESS (0.292s)
[105.433977] [014/132] (913s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[105.577088] Starting subtest: dp-mst-type-0-suspend-resume
[105.578901] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[105.702130] [015/132] (913s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[105.747112] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[105.849429] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[105.916967] [016/132] (913s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[106.032486] Starting subtest: 2x-long-cursor-vs-flip-legacy
[106.034866] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[106.170841] [017/132] (913s left) kms_busy (extended-modeset-hang-oldfb)
[106.258766] Starting subtest: extended-modeset-hang-oldfb
[106.259570] Starting dynamic subtest: pipe-A
[118.219621] Dynamic subtest pipe-A: SUCCESS (11.960s)
[118.229799] Starting dynamic subtest: pipe-D
[130.492815] Dynamic subtest pipe-D: SUCCESS (12.271s)
[130.493602] Subtest extended-modeset-hang-oldfb: SUCCESS (24.235s)
[131.285940] [018/132] (887s left) kms_psr (pr-sprite-blt)
[131.370176] Starting subtest: pr-sprite-blt
[131.371836] Subtest pr-sprite-blt: SKIP (0.000s)
[131.437542] [019/132] (887s left) gem_exec_capture (capture)
[131.485045] Starting subtest: capture
[131.485942] Starting dynamic subtest: rcs0-smem
[132.299328] Dynamic subtest rcs0-smem: SUCCESS (0.814s)
[132.307375] Starting dynamic subtest: bcs0-smem
[133.151564] Dynamic subtest bcs0-smem: SUCCESS (0.853s)
[133.159053] Starting dynamic subtest: vcs0-smem
[133.981741] Dynamic subtest vcs0-smem: SUCCESS (0.830s)
[133.988159] Starting dynamic subtest: vcs1-smem
[134.804798] Dynamic subtest vcs1-smem: SUCCESS (0.823s)
[134.813630] Starting dynamic subtest: vecs0-smem
[136.150660] Dynamic subtest vecs0-smem: FAIL (1.325s)
[136.157836] Starting dynamic subtest: ccs0-smem
[137.454592] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[137.455560] Subtest capture: FAIL (5.971s)
[137.577197] [020/132] (881s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[137.668909] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[137.669841] Starting dynamic subtest: pipe-A-eDP-1
[138.955253] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.286s)
[138.962994] Starting dynamic subtest: pipe-B-eDP-1
[141.353542] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.397s)
[141.360985] Starting dynamic subtest: pipe-C-eDP-1
[143.695396] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.341s)
[143.703146] Starting dynamic subtest: pipe-D-eDP-1
[146.002688] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.306s)
[146.003536] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.334s)
[147.138874] [021/132] (872s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[147.233125] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[147.234036] Starting dynamic subtest: pipe-A
[147.251997] Dynamic subtest pipe-A: SKIP (0.017s)
[147.262146] Starting dynamic subtest: pipe-B
[147.283957] Dynamic subtest pipe-B: SKIP (0.031s)
[147.295541] Starting dynamic subtest: pipe-C
[147.315502] Dynamic subtest pipe-C: SKIP (0.032s)
[147.321899] Starting dynamic subtest: pipe-D
[147.348591] Dynamic subtest pipe-D: SKIP (0.033s)
[147.350074] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.115s)
[147.451430] [022/132] (871s left) gem_wait (invalid-buf)
[147.501986] Starting subtest: invalid-buf
[147.502912] Subtest invalid-buf: SUCCESS (0.000s)
[147.697840] [023/132] (871s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[147.809661] Starting subtest: cursorB-vs-flipB-atomic
[147.811511] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[147.950289] [024/132] (871s left) gem_exec_schedule (pi-ringfull)
[148.133556] Starting subtest: pi-ringfull
[148.134591] Starting dynamic subtest: rcs0
[148.160842] Dynamic subtest rcs0: SUCCESS (0.036s)
[148.180779] Starting dynamic subtest: bcs0
[148.200791] Dynamic subtest bcs0: SUCCESS (0.040s)
[148.208056] Starting dynamic subtest: vcs0
[148.237925] Dynamic subtest vcs0: SUCCESS (0.037s)
[148.244316] Starting dynamic subtest: vcs1
[148.270970] Dynamic subtest vcs1: SUCCESS (0.033s)
[148.277236] Starting dynamic subtest: vecs0
[148.301863] Dynamic subtest vecs0: SUCCESS (0.030s)
[148.307988] Starting dynamic subtest: ccs0
[148.332065] Dynamic subtest ccs0: SUCCESS (0.030s)
[148.332815] Subtest pi-ringfull: SUCCESS (0.208s)
[148.553279] [025/132] (870s left) i915_selftest (mock)
[151.807034] Starting subtest: mock
[151.808196] Starting dynamic subtest: sanitycheck
[152.483647] Dynamic subtest sanitycheck: SUCCESS (0.677s)
[152.491343] Starting dynamic subtest: shmem
[153.156592] Dynamic subtest shmem: SUCCESS (0.670s)
[153.164198] Starting dynamic subtest: fence
[161.039135] Dynamic subtest fence: SUCCESS (7.882s)
[161.046899] Starting dynamic subtest: scatterlist
[162.747054] Dynamic subtest scatterlist: SUCCESS (1.706s)
[162.755903] Starting dynamic subtest: syncmap
[165.888086] Dynamic subtest syncmap: SUCCESS (3.139s)
[165.896095] Starting dynamic subtest: uncore
[166.578503] Dynamic subtest uncore: SUCCESS (0.690s)
[166.585801] Starting dynamic subtest: ring
[167.280449] Dynamic subtest ring: SUCCESS (0.701s)
[167.288356] Starting dynamic subtest: engine
[167.945384] Dynamic subtest engine: SUCCESS (0.664s)
[167.953147] Starting dynamic subtest: timelines
[171.835264] Dynamic subtest timelines: SUCCESS (3.888s)
[171.842795] Starting dynamic subtest: requests
[175.543668] Dynamic subtest requests: SUCCESS (3.707s)
[175.551249] Starting dynamic subtest: objects
[176.292376] Dynamic subtest objects: SUCCESS (0.749s)
[176.299672] Starting dynamic subtest: phys
[177.077561] Dynamic subtest phys: SUCCESS (0.784s)
[177.092687] Starting dynamic subtest: dmabuf
[177.868726] Dynamic subtest dmabuf: SUCCESS (0.790s)
[177.876298] Starting dynamic subtest: vma
[183.630089] Dynamic subtest vma: SUCCESS (5.759s)
[183.637855] Starting dynamic subtest: evict
[185.155263] Dynamic subtest evict: SUCCESS (1.525s)
[185.161162] Starting dynamic subtest: gtt
[188.373493] Dynamic subtest gtt: SUCCESS (3.217s)
[188.380848] Starting dynamic subtest: hugepages
[189.278084] Dynamic subtest hugepages: SUCCESS (0.904s)
[189.286464] Starting dynamic subtest: memory_region
[191.827906] Dynamic subtest memory_region: SUCCESS (2.549s)
[191.829601] Subtest mock: SUCCESS (40.018s)
[191.849399] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[191.850194] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[191.851686] [026/132] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[193.436063] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[200.886683] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.451s)
[201.026006] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[201.027265] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[201.029259] [027/132] (818s left) syncobj_timeline (wait-for-submit-delayed-submit)
[201.080076] Starting subtest: wait-for-submit-delayed-submit
[201.183405] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[201.267486] [028/132] (818s left) kms_flip (2x-plain-flip-ts-check)
[201.360453] Starting subtest: 2x-plain-flip-ts-check
[201.372551] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[201.445035] [029/132] (818s left) syncobj_wait (reset-signaled)
[201.492304] Starting subtest: reset-signaled
[201.493219] Subtest reset-signaled: SUCCESS (0.000s)
[201.581281] [030/132] (818s left) kms_psr (fbc-pr-primary-render)
[201.668540] Starting subtest: fbc-pr-primary-render
[201.670203] Subtest fbc-pr-primary-render: SKIP (0.000s)
[201.733928] [031/132] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[201.820378] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[201.822317] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[201.904009] [032/132] (817s left) gem_mmap_offset (open-flood)
[201.950044] Starting subtest: open-flood
[223.439358] Subtest open-flood: SUCCESS (21.489s)
[223.552960] [033/132] (796s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[223.664990] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[223.665980] Starting dynamic subtest: pipe-A-eDP-1
[223.674888] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.682203] Starting dynamic subtest: pipe-B-eDP-1
[223.690258] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.698467] Starting dynamic subtest: pipe-C-eDP-1
[223.706222] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.712129] Starting dynamic subtest: pipe-D-eDP-1
[223.720231] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.721759] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[225.931894] [034/132] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[226.037350] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[226.038986] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[226.115861] [035/132] (793s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[226.161060] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[226.161894] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[226.256468] [036/132] (793s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[226.342701] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[227.354206] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.012s)
[227.475382] [037/132] (792s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[227.569816] Starting subtest: x-tiled-8bpp-rotate-90
[227.592163] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[227.701388] [038/132] (792s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[227.797782] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[227.799436] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[227.889853] [039/132] (792s left) perf (gen12-mi-rpc)
[228.041923] Starting subtest: gen12-mi-rpc
[228.042807] Starting dynamic subtest: rcs0
[228.059012] Dynamic subtest rcs0: SUCCESS (0.017s)
[228.059898] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[228.101216] [040/132] (791s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[228.215792] Starting subtest: yf-tiled-8bpp-rotate-0
[228.217787] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[228.318657] [041/132] (791s left) kms_dsc (dsc-with-bpc-formats)
[228.408381] Starting subtest: dsc-with-bpc-formats
[228.460313] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[228.488323] [042/132] (791s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[228.609932] Starting subtest: cursorB-vs-flipA-atomic-transitions
[228.612961] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[228.760925] [043/132] (791s left) kms_sequence (get-forked-busy)
[228.847179] Starting subtest: get-forked-busy
[228.848105] Starting dynamic subtest: pipe-A-eDP-1
[230.783440] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[230.790233] Starting dynamic subtest: pipe-B-eDP-1
[233.442802] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.660s)
[233.450145] Starting dynamic subtest: pipe-C-eDP-1
[236.061819] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.617s)
[236.068315] Starting dynamic subtest: pipe-D-eDP-1
[238.699791] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.637s)
[238.700707] Subtest get-forked-busy: SUCCESS (9.853s)
[239.573484] [044/132] (780s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[239.658802] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[239.659906] Starting dynamic subtest: pipe-A-eDP-1
[239.663257] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.670349] Starting dynamic subtest: pipe-B-eDP-1
[239.674086] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.680199] Starting dynamic subtest: pipe-C-eDP-1
[239.683806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.689981] Starting dynamic subtest: pipe-D-eDP-1
[239.693537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.695113] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[241.944955] [045/132] (778s left) gem_exec_balancer (hog)
[242.006084] Starting subtest: hog
[242.007760] Subtest hog: SKIP (0.000s)
[242.309745] [046/132] (777s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[242.400618] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[242.402333] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[242.466353] [047/132] (777s left) syncobj_basic (bad-fd-to-handle)
[242.515592] Starting subtest: bad-fd-to-handle
[242.516426] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[242.608307] [048/132] (777s left) api_intel_allocator (open-vm)
[242.666568] Starting subtest: open-vm
[242.668050] Subtest open-vm: SUCCESS (0.003s)
[242.777745] [049/132] (777s left) gem_ctx_isolation (nonpriv)
[242.835259] Starting subtest: nonpriv
[242.836094] Starting dynamic subtest: rcs0
[243.077708] Dynamic subtest rcs0: SUCCESS (0.243s)
[243.087802] Starting dynamic subtest: bcs0
[243.322501] Dynamic subtest bcs0: SUCCESS (0.244s)
[243.331694] Starting dynamic subtest: vcs0
[243.588366] Dynamic subtest vcs0: SUCCESS (0.265s)
[243.597273] Starting dynamic subtest: vcs1
[245.120077] Dynamic subtest vcs1: SUCCESS (1.531s)
[245.126647] Starting dynamic subtest: vecs0
[247.163205] Dynamic subtest vecs0: SUCCESS (2.042s)
[247.172345] Starting dynamic subtest: ccs0
[249.181374] Dynamic subtest ccs0: SUCCESS (2.017s)
[249.182918] Subtest nonpriv: SUCCESS (6.347s)
[249.423785] [050/132] (770s left) syncobj_timeline (invalid-signal-illegal-point)
[249.483273] Starting subtest: invalid-signal-illegal-point
[249.484151] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[249.572530] [051/132] (770s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[249.657070] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[249.658936] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[249.730067] [052/132] (770s left) prime_busy (before-wait)
[249.787255] Starting subtest: before-wait
[249.790764] Starting dynamic subtest: rcs0
[249.822166] Dynamic subtest rcs0: SUCCESS (0.031s)
[249.830735] Starting dynamic subtest: bcs0
[249.873171] Dynamic subtest bcs0: SUCCESS (0.050s)
[249.879357] Starting dynamic subtest: vcs0
[249.915691] Dynamic subtest vcs0: SUCCESS (0.042s)
[249.923290] Starting dynamic subtest: vcs1
[249.956268] Dynamic subtest vcs1: SUCCESS (0.040s)
[249.963050] Starting dynamic subtest: vecs0
[249.996109] Dynamic subtest vecs0: SUCCESS (0.039s)
[250.002171] Starting dynamic subtest: ccs0
[250.036435] Dynamic subtest ccs0: SUCCESS (0.039s)
[250.144475] Subtest before-wait: SUCCESS (0.356s)
[250.225887] [053/132] (770s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[250.310081] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[250.311067] Starting dynamic subtest: pipe-A-eDP-1
[250.319683] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[250.328074] Starting dynamic subtest: pipe-B-eDP-1
[250.335990] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[250.342435] Starting dynamic subtest: pipe-C-eDP-1
[250.350068] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[250.356337] Starting dynamic subtest: pipe-D-eDP-1
[250.363816] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[250.364662] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[252.593782] [054/132] (767s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[252.677226] Starting subtest: fb-8bpc-vs-panel-6bpc
[252.678046] Starting dynamic subtest: pipe-A-eDP-1
[254.073256] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.395s)
[254.074032] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.397s)
[254.936085] [055/132] (765s left) core_auth (getclient-master-drop)
[254.967392] Starting subtest: getclient-master-drop
[254.983492] Subtest getclient-master-drop: SUCCESS (0.016s)
[255.070665] [056/132] (765s left) gem_exec_gttfill (all-engines)
[255.130964] Starting subtest: all-engines
[278.330622] Subtest all-engines: SUCCESS (23.198s)
[278.515082] [057/132] (742s left) kms_chamelium_hpd (common-hpd-after-suspend)
[278.946473] Subtest common-hpd-after-suspend: SKIP (0.000s)
[279.740796] [058/132] (740s left) kms_vblank (ts-continuation-modeset-hang)
[279.836681] Starting subtest: ts-continuation-modeset-hang
[279.837810] Starting dynamic subtest: pipe-A-eDP-1
[306.644275] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.804s)
[306.652798] Starting dynamic subtest: pipe-D-eDP-1
[331.680848] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.034s)
[331.681671] Subtest ts-continuation-modeset-hang: SUCCESS (51.843s)
[332.514782] [059/132] (688s left) kms_plane_multiple (2x-tiling-yf)
[332.598203] Starting subtest: 2x-tiling-yf
[332.600020] Subtest 2x-tiling-yf: SKIP (0.000s)
[332.663898] [060/132] (687s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[332.757425] Starting subtest: plane-lut1d-post-ctm3x4
[332.938272] Starting dynamic subtest: pipe-A-plane-0
[333.184814] Dynamic subtest pipe-A-plane-0: FAIL (0.185s)
[333.191946] Starting dynamic subtest: pipe-A-plane-1
[333.407206] Dynamic subtest pipe-A-plane-1: FAIL (0.208s)
[333.414684] Starting dynamic subtest: pipe-A-plane-2
[333.626649] Dynamic subtest pipe-A-plane-2: FAIL (0.201s)
[334.723991] Starting dynamic subtest: pipe-B-plane-0
[335.015298] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[335.022674] Starting dynamic subtest: pipe-B-plane-1
[335.213832] Dynamic subtest pipe-B-plane-1: FAIL (0.188s)
[335.220886] Starting dynamic subtest: pipe-B-plane-2
[335.415166] Dynamic subtest pipe-B-plane-2: FAIL (0.189s)
[336.564854] Starting dynamic subtest: pipe-C-plane-0
[336.855893] Dynamic subtest pipe-C-plane-0: FAIL (0.163s)
[336.864771] Starting dynamic subtest: pipe-C-plane-1
[337.012569] Dynamic subtest pipe-C-plane-1: FAIL (0.143s)
[337.020555] Starting dynamic subtest: pipe-C-plane-2
[337.188402] Dynamic subtest pipe-C-plane-2: FAIL (0.166s)
[338.272681] Starting dynamic subtest: pipe-D-plane-0
[338.567231] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[338.574936] Starting dynamic subtest: pipe-D-plane-1
[338.751682] Dynamic subtest pipe-D-plane-1: FAIL (0.155s)
[338.759107] Starting dynamic subtest: pipe-D-plane-2
[338.952469] Dynamic subtest pipe-D-plane-2: FAIL (0.328s)
[339.198271] Subtest plane-lut1d-post-ctm3x4: FAIL (6.441s)
[340.034797] [061/132] (680s left) perf (oa-formats)
[340.172166] Starting subtest: oa-formats
[340.173181] Starting dynamic subtest: 0-rcs0
[340.187575] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[340.196558] Starting dynamic subtest: 1-vcs0
[340.212748] Dynamic subtest 1-vcs0: SUCCESS (0.022s)
[340.213679] Subtest oa-formats: SUCCESS (0.042s)
[340.249278] [062/132] (680s left) perf_pmu (pmu-read)
[340.290749] Starting subtest: pmu-read
[340.296339] Subtest pmu-read: SUCCESS (0.006s)
[340.385971] [063/132] (680s left) gem_render_copy (y-tiled-to-vebox-linear)
[340.433033] Starting subtest: y-tiled-to-vebox-linear
[340.434878] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[340.609364] [064/132] (680s left) drm_read (empty-block)
[340.768022] Starting subtest: empty-block
[341.768545] Subtest empty-block: SUCCESS (1.000s)
[341.886781] [065/132] (678s left) gem_ctx_param (invalid-size-set)
[341.942256] Starting subtest: invalid-size-set
[341.943065] Subtest invalid-size-set: SUCCESS (0.001s)
[342.049483] [066/132] (678s left) gem_pwrite (basic-random)
[342.090686] Subtest basic-random: SKIP (0.000s)
[342.133898] [067/132] (678s left) kms_cursor_crc (cursor-sliding-32x32)
[342.272281] Starting subtest: cursor-sliding-32x32
[342.316998] Subtest cursor-sliding-32x32: SKIP (0.043s)
[342.605801] [068/132] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[342.700026] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[342.701847] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[342.798625] [069/132] (678s left) gem_exec_reloc (basic-gtt-cpu-active)
[342.849289] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[342.909072] [070/132] (678s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[343.001070] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[343.004630] Starting dynamic subtest: A-eDP1
[346.669574] Dynamic subtest A-eDP1: SUCCESS (3.666s)
[346.676733] Starting dynamic subtest: B-eDP1
[349.860670] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[349.867557] Starting dynamic subtest: C-eDP1
[352.983628] Dynamic subtest C-eDP1: SUCCESS (3.121s)
[352.990475] Starting dynamic subtest: D-eDP1
[356.086804] Dynamic subtest D-eDP1: SUCCESS (3.102s)
[356.087678] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.087s)
[356.889745] [071/132] (664s left) fbdev (eof)
[356.933581] Starting subtest: eof
[356.934627] Subtest eof: SUCCESS (0.000s)
[357.020383] [072/132] (664s left) kms_pm_dc (dc9-dpms)
[358.125508] Starting subtest: dc9-dpms
[359.545292] Subtest dc9-dpms: SUCCESS (1.419s)
[359.614230] [073/132] (661s left) syncobj_timeline (device-signal-unordered)
[359.667725] Starting subtest: device-signal-unordered
[359.668673] Subtest device-signal-unordered: SUCCESS (0.000s)
[359.751072] [074/132] (661s left) kms_psr (psr-sprite-render)
[359.844373] Starting subtest: psr-sprite-render
[359.845254] Starting dynamic subtest: eDP-1
[361.613368] Dynamic subtest eDP-1: SUCCESS (1.769s)
[361.614247] Subtest psr-sprite-render: SUCCESS (1.770s)
[362.447774] [075/132] (658s left) kms_psr (psr2-suspend)
[362.543258] Starting subtest: psr2-suspend
[362.544069] Starting dynamic subtest: eDP-1
[380.545111] Dynamic subtest eDP-1: SUCCESS (3.373s)
[380.546097] Subtest psr2-suspend: SUCCESS (3.374s)
[387.395660] [076/132] (639s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[387.495848] Starting subtest: 4-tiled-16bpp-rotate-0
[388.843221] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.346s)
[388.973384] [077/132] (638s left) gem_exec_schedule (submit-golden-slice)
[389.030816] Starting subtest: submit-golden-slice
[389.031926] Starting dynamic subtest: rcs0
[389.065266] Dynamic subtest rcs0: SUCCESS (0.034s)
[389.074997] Starting dynamic subtest: bcs0
[389.096611] Dynamic subtest bcs0: SUCCESS (0.031s)
[389.104180] Starting dynamic subtest: vcs0
[389.129502] Dynamic subtest vcs0: SUCCESS (0.032s)
[389.140993] Starting dynamic subtest: vcs1
[389.163568] Dynamic subtest vcs1: SUCCESS (0.033s)
[389.170926] Starting dynamic subtest: vecs0
[389.203761] Dynamic subtest vecs0: SUCCESS (0.040s)
[389.213655] Starting dynamic subtest: ccs0
[389.235591] Dynamic subtest ccs0: SUCCESS (0.031s)
[389.236469] Subtest submit-golden-slice: SUCCESS (0.205s)
[390.606198] [078/132] (636s left) gem_basic (create-close)
[390.657737] Starting subtest: create-close
[390.659503] Subtest create-close: SUCCESS (0.000s)
[390.766812] [079/132] (636s left) perf (non-system-wide-paranoid)
[390.864172] Starting subtest: non-system-wide-paranoid
[390.892562] Subtest non-system-wide-paranoid: SUCCESS (0.030s)
[390.934473] [080/132] (636s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[391.030612] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[391.032332] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[391.130034] [081/132] (636s left) kms_flip (basic-flip-vs-dpms)
[391.251409] Starting subtest: basic-flip-vs-dpms
[391.255381] Starting dynamic subtest: A-eDP1
[393.856657] Dynamic subtest A-eDP1: SUCCESS (2.598s)
[393.864396] Starting dynamic subtest: B-eDP1
[396.021421] Dynamic subtest B-eDP1: SUCCESS (2.163s)
[396.030531] Starting dynamic subtest: C-eDP1
[398.098298] Dynamic subtest C-eDP1: SUCCESS (2.073s)
[398.107108] Starting dynamic subtest: D-eDP1
[400.184233] Dynamic subtest D-eDP1: SUCCESS (2.082s)
[400.186528] Subtest basic-flip-vs-dpms: SUCCESS (8.931s)
[401.009809] [082/132] (626s left) kms_big_fb (x-tiled-addfb-size-overflow)
[401.124007] Starting subtest: x-tiled-addfb-size-overflow
[401.124958] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[401.213439] [083/132] (626s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[401.430611] Starting subtest: cursor-rapid-movement-128x42
[401.478748] Subtest cursor-rapid-movement-128x42: SKIP (0.047s)
[401.680405] [084/132] (625s left) i915_pm_rpm (gem-mmap-type)
[403.704948] Starting subtest: gem-mmap-type
[403.706129] Starting dynamic subtest: wb-smem0
[407.174018] Dynamic subtest wb-smem0: SUCCESS (3.469s)
[407.181557] Starting dynamic subtest: wc-smem0
[410.332692] Dynamic subtest wc-smem0: SUCCESS (3.158s)
[410.341692] Starting dynamic subtest: uc-smem0
[413.214066] Dynamic subtest uc-smem0: SUCCESS (2.880s)
[413.214893] Subtest gem-mmap-type: SUCCESS (9.511s)
[413.293631] [085/132] (614s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[413.388341] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[413.390374] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[413.479346] [086/132] (614s left) gem_mmap_gtt (cpuset-big-copy-odd)
[413.520215] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[413.564549] [087/132] (614s left) gem_linear_blits (basic)
[413.851582] Starting subtest: basic
[413.858985] Subtest basic: SUCCESS (0.008s)
[413.976180] [088/132] (613s left) gem_userptr_blits (unsync-unmap-after-close)
[414.074323] Subtest unsync-unmap-after-close: SKIP (0.000s)
[414.191386] [089/132] (613s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[414.578307] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[415.377000] [090/132] (612s left) syncobj_timeline (single-wait-for-submit-signaled)
[415.434914] Starting subtest: single-wait-for-submit-signaled
[415.436153] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[415.545375] [091/132] (612s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[415.642663] Starting subtest: plane-upscale-20x20-with-pixel-format
[415.643494] Starting dynamic subtest: pipe-A
[416.703403] Dynamic subtest pipe-A: SUCCESS (1.061s)
[416.711824] Starting dynamic subtest: pipe-B
[418.802595] Dynamic subtest pipe-B: SUCCESS (2.099s)
[418.811231] Starting dynamic subtest: pipe-C
[420.004444] Dynamic subtest pipe-C: SUCCESS (1.201s)
[420.013347] Starting dynamic subtest: pipe-D
[421.231226] Dynamic subtest pipe-D: SUCCESS (1.225s)
[421.232082] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.591s)
[422.427915] [092/132] (605s left) syncobj_wait (wait-all-complex)
[422.486032] Starting subtest: wait-all-complex
[422.712063] Subtest wait-all-complex: SUCCESS (0.215s)
[422.788592] [093/132] (605s left) gen9_exec_parse (bb-start-param)
[422.852469] Subtest bb-start-param: SKIP (0.000s)
[422.917040] [094/132] (604s left) gem_partial_pwrite_pread (write-display)
[422.965420] Subtest write-display: SKIP (0.000s)
[423.028170] [095/132] (604s left) drm_read (short-buffer-nonblock)
[423.187679] Starting subtest: short-buffer-nonblock
[423.188924] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[423.298348] [096/132] (604s left) kms_psr (fbc-psr-basic)
[423.376879] Starting subtest: fbc-psr-basic
[423.377744] Starting dynamic subtest: eDP-1
[423.379396] Dynamic subtest eDP-1: SKIP (0.000s)
[423.380971] Subtest fbc-psr-basic: SKIP (0.001s)
[423.444344] [097/132] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[423.542172] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[423.543775] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[423.628671] [098/132] (604s left) gem_ctx_persistence (file)
[423.685880] Starting subtest: file
[423.793403] Subtest file: SUCCESS (0.108s)
[423.903881] [099/132] (604s left) gem_spin_batch (spin-all-new)
[423.955772] Starting subtest: spin-all-new
[423.972678] Subtest spin-all-new: SUCCESS (0.016s)
[425.499356] [100/132] (602s left) syncobj_wait (invalid-signal-bad-pad)
[425.548723] Starting subtest: invalid-signal-bad-pad
[425.549631] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[425.639544] [101/132] (602s left) kms_cursor_crc (cursor-offscreen-64x21)
[425.834894] Starting subtest: cursor-offscreen-64x21
[425.879507] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[426.116369] [102/132] (602s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[426.214316] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[432.774998] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.562s)
[432.886277] [103/132] (595s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[432.999782] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[433.001534] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[433.110309] [104/132] (595s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[433.218412] Starting subtest: primary-yf-tiled-reflect-x-180
[433.278329] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[433.385778] [105/132] (594s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[433.474829] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[433.475734] Starting dynamic subtest: pipe-A-eDP-1
[433.484150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[433.491881] Starting dynamic subtest: pipe-B-eDP-1
[433.508250] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[433.516012] Starting dynamic subtest: pipe-C-eDP-1
[433.523952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[433.531502] Starting dynamic subtest: pipe-D-eDP-1
[433.539942] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[433.541564] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[435.793226] [106/132] (592s left) perf_pmu (all-busy-idle-check-all)
[435.831855] Starting subtest: all-busy-idle-check-all
[437.506057] Subtest all-busy-idle-check-all: SUCCESS (1.664s)
[437.579034] [107/132] (590s left) kms_prop_blob (invalid-get-prop)
[437.633594] Starting subtest: invalid-get-prop
[437.634629] Subtest invalid-get-prop: SUCCESS (0.000s)
[437.734712] [108/132] (590s left) kms_frontbuffer_tracking (psr-2p-rte)
[437.819605] Starting subtest: psr-2p-rte
[437.821473] Subtest psr-2p-rte: SKIP (0.000s)
[437.918983] [109/132] (590s left) i915_drm_fdinfo (virtual-busy)
[437.954814] Starting subtest: virtual-busy
[437.956262] Subtest virtual-busy: SKIP (0.000s)
[438.041628] [110/132] (590s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[438.141317] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[438.142209] Starting dynamic subtest: pipe-A-eDP-1
[444.993820] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.852s)
[445.001903] Starting dynamic subtest: pipe-B-eDP-1
[452.023403] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.028s)
[452.024826] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.884s)
[452.883520] [111/132] (575s left) kms_plane_alpha_blend (coverage-7efc)
[452.976718] Starting subtest: coverage-7efc
[453.260859] Starting dynamic subtest: pipe-A-eDP-1
[453.816704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[453.844516] Starting dynamic subtest: pipe-D-eDP-1
[455.095168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[455.096053] Subtest coverage-7efc: SUCCESS (2.119s)
[455.942729] [112/132] (572s left) kms_prime (basic-modeset-hybrid)
[456.026326] Subtest basic-modeset-hybrid: SKIP (0.000s)
[456.129063] [113/132] (572s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[456.220743] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[463.472198] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.252s)
[463.597367] [114/132] (564s left) gem_lmem_swapping (heavy-verify-multi)
[463.634999] Subtest heavy-verify-multi: SKIP (0.000s)
[463.675567] [115/132] (564s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[463.767862] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[463.769715] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[463.884094] [116/132] (564s left) kms_big_fb (linear-16bpp-rotate-90)
[463.986017] Starting subtest: linear-16bpp-rotate-90
[464.004576] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[464.117487] [117/132] (564s left) gem_exec_store (basic)
[464.176197] Starting subtest: basic
[464.279409] Subtest basic: SUCCESS (0.103s)
[464.460808] [118/132] (564s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[464.553853] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[471.236326] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.682s)
[471.370001] [119/132] (557s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[471.452881] Starting subtest: psr-modesetfrombusy
[477.610903] Subtest psr-modesetfrombusy: SUCCESS (6.158s)
[477.746528] [120/132] (551s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[477.838130] Starting subtest: addfb25-y-tiled-legacy
[477.839042] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[477.939639] [121/132] (550s left) i915_hangman (engine-engine-error)
[478.002322] Starting subtest: engine-engine-error
[478.003196] Starting dynamic subtest: rcs0
[479.520280] Dynamic subtest rcs0: SUCCESS (1.508s)
[479.530734] Starting dynamic subtest: bcs0
[481.503499] Dynamic subtest bcs0: SUCCESS (1.980s)
[481.514043] Starting dynamic subtest: vcs0
[483.489337] Dynamic subtest vcs0: SUCCESS (1.983s)
[483.509514] Starting dynamic subtest: vcs1
[485.472712] Dynamic subtest vcs1: SUCCESS (1.981s)
[485.483429] Starting dynamic subtest: vecs0
[487.520216] Dynamic subtest vecs0: SUCCESS (2.045s)
[487.534017] Starting dynamic subtest: ccs0
[489.440230] Dynamic subtest ccs0: SUCCESS (1.917s)
[489.441595] Subtest engine-engine-error: SUCCESS (11.430s)
[489.567056] [122/132] (539s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[489.662039] Starting subtest: pr-cursor-plane-move-continuous-sf
[489.663739] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[489.735042] [123/132] (539s left) gem_create (create-clear)
[489.785846] Starting subtest: create-clear
[489.786770] Starting dynamic subtest: smem0
[522.523521] Dynamic subtest smem0: SUCCESS (32.736s)
[522.524414] Subtest create-clear: SUCCESS (32.737s)
[522.724061] [124/132] (506s left) gem_pxp (protected-raw-src-copy-not-readible)
[522.860366] Starting subtest: protected-raw-src-copy-not-readible
[522.949916] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.090s)
[523.067574] [125/132] (505s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[523.162469] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[523.164318] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[523.258530] [126/132] (505s left) gem_exec_flush (basic-uc-rw-default)
[523.320728] Starting subtest: basic-uc-rw-default
[528.789502] Subtest basic-uc-rw-default: SUCCESS (5.467s)
[528.982857] [127/132] (500s left) gem_exec_params (cliprects_ptr-dirt)
[529.040900] Starting subtest: cliprects_ptr-dirt
[529.041812] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[529.132781] [128/132] (499s left) kms_lease (lease-unleased-connector)
[529.239208] Starting subtest: lease-unleased-connector
[529.240655] Starting dynamic subtest: pipe-A-eDP-1
[529.247065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[529.258054] Starting dynamic subtest: pipe-B-eDP-1
[529.259682] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[529.268456] Starting dynamic subtest: pipe-C-eDP-1
[529.269434] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[529.277998] Starting dynamic subtest: pipe-D-eDP-1
[529.278823] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[529.279580] Subtest lease-unleased-connector: SUCCESS (0.037s)
[529.382557] [129/132] (499s left) syncobj_wait (signal)
[529.435141] Starting subtest: signal
[529.436106] Subtest signal: SUCCESS (0.000s)
[529.525390] [130/132] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[529.607792] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[529.609452] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[529.701803] [131/132] (499s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[529.784968] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[529.786595] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[529.855199] [132/132] (499s left) kms_flip (flip-vs-blocking-wf-vblank)
[529.949054] Starting subtest: flip-vs-blocking-wf-vblank
[529.951761] Starting dynamic subtest: A-eDP1
[538.842849] Dynamic subtest A-eDP1: SUCCESS (8.891s)
[538.852279] Starting dynamic subtest: B-eDP1
[547.778513] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[547.788816] Starting dynamic subtest: C-eDP1
[556.740693] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[556.750179] Starting dynamic subtest: D-eDP1
[565.674225] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[565.675131] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.689s)
[566.860022] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: gem_ctx_param
results: parsing output: 5/ for test: core_setmaster
results: parsing output: 6/ for test: gem_wait
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_exec_create
results: parsing output: 11/ for test: gem_ctx_bad_destroy
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_busy
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_exec_capture
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: gem_wait
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: i915_selftest
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_sequence
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: api_intel_allocator
results: parsing output: 48/ for test: gem_ctx_isolation
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: prime_busy
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_dither
results: parsing output: 54/ for test: core_auth
results: parsing output: 55/ for test: gem_exec_gttfill
results: parsing output: 56/ for test: kms_chamelium_hpd
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: kms_plane_multiple
results: parsing output: 59/ for test: kms_color_pipeline
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: drm_read
results: parsing output: 64/ for test: gem_ctx_param
results: parsing output: 65/ for test: gem_pwrite
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: fbdev
results: parsing output: 71/ for test: kms_pm_dc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: gem_basic
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: i915_pm_rpm
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: gem_linear_blits
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_chamelium_edid
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gen9_exec_parse
results: parsing output: 93/ for test: gem_partial_pwrite_pread
results: parsing output: 94/ for test: drm_read
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: gem_spin_batch
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_rotation_crc
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_prop_blob
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: kms_plane_alpha_blend
results: parsing output: 111/ for test: kms_prime
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_exec_store
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: i915_hangman
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: gem_create
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: kms_lease
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: kms_flip
Done.