[65.124544] Initializing watchdogs
[65.124600]   /dev/watchdog0
[65.139868] [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]
[65.144661] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[65.147072] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.149014] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[65.243384] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[65.245194] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[65.329746] [002/133] (960s left) kms_chamelium_edid (vga-edid-read)
[65.707593] Subtest vga-edid-read: SKIP (0.000s)
[66.549675] [003/133] (959s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[66.637407] Starting subtest: bad-rotation-90-y-tiled-ccs
[66.638427] Starting dynamic subtest: pipe-A-eDP-1
[66.647566] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.653901] Starting dynamic subtest: pipe-B-eDP-1
[66.662933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.668582] Starting dynamic subtest: pipe-C-eDP-1
[66.677960] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.683393] Starting dynamic subtest: pipe-D-eDP-1
[66.691579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.693248] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s)
[68.920198] [004/133] (956s left) kms_psr (pr-cursor-blt)
[69.012934] Starting subtest: pr-cursor-blt
[69.014679] Subtest pr-cursor-blt: SKIP (0.000s)
[69.074783] [005/133] (956s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[69.126907] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[69.188154] [006/133] (956s left) kms_cursor_legacy (single-bo)
[69.308843] Starting subtest: single-bo
[69.309706] Starting dynamic subtest: pipe-A
[74.735910] Dynamic subtest pipe-A: SUCCESS (5.379s)
[74.742836] Starting dynamic subtest: pipe-B
[80.117957] Dynamic subtest pipe-B: SUCCESS (5.380s)
[80.125037] Starting dynamic subtest: pipe-C
[85.463062] Dynamic subtest pipe-C: SUCCESS (5.380s)
[85.471206] Starting dynamic subtest: pipe-D
[90.880779] Dynamic subtest pipe-D: SUCCESS (5.380s)
[90.888514] Starting dynamic subtest: all-pipes
[96.268263] Dynamic subtest all-pipes: SUCCESS (5.386s)
[96.269459] Subtest single-bo: SUCCESS (26.910s)
[96.360464] [007/133] (929s left) perf_pmu (semaphore-wait-idle)
[96.403011] Starting subtest: semaphore-wait-idle
[96.403891] Starting dynamic subtest: rcs0
[96.925621] Dynamic subtest rcs0: SUCCESS (0.514s)
[96.932390] Starting dynamic subtest: bcs0
[97.438322] Dynamic subtest bcs0: SUCCESS (0.511s)
[97.445464] Starting dynamic subtest: vcs0
[97.950344] Dynamic subtest vcs0: SUCCESS (0.511s)
[97.958340] Starting dynamic subtest: vcs1
[98.462195] Dynamic subtest vcs1: SUCCESS (0.511s)
[98.470763] Starting dynamic subtest: vecs0
[98.974882] Dynamic subtest vecs0: SUCCESS (0.512s)
[98.983528] Starting dynamic subtest: ccs0
[99.480569] Dynamic subtest ccs0: SUCCESS (0.513s)
[99.482207] Subtest semaphore-wait-idle: SUCCESS (3.078s)
[100.952321] [008/133] (924s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[101.003801] Starting subtest: invalid-smem-bo-on-discrete
[101.005572] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[101.157523] [009/133] (924s left) kms_vblank (wait-forked-hang)
[101.247073] Starting subtest: wait-forked-hang
[101.248074] Starting dynamic subtest: pipe-A-eDP-1
[127.702379] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.452s)
[127.710838] Starting dynamic subtest: pipe-D-eDP-1
[142.749861] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.045s)
[142.750765] Subtest wait-forked-hang: SUCCESS (41.501s)
[143.576168] [010/133] (882s left) api_intel_allocator (execbuf-with-allocator)
[143.628055] Starting subtest: execbuf-with-allocator
[143.636542] Subtest execbuf-with-allocator: SUCCESS (0.009s)
[143.738228] [011/133] (882s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[143.829753] Starting subtest: psr-rgb101010-draw-pwrite
[151.573893] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.745s)
[151.668515] [012/133] (874s left) gem_ctx_engines (execute-one)
[151.737620] Starting subtest: execute-one
[153.883058] Subtest execute-one: SUCCESS (2.145s)
[154.062511] [013/133] (871s left) kms_prime (basic-crc-hybrid)
[154.144289] Subtest basic-crc-hybrid: SKIP (0.000s)
[154.286331] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[154.288546] [014/133] (871s left) kms_psr (fbc-psr-basic)
[154.375332] Starting subtest: fbc-psr-basic
[154.376286] Starting dynamic subtest: eDP-1
[154.377992] Dynamic subtest eDP-1: SKIP (0.000s)
[154.379898] Subtest fbc-psr-basic: SKIP (0.000s)
[154.441802] [015/133] (871s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[154.532835] Starting subtest: flip-vs-dpms-off-vs-modeset
[154.533885] Starting dynamic subtest: A-eDP1
[158.217121] Dynamic subtest A-eDP1: SUCCESS (3.678s)
[158.225276] Starting dynamic subtest: B-eDP1
[161.420596] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[161.427866] Starting dynamic subtest: C-eDP1
[164.525838] Dynamic subtest C-eDP1: SUCCESS (3.105s)
[164.532952] Starting dynamic subtest: D-eDP1
[167.665616] Dynamic subtest D-eDP1: SUCCESS (3.139s)
[167.667406] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.136s)
[168.455212] [016/133] (857s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[168.554289] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[169.599794] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[169.729314] [017/133] (856s left) perf (gen12-invalid-class-instance)
[169.864536] Starting subtest: gen12-invalid-class-instance
[169.875906] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[169.914119] [018/133] (856s left) gem_exec_async (concurrent-writes)
[169.973277] Starting subtest: concurrent-writes
[169.974299] Starting dynamic subtest: rcs0
[169.990710] Dynamic subtest rcs0: SUCCESS (0.017s)
[170.001605] Starting dynamic subtest: bcs0
[170.002567] Dynamic subtest bcs0: SUCCESS (0.009s)
[170.009584] Starting dynamic subtest: vcs0
[170.010411] Dynamic subtest vcs0: SUCCESS (0.006s)
[170.017497] Starting dynamic subtest: vcs1
[170.018357] Dynamic subtest vcs1: SUCCESS (0.008s)
[170.025344] Starting dynamic subtest: vecs0
[170.026283] Dynamic subtest vecs0: SUCCESS (0.005s)
[170.032777] Starting dynamic subtest: ccs0
[170.033894] Dynamic subtest ccs0: SUCCESS (0.005s)
[170.034808] Subtest concurrent-writes: SUCCESS (0.052s)
[170.253150] [019/133] (855s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[170.355280] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[174.541713] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.186s)
[175.665993] [020/133] (850s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[175.754935] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[175.756725] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[175.856863] [021/133] (850s left) gem_set_tiling_vs_gtt
[175.973650] [022/133] (850s left) dmabuf_sync_file (import-multiple-read-write)
[176.012703] Starting subtest: import-multiple-read-write
[176.014800] Subtest import-multiple-read-write: SUCCESS (0.004s)
[176.064967] [023/133] (850s left) gem_render_copy (yf-tiled-to-vebox-linear)
[176.125056] Starting subtest: yf-tiled-to-vebox-linear
[176.127359] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[176.304478] [024/133] (850s left) gem_exec_balancer (invalid-bonds)
[176.367990] Starting subtest: invalid-bonds
[176.369957] Subtest invalid-bonds: SKIP (0.000s)
[176.655282] [025/133] (849s left) syncobj_timeline (single-wait-available-submitted)
[176.716944] Starting subtest: single-wait-available-submitted
[176.717926] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[176.821652] [026/133] (849s left) gen9_exec_parse (batch-invalid-length)
[176.877788] Subtest batch-invalid-length: SKIP (0.000s)
[176.943233] [027/133] (849s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[177.027512] Starting subtest: invalidate-primary-flip-overlay
[187.818113] Subtest invalidate-primary-flip-overlay: SUCCESS (10.791s)
[187.919982] [028/133] (838s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[188.037109] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[188.040019] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[188.191129] [029/133] (838s left) i915_query (query-topology-known-pci-ids)
[188.240812] Starting subtest: query-topology-known-pci-ids
[188.248266] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[188.333747] [030/133] (838s left) kms_plane_scaling (invalid-parameters)
[188.423160] Starting subtest: invalid-parameters
[188.424073] Starting dynamic subtest: less-than-1-height-src
[188.436923] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[188.444046] Starting dynamic subtest: less-than-1-width-src
[188.450180] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[188.451161] Subtest invalid-parameters: SUCCESS (0.027s)
[188.562324] [031/133] (838s left) gem_userptr_blits (coherency-unsync)
[188.611821] Subtest coherency-unsync: SKIP (0.000s)
[188.721077] [032/133] (837s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[188.822188] Starting subtest: y-tiled-32bpp-rotate-270
[188.824790] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[188.919736] [033/133] (837s left) gen9_exec_parse (unaligned-jump)
[188.970699] Subtest unaligned-jump: SKIP (0.000s)
[189.077891] [034/133] (837s left) perf_pmu (interrupts-sync)
[189.110798] Starting subtest: interrupts-sync
[190.213768] Subtest interrupts-sync: SUCCESS (1.093s)
[190.335380] [035/133] (836s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[190.425443] Starting subtest: nonblocking-crc-frame-sequence
[190.426396] Starting dynamic subtest: pipe-A-eDP-1
[191.171405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s)
[191.186814] Starting dynamic subtest: pipe-B-eDP-1
[192.573830] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[192.581365] Starting dynamic subtest: pipe-C-eDP-1
[193.954308] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[193.964503] Starting dynamic subtest: pipe-D-eDP-1
[195.275562] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[195.276423] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.851s)
[196.074380] [036/133] (830s left) gem_mmap_gtt (basic-small-copy)
[196.123507] Subtest basic-small-copy: SKIP (0.000s)
[196.183282] [037/133] (830s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[196.268105] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[196.269817] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[196.334030] [038/133] (830s left) kms_getfb (getfb2-handle-protection)
[196.427199] Starting subtest: getfb2-handle-protection
[196.442664] Subtest getfb2-handle-protection: SUCCESS (0.016s)
[196.560735] [039/133] (830s left) i915_hangman (engine-error-state-capture)
[196.613908] Starting subtest: engine-error-state-capture
[196.615355] Starting dynamic subtest: rcs0
[199.869624] Dynamic subtest rcs0: SUCCESS (3.246s)
[199.880052] Starting dynamic subtest: bcs0
[205.887052] Dynamic subtest bcs0: SUCCESS (6.015s)
[205.896691] Starting dynamic subtest: vcs0
[211.901696] Dynamic subtest vcs0: SUCCESS (6.013s)
[211.910753] Starting dynamic subtest: vcs1
[216.894026] Dynamic subtest vcs1: SUCCESS (4.990s)
[216.903372] Starting dynamic subtest: vecs0
[222.845298] Dynamic subtest vecs0: SUCCESS (5.949s)
[222.854855] Starting dynamic subtest: ccs0
[228.861266] Dynamic subtest ccs0: SUCCESS (6.014s)
[228.862095] Subtest engine-error-state-capture: SUCCESS (32.239s)
[228.923448] [040/133] (798s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[228.976800] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[228.977781] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[229.073819] [041/133] (797s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[229.176361] Starting subtest: fbc-rgb565-draw-mmap-wc
[233.213717] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.037s)
[234.382021] [042/133] (792s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[234.462427] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[234.463401] Starting dynamic subtest: pipe-A-eDP-1
[234.472353] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[234.484963] Starting dynamic subtest: pipe-B-eDP-1
[234.494106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[234.503529] Starting dynamic subtest: pipe-C-eDP-1
[234.511868] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[234.518654] Starting dynamic subtest: pipe-D-eDP-1
[234.527346] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[234.528918] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[236.677126] [043/133] (790s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[236.773118] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[236.774915] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[236.872273] [044/133] (790s left) gem_mmap_wc (invalid-flags)
[236.915092] Subtest invalid-flags: SKIP (0.000s)
[236.972315] [045/133] (790s left) kms_flip (flip-vs-rmfb)
[237.057199] Starting subtest: flip-vs-rmfb
[237.058093] Starting dynamic subtest: A-eDP1
[245.761579] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[245.770688] Starting dynamic subtest: B-eDP1
[254.400645] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[254.410347] Starting dynamic subtest: C-eDP1
[263.030533] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[263.040860] Starting dynamic subtest: D-eDP1
[271.664575] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[271.667362] Subtest flip-vs-rmfb: SUCCESS (34.609s)
[272.860413] [046/133] (754s left) kms_atomic_transition (plane-all-transition-fencing)
[272.958378] Starting subtest: plane-all-transition-fencing
[272.960749] Starting dynamic subtest: pipe-A-eDP-1
[275.464706] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.505s)
[275.768169] Starting dynamic subtest: pipe-B-eDP-1
[278.995807] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.234s)
[279.293890] Subtest plane-all-transition-fencing: SUCCESS (6.335s)
[280.115824] [047/133] (747s left) kms_flip (basic-flip-vs-dpms)
[280.215356] Starting subtest: basic-flip-vs-dpms
[280.217408] Starting dynamic subtest: A-eDP1
[282.823396] Dynamic subtest A-eDP1: SUCCESS (2.605s)
[282.831844] Starting dynamic subtest: B-eDP1
[284.988309] Dynamic subtest B-eDP1: SUCCESS (2.163s)
[284.995509] Starting dynamic subtest: C-eDP1
[287.157254] Dynamic subtest C-eDP1: SUCCESS (2.167s)
[287.168142] Starting dynamic subtest: D-eDP1
[289.228339] Dynamic subtest D-eDP1: SUCCESS (2.068s)
[289.231437] Subtest basic-flip-vs-dpms: SUCCESS (9.016s)
[290.027302] [048/133] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[290.140691] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[296.794614] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.655s)
[296.901749] [049/133] (730s left) i915_pm_rpm (gem-execbuf-stress)
[299.040308] Starting subtest: gem-execbuf-stress
[299.041721] Starting dynamic subtest: smem0
[311.977244] Dynamic subtest smem0: SUCCESS (12.937s)
[311.989153] Starting dynamic subtest: extra-wait-smem0
[373.980444] Dynamic subtest extra-wait-smem0: SUCCESS (61.989s)
[373.981972] Subtest gem-execbuf-stress: SUCCESS (74.932s)
[374.350033] [050/133] (652s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[374.904900] Starting subtest: syncobj-timeline-multiple-ext-nodes
[374.906244] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[375.972676] [051/133] (651s left) gem_linear_blits (basic)
[376.487679] Starting subtest: basic
[376.495361] Subtest basic: SUCCESS (0.009s)
[376.620985] [052/133] (650s left) i915_query (query-topology-kernel-writes)
[376.717911] Starting subtest: query-topology-kernel-writes
[376.718809] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[376.809729] [053/133] (650s left) gem_ctx_persistence (legacy-engines-mixed)
[376.857599] Starting subtest: legacy-engines-mixed
[376.858613] Starting dynamic subtest: render
[376.937310] Dynamic subtest render: SUCCESS (0.079s)
[376.948389] Starting dynamic subtest: bsd1
[376.994230] Dynamic subtest bsd1: SUCCESS (0.054s)
[377.004782] Starting dynamic subtest: bsd2
[377.052241] Dynamic subtest bsd2: SUCCESS (0.056s)
[377.064417] Starting dynamic subtest: blt
[377.108546] Dynamic subtest blt: SUCCESS (0.054s)
[377.120054] Starting dynamic subtest: vebox
[377.165713] Dynamic subtest vebox: SUCCESS (0.055s)
[377.167285] Subtest legacy-engines-mixed: SUCCESS (0.309s)
[377.239982] [054/133] (650s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[377.332062] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[377.332887] Starting dynamic subtest: pipe-A-eDP-1
[377.631186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[377.639540] Starting dynamic subtest: pipe-B-eDP-1
[378.899993] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.268s)
[378.907918] Starting dynamic subtest: pipe-C-eDP-1
[380.112805] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[380.123621] Starting dynamic subtest: pipe-D-eDP-1
[381.389827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.276s)
[381.390781] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.048s)
[382.562898] [055/133] (644s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[382.666374] Starting subtest: x-tiled-8bpp-rotate-270
[382.689750] Subtest x-tiled-8bpp-rotate-270: SKIP (0.023s)
[382.806868] [056/133] (644s left) kms_flip (wf_vblank-ts-check-interruptible)
[382.896927] Starting subtest: wf_vblank-ts-check-interruptible
[382.899323] Starting dynamic subtest: A-eDP1
[391.834742] Dynamic subtest A-eDP1: SUCCESS (8.910s)
[391.844096] Starting dynamic subtest: B-eDP1
[400.766337] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[400.776623] Starting dynamic subtest: C-eDP1
[409.689688] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[409.700299] Starting dynamic subtest: D-eDP1
[418.587332] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[418.590817] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.693s)
[419.817801] [057/133] (607s left) gem_userptr_blits (sync-unmap-cycles)
[419.899158] Starting subtest: sync-unmap-cycles
[425.279252] Subtest sync-unmap-cycles: SUCCESS (5.379s)
[425.403646] [058/133] (602s left) gem_eio (in-flight-immediate)
[425.628450] Starting subtest: in-flight-immediate
[433.860905] Subtest in-flight-immediate: SUCCESS (8.232s)
[433.978890] [059/133] (593s left) kms_sequence (queue-busy)
[434.064202] Starting subtest: queue-busy
[434.065185] Starting dynamic subtest: pipe-A-eDP-1
[436.000259] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[436.009040] Starting dynamic subtest: pipe-B-eDP-1
[438.620756] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.619s)
[438.629367] Starting dynamic subtest: pipe-C-eDP-1
[441.230731] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[441.238758] Starting dynamic subtest: pipe-D-eDP-1
[443.855994] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.623s)
[443.856917] Subtest queue-busy: SUCCESS (9.792s)
[444.734740] [060/133] (582s left) fbdev (unaligned-read)
[444.770616] Starting subtest: unaligned-read
[444.786113] Subtest unaligned-read: SUCCESS (0.016s)
[444.844177] [061/133] (582s left) gem_userptr_blits (nohangcheck)
[444.912781] Starting subtest: nohangcheck
[445.158314] Subtest nohangcheck: SUCCESS (0.245s)
[445.282617] [062/133] (582s left) gem_exec_fence (expired-history)
[445.691772] Starting subtest: expired-history
[452.629950] Subtest expired-history: SUCCESS (6.931s)
[453.193783] [063/133] (574s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[453.287088] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[453.287923] Starting dynamic subtest: pipe-A-default-mode
[454.411181] Dynamic subtest pipe-A-default-mode: SKIP (1.122s)
[454.412914] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.123s)
[454.554507] [064/133] (573s left) kms_psr (psr2-cursor-mmap-cpu)
[454.649622] Starting subtest: psr2-cursor-mmap-cpu
[454.650518] Starting dynamic subtest: eDP-1
[456.348896] Dynamic subtest eDP-1: SUCCESS (1.698s)
[456.349771] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.700s)
[457.155432] [065/133] (570s left) kms_cursor_crc (cursor-alpha-transparent)
[457.252340] Starting subtest: cursor-alpha-transparent
[457.253260] Starting dynamic subtest: pipe-A-eDP-1
[457.891509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.638s)
[457.899899] Starting dynamic subtest: pipe-D-eDP-1
[459.133095] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[459.133934] Subtest cursor-alpha-transparent: SUCCESS (1.881s)
[459.929504] [066/133] (567s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[460.020537] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[460.021425] Starting dynamic subtest: pipe-A
[460.084755] Dynamic subtest pipe-A: SUCCESS (0.065s)
[460.094626] Starting dynamic subtest: pipe-B
[461.259449] Dynamic subtest pipe-B: SUCCESS (1.174s)
[461.270487] Starting dynamic subtest: pipe-C
[462.374780] Dynamic subtest pipe-C: SUCCESS (1.114s)
[462.384202] Starting dynamic subtest: pipe-D
[463.502121] Dynamic subtest pipe-D: SUCCESS (1.126s)
[463.503203] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.483s)
[464.661764] [067/133] (563s left) gem_exec_whisper (basic-queues-all)
[464.732561] Starting subtest: basic-queues-all
[475.404077] Subtest basic-queues-all: SUCCESS (10.671s)
[475.588585] [068/133] (552s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[475.963589] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[476.762475] [069/133] (551s left) perf (blocking)
[476.869878] Starting subtest: blocking
[476.870827] Starting dynamic subtest: 0-rcs0
[486.934454] Dynamic subtest 0-rcs0: SUCCESS (10.017s)
[486.944989] Starting dynamic subtest: 1-vecs0
[496.955110] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[496.956526] Subtest blocking: SUCCESS (20.039s)
[496.988242] [070/133] (530s left) api_intel_bb (intel-bb-blit-x)
[497.047458] Starting subtest: intel-bb-blit-x
[500.897919] Subtest intel-bb-blit-x: SUCCESS (3.840s)
[501.004510] [071/133] (527s left) kms_draw_crc (fill-fb)
[501.102021] Starting subtest: fill-fb
[501.599195] Subtest fill-fb: SUCCESS (0.497s)
[501.677822] [072/133] (526s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[501.769247] Starting subtest: primary-x-tiled-reflect-x-180
[508.758712] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.990s)
[509.952884] [073/133] (518s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[510.092438] Starting subtest: cursor-rapid-movement-32x32
[510.138104] Subtest cursor-rapid-movement-32x32: SKIP (0.044s)
[510.433678] [074/133] (517s left) gem_madvise (dontneed-before-exec)
[510.466469] Starting subtest: dontneed-before-exec
[510.494770] Subtest dontneed-before-exec: SKIP (0.028s)
[510.550881] [075/133] (517s left) gem_ctx_isolation (dirty-switch)
[510.603488] Starting subtest: dirty-switch
[510.604721] Starting dynamic subtest: rcs0
[510.792112] Dynamic subtest rcs0: SUCCESS (0.188s)
[510.804547] Starting dynamic subtest: bcs0
[510.989133] Dynamic subtest bcs0: SUCCESS (0.196s)
[511.000721] Starting dynamic subtest: vcs0
[511.199371] Dynamic subtest vcs0: SUCCESS (0.209s)
[511.212748] Starting dynamic subtest: vcs1
[513.134074] Dynamic subtest vcs1: SUCCESS (1.934s)
[513.144961] Starting dynamic subtest: vecs0
[515.105856] Dynamic subtest vecs0: SUCCESS (1.971s)
[515.115939] Starting dynamic subtest: ccs0
[517.090202] Dynamic subtest ccs0: SUCCESS (1.983s)
[517.091530] Subtest dirty-switch: SUCCESS (6.487s)
[517.329432] [076/133] (510s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[517.415915] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[517.506500] [077/133] (510s left) kms_content_protection (dp-mst-type-0-hdcp14)
[517.628841] Starting subtest: dp-mst-type-0-hdcp14
[517.630695] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[517.757037] [078/133] (510s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[517.841812] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[527.631569] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.787s)
[527.754201] [079/133] (500s left) kms_addfb_basic (unused-offsets)
[527.812939] Starting subtest: unused-offsets
[527.813887] Subtest unused-offsets: SUCCESS (0.000s)
[527.959450] [080/133] (500s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[528.054089] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[528.055674] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[528.140316] [081/133] (500s left) kms_cursor_edge_walk (64x64-left-edge)
[528.225324] Starting subtest: 64x64-left-edge
[528.226181] Starting dynamic subtest: pipe-A-eDP-1
[531.737717] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s)
[531.746147] Starting dynamic subtest: pipe-D-eDP-1
[534.854782] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[534.855652] Subtest 64x64-left-edge: SUCCESS (6.629s)
[535.674313] [082/133] (492s left) kms_color (legacy-gamma-reset)
[535.765168] Starting subtest: legacy-gamma-reset
[535.765981] Starting dynamic subtest: pipe-A-eDP-1
[536.153690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[536.162565] Starting dynamic subtest: pipe-B-eDP-1
[536.166151] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[536.174172] Starting dynamic subtest: pipe-C-eDP-1
[536.179451] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s)
[536.187510] Starting dynamic subtest: pipe-D-eDP-1
[536.194238] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[536.195188] Subtest legacy-gamma-reset: SUCCESS (0.429s)
[537.007906] [083/133] (491s left) gem_exec_whisper (basic-fds-all)
[537.064474] Starting subtest: basic-fds-all
[548.860862] Subtest basic-fds-all: SUCCESS (11.786s)
[549.034831] [084/133] (479s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[549.119065] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[549.119923] Starting dynamic subtest: pipe-A-eDP-1
[549.128730] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[549.137750] Starting dynamic subtest: pipe-B-eDP-1
[549.146767] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[549.154805] Starting dynamic subtest: pipe-C-eDP-1
[549.163073] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[549.171082] Starting dynamic subtest: pipe-D-eDP-1
[549.179849] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[549.181575] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[551.274895] [085/133] (477s left) gem_exec_capture (userptr)
[551.325418] Starting subtest: userptr
[552.162531] Subtest userptr: SUCCESS (0.836s)
[552.275549] [086/133] (476s left) sw_sync (sync_merge)
[552.309447] Starting subtest: sync_merge
[552.310432] Subtest sync_merge: SUCCESS (0.000s)
[552.362185] [087/133] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[552.455153] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[552.456962] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[552.536268] [088/133] (476s left) gem_exec_schedule (u-semaphore-resolve)
[552.595091] Starting subtest: u-semaphore-resolve
[552.631538] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[552.981275] [089/133] (475s left) kms_atomic_interruptible (legacy-pageflip)
[553.076837] Starting subtest: legacy-pageflip
[553.077760] Starting dynamic subtest: pipe-A-eDP-1
[560.523749] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.445s)
[560.524708] Subtest legacy-pageflip: SUCCESS (7.446s)
[561.349064] [090/133] (467s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[561.439702] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[561.441533] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[561.562588] [091/133] (467s left) gem_exec_params (no-vebox)
[561.623391] Starting subtest: no-vebox
[561.626128] Subtest no-vebox: SUCCESS (0.003s)
[562.968996] [092/133] (465s left) gem_readwrite (beyond-eob)
[563.015079] Subtest beyond-EOB: SKIP (0.000s)
[563.073485] [093/133] (465s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[563.157374] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[563.159245] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[563.230082] [094/133] (465s left) kms_chamelium_color (ctm-negative)
[563.321829] Subtest ctm-negative: SKIP (0.000s)
[563.364839] [095/133] (465s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[563.479935] Starting subtest: verify-pxp-stale-buf-optout-execution
[564.538022] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.060s)
[564.655871] [096/133] (464s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[564.735337] Starting subtest: fbc-pr-cursor-mmap-cpu
[564.737057] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[564.805907] [097/133] (464s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[564.917332] Starting subtest: short-flip-before-cursor-atomic-transitions
[565.881770] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.963s)
[566.695201] [098/133] (462s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[566.789722] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[566.791476] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[566.870135] [099/133] (462s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[566.956290] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[566.957881] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[567.049578] [100/133] (461s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[567.145013] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[570.796843] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.652s)
[572.008996] [101/133] (457s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[572.055453] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[572.056279] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[572.153101] [102/133] (456s left) kms_plane_multiple (2x-tiling-none)
[572.246408] Starting subtest: 2x-tiling-none
[572.247920] Subtest 2x-tiling-none: SKIP (0.000s)
[572.321464] [103/133] (456s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[572.430135] Starting subtest: 4-tiled-16bpp-rotate-0
[573.822667] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.393s)
[573.928302] [104/133] (455s left) kms_invalid_mode (int-max-clock)
[574.032510] Starting subtest: int-max-clock
[574.033610] Starting dynamic subtest: pipe-A-eDP-1
[574.324508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[574.332900] Starting dynamic subtest: pipe-B-eDP-1
[574.333795] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[574.341780] Starting dynamic subtest: pipe-C-eDP-1
[574.342780] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[574.350800] Starting dynamic subtest: pipe-D-eDP-1
[574.351703] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[574.352583] Subtest int-max-clock: SUCCESS (0.298s)
[575.119498] [105/133] (454s left) kms_flip (plain-flip-interruptible)
[575.202882] Starting subtest: plain-flip-interruptible
[575.205562] Starting dynamic subtest: A-eDP1
[576.831473] Dynamic subtest A-eDP1: SUCCESS (1.625s)
[576.843151] Starting dynamic subtest: B-eDP1
[578.459284] Dynamic subtest B-eDP1: SUCCESS (1.625s)
[578.470843] Starting dynamic subtest: C-eDP1
[580.079380] Dynamic subtest C-eDP1: SUCCESS (1.616s)
[580.090424] Starting dynamic subtest: D-eDP1
[581.716989] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[581.718191] Subtest plain-flip-interruptible: SUCCESS (6.512s)
[582.880437] [106/133] (446s left) kms_big_fb (linear-64bpp-rotate-0)
[582.994394] Starting subtest: linear-64bpp-rotate-0
[584.662519] Subtest linear-64bpp-rotate-0: SUCCESS (1.668s)
[584.835565] [107/133] (444s left) kms_lease (atomic-implicit-crtc)
[584.922413] Starting subtest: atomic-implicit-crtc
[584.923342] Starting dynamic subtest: pipe-A-eDP-1
[584.928710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[584.939436] Starting dynamic subtest: pipe-B-eDP-1
[584.944640] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[584.956635] Starting dynamic subtest: pipe-C-eDP-1
[584.960969] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[584.969108] Starting dynamic subtest: pipe-D-eDP-1
[584.973517] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[584.974398] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[585.070472] [108/133] (444s left) vgem_basic (dmabuf-fence-before)
[585.123202] Starting subtest: dmabuf-fence-before
[585.124067] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[585.177232] [109/133] (444s left) gem_mmap_offset (clear)
[585.229717] Starting subtest: clear
[585.231054] Starting dynamic subtest: smem0
[610.336927] Dynamic subtest smem0: SUCCESS (25.095s)
[610.337905] Subtest clear: SUCCESS (25.097s)
[610.449054] [110/133] (418s left) gem_exec_params (readonly)
[610.559712] Starting subtest: readonly
[610.562072] Subtest readonly: SUCCESS (0.004s)
[610.694480] [111/133] (418s left) perf_pmu (rc6)
[610.731731] Starting subtest: rc6
[610.732765] Starting dynamic subtest: gt0
[617.145209] Dynamic subtest gt0: SUCCESS (6.367s)
[617.156237] Starting dynamic subtest: runtime-pm-gt0
[624.821078] Dynamic subtest runtime-pm-gt0: SUCCESS (7.710s)
[624.832226] Starting dynamic subtest: runtime-pm-long-gt0
[637.258286] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.434s)
[637.269951] Starting dynamic subtest: other-idle-gt0
[643.602440] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[643.614183] Starting dynamic subtest: gt1
[649.944534] Dynamic subtest gt1: SUCCESS (6.339s)
[649.953174] Starting dynamic subtest: runtime-pm-gt1
[657.436897] Dynamic subtest runtime-pm-gt1: SUCCESS (7.489s)
[657.447929] Starting dynamic subtest: runtime-pm-long-gt1
[669.885352] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.446s)
[669.897324] Starting dynamic subtest: other-idle-gt1
[676.228578] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[676.230333] Subtest rc6: SUCCESS (65.486s)
[676.842351] [112/133] (352s left) kms_fb_coherency (memset-crc)
[676.928382] Starting subtest: memset-crc
[676.929273] Starting dynamic subtest: mmap-offset-wc
[677.351802] Dynamic subtest mmap-offset-wc: SUCCESS (0.424s)
[677.653302] Starting dynamic subtest: mmap-offset-uc
[683.836996] Dynamic subtest mmap-offset-uc: SUCCESS (6.193s)
[684.128931] Subtest memset-crc: SUCCESS (7.200s)
[684.921066] [113/133] (344s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[685.022700] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[685.681912] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[685.815895] [114/133] (343s left) gem_exec_schedule (lateslice)
[685.885775] Starting subtest: lateslice
[685.886720] Starting dynamic subtest: rcs0
[685.907084] Dynamic subtest rcs0: SUCCESS (0.021s)
[685.917137] Starting dynamic subtest: bcs0
[685.924117] Dynamic subtest bcs0: SUCCESS (0.016s)
[685.932832] Starting dynamic subtest: vcs0
[685.942878] Dynamic subtest vcs0: SUCCESS (0.018s)
[685.953375] Starting dynamic subtest: vcs1
[685.963098] Dynamic subtest vcs1: SUCCESS (0.020s)
[685.972124] Starting dynamic subtest: vecs0
[685.981983] Dynamic subtest vecs0: SUCCESS (0.018s)
[685.990269] Starting dynamic subtest: ccs0
[686.002419] Dynamic subtest ccs0: SUCCESS (0.020s)
[686.003276] Subtest lateslice: SUCCESS (0.117s)
[687.955930] [115/133] (341s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[688.045636] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[688.047355] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[688.091416] [116/133] (341s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[688.146163] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[688.250374] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[688.300849] [117/133] (341s left) perf_pmu (busy-check-all)
[688.334504] Starting subtest: busy-check-all
[688.335614] Starting dynamic subtest: rcs0
[688.888899] Dynamic subtest rcs0: SUCCESS (0.554s)
[688.901972] Starting dynamic subtest: bcs0
[689.437965] Dynamic subtest bcs0: SUCCESS (0.547s)
[689.450937] Starting dynamic subtest: vcs0
[690.911768] Dynamic subtest vcs0: SUCCESS (1.461s)
[690.923510] Starting dynamic subtest: vcs1
[692.895704] Dynamic subtest vcs1: SUCCESS (1.981s)
[692.907397] Starting dynamic subtest: vecs0
[694.943817] Dynamic subtest vecs0: SUCCESS (2.045s)
[694.955412] Starting dynamic subtest: ccs0
[695.488937] Dynamic subtest ccs0: SUCCESS (0.553s)
[695.491962] Subtest busy-check-all: SUCCESS (7.155s)
[695.567491] [118/133] (334s left) kms_busy (basic-hang)
[695.675091] Starting subtest: basic-hang
[695.675955] Starting dynamic subtest: flip-pipe-A
[696.278259] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[696.287260] Starting dynamic subtest: modeset-pipe-A
[699.652290] Dynamic subtest modeset-pipe-A: SUCCESS (3.374s)
[699.662934] Starting dynamic subtest: flip-pipe-D
[700.852692] Dynamic subtest flip-pipe-D: SUCCESS (1.196s)
[700.862216] Starting dynamic subtest: modeset-pipe-D
[704.286613] Dynamic subtest modeset-pipe-D: SUCCESS (3.433s)
[704.287532] Subtest basic-hang: SUCCESS (8.612s)
[705.064181] [119/133] (324s left) sysfs_preempt_timeout (timeout)
[705.129556] Starting subtest: timeout
[705.130527] Starting dynamic subtest: vecs0
[714.905355] Dynamic subtest vecs0: SUCCESS (9.766s)
[714.915775] Starting dynamic subtest: ccs0
[716.188614] Dynamic subtest ccs0: SUCCESS (1.290s)
[716.201230] Starting dynamic subtest: vcs0
[725.913495] Dynamic subtest vcs0: SUCCESS (9.713s)
[725.925487] Starting dynamic subtest: bcs0
[727.149464] Dynamic subtest bcs0: SUCCESS (1.241s)
[727.158752] Starting dynamic subtest: rcs0
[728.323652] Dynamic subtest rcs0: SUCCESS (1.174s)
[728.334747] Starting dynamic subtest: vcs1
[737.878351] Dynamic subtest vcs1: SUCCESS (9.545s)
[737.879234] Subtest timeout: SUCCESS (32.740s)
[737.918029] [120/133] (291s left) gem_softpin (evict-prime)
[737.982152] Starting subtest: evict-prime
[737.983092] Starting dynamic subtest: rcs0
[739.141313] Dynamic subtest rcs0: SUCCESS (1.159s)
[739.152418] Starting dynamic subtest: bcs0
[740.266463] Dynamic subtest bcs0: SUCCESS (1.123s)
[740.277998] Starting dynamic subtest: vcs0
[741.919835] Dynamic subtest vcs0: SUCCESS (1.642s)
[741.930994] Starting dynamic subtest: vcs1
[743.908932] Dynamic subtest vcs1: SUCCESS (1.987s)
[743.920243] Starting dynamic subtest: vecs0
[745.898649] Dynamic subtest vecs0: SUCCESS (1.988s)
[745.908439] Starting dynamic subtest: ccs0
[747.033590] Dynamic subtest ccs0: SUCCESS (1.142s)
[747.045189] Starting dynamic subtest: all
[748.899052] Dynamic subtest all: SUCCESS (1.854s)
[748.900232] Subtest evict-prime: SUCCESS (10.908s)
[748.941172] [121/133] (280s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[749.048494] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[749.050052] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[749.113068] [122/133] (280s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[749.176238] Starting subtest: map-fixed-invalidate-overlap-busy
[749.178014] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[749.271920] [123/133] (280s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[749.374962] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[749.376771] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[749.453555] [124/133] (280s left) kms_pm_backlight (fade)
[749.551340] Starting subtest: fade
[749.601900] Starting dynamic subtest: eDP-1
[752.086193] Dynamic subtest eDP-1: SUCCESS (2.484s)
[752.087356] Subtest fade: SUCCESS (2.536s)
[752.892375] [125/133] (277s left) gem_ppgtt (shrink-vs-evict-pinned)
[752.954564] Starting subtest: shrink-vs-evict-pinned
[760.889404] Subtest shrink-vs-evict-pinned: SUCCESS (7.888s)
[760.934165] [126/133] (269s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[761.024046] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[768.114714] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.091s)
[768.188073] [127/133] (261s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[768.250176] Starting subtest: invalid-multi-wait-unsubmitted
[768.251218] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[768.311339] [128/133] (261s left) i915_suspend (forcewake)
[768.364861] Starting subtest: forcewake
[800.884343] Subtest forcewake: SUCCESS (3.126s)
[807.952411] [129/133] (229s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[808.004593] Starting subtest: multi-wait-for-submit-available-signaled
[808.005483] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[808.078571] [130/133] (229s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[808.166573] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[815.472198] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.302s)
[815.561329] [131/133] (221s left) gem_softpin (evict-active)
[815.621520] Starting subtest: evict-active
[815.626659] Subtest evict-active: SUCCESS (0.005s)
[815.732291] [132/133] (221s left) kms_psr (fbc-psr2-basic)
[815.835011] Starting subtest: fbc-psr2-basic
[815.835757] Starting dynamic subtest: eDP-1
[815.837563] Dynamic subtest eDP-1: SKIP (0.000s)
[815.839130] Subtest fbc-psr2-basic: SKIP (0.001s)
[815.880144] [133/133] (221s left) gem_partial_pwrite_pread (reads-display)
[815.939427] Subtest reads-display: SKIP (0.000s)
[816.008813] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_chamelium_edid
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_vblank
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_ctx_engines
results: parsing output: 12/ for test: kms_prime
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: gem_exec_async
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_set_tiling_vs_gtt
results: parsing output: 21/ for test: dmabuf_sync_file
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: kms_psr_stress_test
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: i915_query
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_pipe_crc_basic
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: i915_hangman
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_atomic_transition
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: gem_linear_blits
results: parsing output: 51/ for test: i915_query
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_sequence
results: parsing output: 59/ for test: fbdev
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: gem_exec_whisper
results: parsing output: 67/ for test: kms_chamelium_hpd
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_draw_crc
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gem_madvise
results: parsing output: 74/ for test: gem_ctx_isolation
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_cursor_edge_walk
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_exec_capture
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_atomic_interruptible
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: gem_readwrite
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: kms_chamelium_color
results: parsing output: 94/ for test: gem_pxp
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_invalid_mode
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: vgem_basic
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_fb_coherency
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: kms_busy
results: parsing output: 118/ for test: sysfs_preempt_timeout
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_backlight
results: parsing output: 124/ for test: gem_ppgtt
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: i915_suspend
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: gem_partial_pwrite_pread
Done.