[59.079348] Initializing watchdogs
[59.079396]   /dev/watchdog0
[59.094257] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.098690] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.100846] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.102821] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[59.211746] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[59.213329] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.324425] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[59.395433] Starting subtest: basic-S3-devices
[59.396498] Starting dynamic subtest: smem
[70.936265] Dynamic subtest smem: SUCCESS (11.553s)
[70.937758] Subtest basic-S3-devices: SUCCESS (11.554s)
[76.140034] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[76.197419] Starting subtest: y-tiled-ccs-to-yf-tiled
[76.199382] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[76.399889] [004/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[76.489114] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[76.490086] Starting dynamic subtest: pipe-A-eDP-1
[76.498915] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.505782] Starting dynamic subtest: pipe-B-eDP-1
[76.514538] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.521891] Starting dynamic subtest: pipe-C-eDP-1
[76.530153] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.536212] Starting dynamic subtest: pipe-D-eDP-1
[76.544746] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.546418] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[78.794409] [005/133] (945s left) kms_flip (bo-too-big)
[78.884553] Starting subtest: bo-too-big
[78.886686] Starting dynamic subtest: A-eDP1
[80.238063] Dynamic subtest A-eDP1: SUCCESS (1.352s)
[80.245900] Starting dynamic subtest: B-eDP1
[81.565832] Dynamic subtest B-eDP1: SUCCESS (1.326s)
[81.574521] Starting dynamic subtest: C-eDP1
[82.906613] Dynamic subtest C-eDP1: SUCCESS (1.339s)
[82.913476] Starting dynamic subtest: D-eDP1
[84.227939] Dynamic subtest D-eDP1: SUCCESS (1.321s)
[84.230735] Subtest bo-too-big: SUCCESS (5.346s)
[85.451323] [006/133] (939s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[85.503676] Starting subtest: multi-wait-available-unsubmitted-signaled
[85.504632] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[85.610084] [007/133] (939s left) kms_lease (lease-uevent)
[85.702026] Starting subtest: lease-uevent
[86.713384] Subtest lease-uevent: SUCCESS (1.011s)
[86.807957] [008/133] (938s left) gem_exec_fence (syncobj-timeline-wait)
[87.416795] Starting subtest: syncobj-timeline-wait
[88.987452] Subtest syncobj-timeline-wait: SUCCESS (1.571s)
[91.039468] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[91.041125] [009/133] (933s left) kms_chamelium_color (gamma)
[91.152220] Subtest gamma: SKIP (0.000s)
[91.189288] [010/133] (933s left) prime_mmap (test_errors)
[91.247395] Starting subtest: test_errors
[91.248445] Starting dynamic subtest: test_errors-smem
[91.343764] Dynamic subtest test_errors-smem: SUCCESS (0.097s)
[91.344935] Subtest test_errors: SUCCESS (0.097s)
[91.461185] [011/133] (933s left) i915_drm_fdinfo (idle)
[91.496870] Starting subtest: idle
[91.497967] Starting dynamic subtest: rcs0
[92.100393] Dynamic subtest rcs0: SUCCESS (0.603s)
[92.110261] Starting dynamic subtest: bcs0
[92.606343] Dynamic subtest bcs0: SUCCESS (0.503s)
[92.615493] Starting dynamic subtest: vcs0
[93.110812] Dynamic subtest vcs0: SUCCESS (0.503s)
[93.119116] Starting dynamic subtest: vcs1
[93.615543] Dynamic subtest vcs1: SUCCESS (0.504s)
[93.622928] Starting dynamic subtest: vecs0
[94.120360] Dynamic subtest vecs0: SUCCESS (0.504s)
[94.129806] Starting dynamic subtest: ccs0
[94.624535] Dynamic subtest ccs0: SUCCESS (0.503s)
[94.625953] Subtest idle: SUCCESS (3.126s)
[94.717226] [012/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[94.815883] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[94.817728] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[94.962546] [013/133] (930s left) kms_invalid_mode (zero-hdisplay)
[95.054840] Starting subtest: zero-hdisplay
[95.055891] Starting dynamic subtest: pipe-A-eDP-1
[95.339209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[95.347033] Starting dynamic subtest: pipe-B-eDP-1
[95.348322] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[95.354776] Starting dynamic subtest: pipe-C-eDP-1
[95.355738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[95.362537] Starting dynamic subtest: pipe-D-eDP-1
[95.363467] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[95.364419] Subtest zero-hdisplay: SUCCESS (0.289s)
[96.171187] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[96.263452] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[96.264434] Starting dynamic subtest: pipe-A
[96.327788] Dynamic subtest pipe-A: SUCCESS (0.065s)
[96.337079] Starting dynamic subtest: pipe-B
[97.470099] Dynamic subtest pipe-B: SUCCESS (1.142s)
[97.478629] Starting dynamic subtest: pipe-C
[98.580088] Dynamic subtest pipe-C: SUCCESS (1.109s)
[98.587328] Starting dynamic subtest: pipe-D
[99.714971] Dynamic subtest pipe-D: SUCCESS (1.135s)
[99.716179] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.453s)
[100.899886] [015/133] (924s left) drm_read (fault-buffer)
[101.052897] Starting subtest: fault-buffer
[101.053992] Subtest fault-buffer: SUCCESS (0.000s)
[101.232202] [016/133] (923s left) gem_ccs (suspend-resume)
[101.292250] Starting subtest: suspend-resume
[101.294253] Subtest suspend-resume: SKIP (0.000s)
[101.426714] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[101.517465] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[101.518353] Starting dynamic subtest: pipe-A-eDP-1
[101.526663] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.533904] Starting dynamic subtest: pipe-B-eDP-1
[101.542215] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.549181] Starting dynamic subtest: pipe-C-eDP-1
[101.557163] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.563616] Starting dynamic subtest: pipe-D-eDP-1
[101.571751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.573383] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[103.766588] [018/133] (921s left) gem_close (many-handles-one-vma)
[103.839205] Starting subtest: many-handles-one-vma
[103.864234] Subtest many-handles-one-vma: SUCCESS (0.025s)
[104.015784] [019/133] (921s left) gem_busy (extended)
[104.209068] Starting subtest: extended
[104.210049] Starting dynamic subtest: rcs0
[104.310508] Dynamic subtest rcs0: SUCCESS (0.101s)
[104.319952] Starting dynamic subtest: bcs0
[104.351869] Dynamic subtest bcs0: SUCCESS (0.041s)
[104.359459] Starting dynamic subtest: vcs0
[105.943612] Dynamic subtest vcs0: SUCCESS (1.587s)
[105.953722] Starting dynamic subtest: vcs1
[107.927404] Dynamic subtest vcs1: SUCCESS (1.981s)
[107.937080] Starting dynamic subtest: vecs0
[109.911789] Dynamic subtest vecs0: SUCCESS (1.982s)
[109.921749] Starting dynamic subtest: ccs0
[109.954764] Dynamic subtest ccs0: SUCCESS (0.045s)
[109.955889] Subtest extended: SUCCESS (5.743s)
[110.230919] [020/133] (915s left) kms_vblank (ts-continuation-suspend)
[110.323857] Starting subtest: ts-continuation-suspend
[110.324924] Starting dynamic subtest: pipe-A-eDP-1
[127.727309] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[127.737710] Starting dynamic subtest: pipe-D-eDP-1
[145.729122] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.589s)
[145.729965] Subtest ts-continuation-suspend: SUCCESS (4.517s)
[152.551255] [021/133] (878s left) perf_pmu (semaphore-wait-idle)
[152.586426] Starting subtest: semaphore-wait-idle
[152.587624] Starting dynamic subtest: rcs0
[153.103640] Dynamic subtest rcs0: SUCCESS (0.514s)
[153.113624] Starting dynamic subtest: bcs0
[153.619396] Dynamic subtest bcs0: SUCCESS (0.515s)
[153.629151] Starting dynamic subtest: vcs0
[154.132111] Dynamic subtest vcs0: SUCCESS (0.519s)
[154.141113] Starting dynamic subtest: vcs1
[154.646342] Dynamic subtest vcs1: SUCCESS (0.519s)
[154.655250] Starting dynamic subtest: vecs0
[155.159751] Dynamic subtest vecs0: SUCCESS (0.519s)
[155.168395] Starting dynamic subtest: ccs0
[155.675648] Dynamic subtest ccs0: SUCCESS (0.520s)
[155.676873] Subtest semaphore-wait-idle: SUCCESS (3.115s)
[156.885471] [022/133] (874s left) kms_debugfs (display-off-read-all)
[156.971885] Starting subtest: display-off-read-all
[157.266971] Subtest display-off-read-all: SUCCESS (0.298s)
[158.137790] [023/133] (873s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[158.223262] Starting subtest: fbc-rgb101010-draw-blt
[162.812197] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.617s)
[164.015483] [024/133] (867s left) gem_ctx_param (invalid-get-no-zeromap)
[164.070090] Starting subtest: invalid-get-no-zeromap
[164.071197] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[164.215346] [025/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[164.308817] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[164.310576] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[164.430583] [026/133] (867s left) gem_exec_big (single)
[164.476838] Starting subtest: single
[166.771613] Subtest single: SUCCESS (2.299s)
[167.016437] [027/133] (864s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[167.157330] Starting subtest: psr-rgb101010-draw-mmap-gtt
[167.159113] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[167.286151] [028/133] (864s left) gem_exec_flush (basic-uc-prw-default)
[167.350841] Starting subtest: basic-uc-prw-default
[172.804970] Subtest basic-uc-prw-default: SUCCESS (5.466s)
[173.013777] [029/133] (858s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[173.121560] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[173.123500] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[173.252973] [030/133] (858s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[173.344612] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[180.246405] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.907s)
[180.426061] [031/133] (851s left) gem_exec_create (forked)
[180.495656] Starting subtest: forked
[180.496677] Starting dynamic subtest: smem
[201.726503] Dynamic subtest smem: SUCCESS (21.227s)
[201.728248] Subtest forked: SUCCESS (21.229s)
[201.925089] [032/133] (829s left) kms_feature_discovery (display-1x)
[202.024535] Starting subtest: display-1x
[202.025472] Subtest display-1x: SUCCESS (0.000s)
[202.116820] [033/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[202.215974] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[202.217703] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[202.342802] [034/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[202.441621] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[202.443465] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[202.570122] [035/133] (829s left) gem_render_copy_redux (interruptible)
[202.629663] Starting subtest: interruptible
[202.908292] Subtest interruptible: SUCCESS (0.280s)
[203.072835] [036/133] (828s left) i915_pm_rpm (system-suspend-execbuf)
[204.944266] Starting subtest: system-suspend-execbuf
[264.025197] Subtest system-suspend-execbuf: SUCCESS (44.198s)
[264.410848] [037/133] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[264.503701] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[264.505494] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[264.640252] [038/133] (767s left) gem_request_retire (retire-vma-not-inactive)
[264.696720] Starting subtest: retire-vma-not-inactive
[264.755717] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[264.919468] [039/133] (766s left) i915_pm_rps (thresholds-idle)
[264.989721] Starting subtest: thresholds-idle
[264.991671] Subtest thresholds-idle: SKIP (0.001s)
[265.124181] [040/133] (766s left) gem_ctx_persistence (legacy-engines-queued)
[265.182815] Starting subtest: legacy-engines-queued
[265.183971] Starting dynamic subtest: render
[265.309530] Dynamic subtest render: SUCCESS (0.126s)
[265.321464] Starting dynamic subtest: bsd1
[266.737457] Dynamic subtest bsd1: SUCCESS (1.423s)
[266.748553] Starting dynamic subtest: bsd2
[268.782024] Dynamic subtest bsd2: SUCCESS (2.040s)
[268.791801] Starting dynamic subtest: blt
[268.867063] Dynamic subtest blt: SUCCESS (0.084s)
[268.877672] Starting dynamic subtest: vebox
[270.766043] Dynamic subtest vebox: SUCCESS (1.894s)
[270.767711] Subtest legacy-engines-queued: SUCCESS (5.580s)
[270.863040] [041/133] (761s left) i915_hangman (gt-error-state-capture)
[270.937922] Starting subtest: gt-error-state-capture
[270.938913] Starting dynamic subtest: rcs0
[282.733961] Dynamic subtest rcs0: SUCCESS (11.793s)
[282.746353] Starting dynamic subtest: bcs0
[293.742482] Dynamic subtest bcs0: SUCCESS (11.008s)
[293.753766] Starting dynamic subtest: vcs0
[305.709432] Dynamic subtest vcs0: SUCCESS (11.969s)
[305.720508] Starting dynamic subtest: vcs1
[315.693358] Dynamic subtest vcs1: SUCCESS (9.985s)
[315.704516] Starting dynamic subtest: vecs0
[326.701368] Dynamic subtest vecs0: SUCCESS (11.010s)
[326.712732] Starting dynamic subtest: ccs0
[336.751587] Dynamic subtest ccs0: SUCCESS (10.044s)
[336.753066] Subtest gt-error-state-capture: SUCCESS (65.819s)
[336.848672] [042/133] (695s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[337.070530] Starting subtest: cursor-rapid-movement-128x42
[337.112035] Subtest cursor-rapid-movement-128x42: SKIP (0.039s)
[337.365710] [043/133] (694s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[337.420719] Subtest writes-after-reads-uncached: SKIP (0.000s)
[337.501227] [044/133] (694s left) gem_mmap_wc (coherency)
[337.560347] Subtest coherency: SKIP (0.000s)
[337.626270] [045/133] (694s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[337.687369] Starting subtest: single-wait-all-for-submit-signaled
[337.688416] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[337.816664] [046/133] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[337.913640] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[341.577898] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.664s)
[342.783784] [047/133] (689s left) kms_psr (fbc-psr-primary-mmap-cpu)
[342.876499] Starting subtest: fbc-psr-primary-mmap-cpu
[342.877466] Starting dynamic subtest: eDP-1
[342.879389] Dynamic subtest eDP-1: SKIP (0.000s)
[342.881104] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[342.969649] [048/133] (689s left) kms_invalid_mode (bad-vsync-start)
[343.062446] Starting subtest: bad-vsync-start
[343.063357] Starting dynamic subtest: pipe-A-eDP-1
[343.345232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[343.354883] Starting dynamic subtest: pipe-B-eDP-1
[343.355751] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[343.363442] Starting dynamic subtest: pipe-C-eDP-1
[343.364346] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[343.372053] Starting dynamic subtest: pipe-D-eDP-1
[343.373026] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[343.373971] Subtest bad-vsync-start: SUCCESS (0.288s)
[344.209755] [049/133] (688s left) gem_exec_reloc (basic-wc-gtt)
[344.273086] Subtest basic-wc-gtt: SKIP (0.000s)
[344.381948] [050/133] (687s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[344.443361] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[344.509610] [051/133] (687s left) kms_prop_blob (blob-multiple)
[344.567724] Starting subtest: blob-multiple
[344.570437] Subtest blob-multiple: SUCCESS (0.002s)
[344.700186] [052/133] (687s left) api_intel_allocator (open-vm)
[344.754359] Starting subtest: open-vm
[344.756523] Subtest open-vm: SUCCESS (0.003s)
[344.916468] [053/133] (687s left) kms_getfb (getfb-repeated-different-handles)
[345.012259] Starting subtest: getfb-repeated-different-handles
[345.013152] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[345.139886] [054/133] (687s left) kms_content_protection (legacy-hdcp14)
[345.280045] Starting subtest: legacy-hdcp14
[345.282138] Subtest legacy-hdcp14: SKIP (0.000s)
[345.418590] [055/133] (687s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[345.819876] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[346.593219] [056/133] (685s left) kms_flip (blocking-absolute-wf_vblank)
[346.699393] Starting subtest: blocking-absolute-wf_vblank
[346.701649] Starting dynamic subtest: A-eDP1
[355.479373] Dynamic subtest A-eDP1: SUCCESS (8.777s)
[355.489679] Starting dynamic subtest: B-eDP1
[364.207582] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[364.218207] Starting dynamic subtest: C-eDP1
[372.929370] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[372.937439] Starting dynamic subtest: D-eDP1
[381.663752] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[381.666690] Subtest blocking-absolute-wf_vblank: SUCCESS (34.967s)
[382.890725] [057/133] (649s left) gem_mmap_offset (bad-object)
[382.955097] Starting subtest: bad-object
[382.956242] Subtest bad-object: SUCCESS (0.001s)
[383.075780] [058/133] (649s left) kms_psr (psr2-no-drrs)
[383.164153] Starting subtest: psr2-no-drrs
[383.165074] Starting dynamic subtest: eDP-1
[384.742052] Dynamic subtest eDP-1: SUCCESS (1.576s)
[384.743057] Subtest psr2-no-drrs: SUCCESS (1.578s)
[385.551111] [059/133] (647s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[385.613883] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[385.678292] [060/133] (646s left) kms_vblank (wait-idle)
[385.769961] Starting subtest: wait-idle
[385.771027] Starting dynamic subtest: pipe-A-eDP-1
[387.521254] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[387.531542] Starting dynamic subtest: pipe-D-eDP-1
[389.961499] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s)
[389.962402] Subtest wait-idle: SUCCESS (4.194s)
[390.809830] [061/133] (641s left) gem_exec_whisper (basic-contexts-all)
[390.884248] Starting subtest: basic-contexts-all
[402.735038] Subtest basic-contexts-all: SUCCESS (11.850s)
[402.938607] [062/133] (629s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[403.044345] Starting subtest: x-tiled-16bpp-rotate-0
[404.411768] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[404.578021] [063/133] (628s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[404.672910] Starting subtest: plane-primary-overlay-mutable-zpos
[408.112013] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.440s)
[409.318509] [064/133] (623s left) gen9_exec_parse (bb-start-cmd)
[409.374052] Subtest bb-start-cmd: SKIP (0.000s)
[409.459826] [065/133] (623s left) kms_cursor_crc (cursor-alpha-opaque)
[409.545360] Starting subtest: cursor-alpha-opaque
[409.546365] Starting dynamic subtest: pipe-A-eDP-1
[410.189484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s)
[410.198749] Starting dynamic subtest: pipe-D-eDP-1
[411.470908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[411.471860] Subtest cursor-alpha-opaque: SUCCESS (1.926s)
[412.305608] [066/133] (620s left) kms_cursor_crc (cursor-sliding-64x64)
[412.478705] Starting subtest: cursor-sliding-64x64
[412.482085] Starting dynamic subtest: pipe-A-eDP-1
[415.685591] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.204s)
[415.713443] Starting dynamic subtest: pipe-D-eDP-1
[419.562297] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.852s)
[419.563270] Subtest cursor-sliding-64x64: SUCCESS (7.079s)
[420.381453] [067/133] (612s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[420.478155] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[427.276046] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.800s)
[427.451703] [068/133] (605s left) gem_ctx_shared (exec-single-timeline)
[427.512508] Starting subtest: exec-single-timeline
[427.513538] Starting dynamic subtest: rcs0
[428.587970] Dynamic subtest rcs0: SUCCESS (1.072s)
[428.599503] Starting dynamic subtest: bcs0
[429.675895] Dynamic subtest bcs0: SUCCESS (1.084s)
[429.687208] Starting dynamic subtest: vcs0
[430.763839] Dynamic subtest vcs0: SUCCESS (1.085s)
[430.774040] Starting dynamic subtest: vcs1
[431.855845] Dynamic subtest vcs1: SUCCESS (1.088s)
[431.865668] Starting dynamic subtest: vecs0
[432.941681] Dynamic subtest vecs0: SUCCESS (1.083s)
[432.951758] Starting dynamic subtest: ccs0
[434.028933] Dynamic subtest ccs0: SUCCESS (1.085s)
[434.030413] Subtest exec-single-timeline: SUCCESS (6.518s)
[434.841685] [069/133] (598s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[434.945975] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[434.946870] Starting dynamic subtest: pipe-A
[436.062707] Dynamic subtest pipe-A: SUCCESS (1.118s)
[436.072360] Starting dynamic subtest: pipe-B
[438.312091] Dynamic subtest pipe-B: SUCCESS (2.248s)
[438.322760] Starting dynamic subtest: pipe-C
[439.483544] Dynamic subtest pipe-C: SUCCESS (1.171s)
[439.493023] Starting dynamic subtest: pipe-D
[440.708290] Dynamic subtest pipe-D: SUCCESS (1.222s)
[440.709257] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.765s)
[441.914779] [070/133] (591s left) gem_wait (write-busy)
[441.989836] Starting subtest: write-busy
[441.990939] Starting dynamic subtest: all-engines
[442.624839] Dynamic subtest all-engines: SUCCESS (0.634s)
[442.641322] Starting dynamic subtest: rcs0
[443.183552] Dynamic subtest rcs0: SUCCESS (0.556s)
[443.198588] Starting dynamic subtest: bcs0
[443.736833] Dynamic subtest bcs0: SUCCESS (0.551s)
[443.752749] Starting dynamic subtest: vcs0
[445.774756] Dynamic subtest vcs0: SUCCESS (2.035s)
[445.790520] Starting dynamic subtest: vcs1
[447.759355] Dynamic subtest vcs1: SUCCESS (1.982s)
[447.774751] Starting dynamic subtest: vecs0
[449.806844] Dynamic subtest vecs0: SUCCESS (2.045s)
[449.822143] Starting dynamic subtest: ccs0
[450.356892] Dynamic subtest ccs0: SUCCESS (0.550s)
[450.360171] Subtest write-busy: SUCCESS (8.371s)
[450.578452] [071/133] (582s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[450.676807] Starting subtest: y-tiled-8bpp-rotate-0
[450.678761] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[450.802782] [072/133] (582s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[450.926504] Starting subtest: basic-busy-flip-before-cursor-legacy
[450.928288] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[451.089087] [073/133] (582s left) gem_basic (bad-close)
[451.143605] Starting subtest: bad-close
[451.145547] Subtest bad-close: SUCCESS (0.000s)
[451.258955] [074/133] (581s left) kms_big_fb (linear-16bpp-rotate-0)
[451.361560] Starting subtest: linear-16bpp-rotate-0
[452.784358] Subtest linear-16bpp-rotate-0: SUCCESS (1.423s)
[452.949443] [075/133] (580s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[457.970921] Starting subtest: pr-overlay-plane-update-continuous-sf
[457.974307] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[458.834631] [076/133] (574s left) drm_read (short-buffer-wakeup)
[458.978078] Starting subtest: short-buffer-wakeup
[491.205578] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[491.388286] [077/133] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[491.491098] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[498.597243] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.103s)
[498.784543] [078/133] (534s left) kms_psr (fbc-pr-cursor-render)
[498.871506] Starting subtest: fbc-pr-cursor-render
[498.873457] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[498.960271] [079/133] (534s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[499.049464] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[499.051592] Starting dynamic subtest: pipe-A-eDP-1
[499.054880] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.063251] Starting dynamic subtest: pipe-B-eDP-1
[499.066465] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.074289] Starting dynamic subtest: pipe-C-eDP-1
[499.077543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.085453] Starting dynamic subtest: pipe-D-eDP-1
[499.088670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.090304] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[501.212835] [080/133] (532s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[501.308207] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[501.309468] Starting dynamic subtest: pipe-A-eDP-1
[502.560078] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.253s)
[502.569630] Starting dynamic subtest: pipe-B-eDP-1
[504.854907] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.293s)
[504.864775] Starting dynamic subtest: pipe-C-eDP-1
[507.183833] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.328s)
[507.193332] Starting dynamic subtest: pipe-D-eDP-1
[509.521153] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.336s)
[509.522115] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.215s)
[510.746747] [081/133] (522s left) sw_sync (sync_multi_timeline_wait)
[510.788195] Starting subtest: sync_multi_timeline_wait
[510.789302] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[510.863457] [082/133] (522s left) sysfs_heartbeat_interval (idempotent)
[510.917807] Starting subtest: idempotent
[510.918877] Starting dynamic subtest: vecs0
[510.920067] Dynamic subtest vecs0: SUCCESS (0.001s)
[510.930821] Starting dynamic subtest: ccs0
[510.931664] Dynamic subtest ccs0: SUCCESS (0.001s)
[510.939570] Starting dynamic subtest: vcs0
[510.940375] Dynamic subtest vcs0: SUCCESS (0.000s)
[510.948038] Starting dynamic subtest: bcs0
[510.948827] Dynamic subtest bcs0: SUCCESS (0.001s)
[510.956490] Starting dynamic subtest: rcs0
[510.957309] Dynamic subtest rcs0: SUCCESS (0.000s)
[510.964854] Starting dynamic subtest: vcs1
[510.965689] Dynamic subtest vcs1: SUCCESS (0.000s)
[510.966500] Subtest idempotent: SUCCESS (0.010s)
[511.065399] [083/133] (522s left) syncobj_eventfd (invalid-bad-pad)
[511.112873] Starting subtest: invalid-bad-pad
[511.113934] Subtest invalid-bad-pad: SUCCESS (0.000s)
[511.232713] [084/133] (522s left) kms_busy (extended-pageflip-hang-newfb)
[511.339218] Starting subtest: extended-pageflip-hang-newfb
[511.340119] Starting dynamic subtest: pipe-A
[537.571887] Dynamic subtest pipe-A: SUCCESS (26.230s)
[537.593431] Starting dynamic subtest: pipe-D
[552.612237] Dynamic subtest pipe-D: SUCCESS (15.037s)
[552.613312] Subtest extended-pageflip-hang-newfb: SUCCESS (41.273s)
[553.537474] [085/133] (479s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[558.571089] Starting subtest: psr2-cursor-plane-update-sf
[558.572029] Starting dynamic subtest: pipe-A-eDP-1
[559.881264] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.308s)
[559.889968] Starting dynamic subtest: pipe-B-eDP-1
[561.232959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.351s)
[561.233967] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.663s)
[562.122404] [086/133] (471s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[562.221677] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[562.891383] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[563.093967] [087/133] (470s left) gem_exec_balancer (busy)
[563.156454] Starting subtest: busy
[564.776925] Subtest busy: SUCCESS (1.618s)
[565.131579] [088/133] (468s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[565.223038] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[565.224905] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[565.356276] [089/133] (468s left) vgem_slow (nohang)
[565.397443] Starting subtest: nohang
[575.404414] Subtest nohang: SUCCESS (10.005s)
[575.489631] [090/133] (458s left) gem_spin_batch (resubmit-new-all)
[575.556034] Starting subtest: resubmit-new-all
[575.557219] Starting dynamic subtest: rcs0
[575.582770] Dynamic subtest rcs0: SUCCESS (0.027s)
[575.593560] Starting dynamic subtest: bcs0
[575.601505] Dynamic subtest bcs0: SUCCESS (0.018s)
[575.609869] Starting dynamic subtest: vcs0
[575.619743] Dynamic subtest vcs0: SUCCESS (0.017s)
[575.629212] Starting dynamic subtest: vcs1
[575.639386] Dynamic subtest vcs1: SUCCESS (0.018s)
[575.647470] Starting dynamic subtest: vecs0
[575.656578] Dynamic subtest vecs0: SUCCESS (0.016s)
[575.666522] Starting dynamic subtest: ccs0
[575.675390] Dynamic subtest ccs0: SUCCESS (0.018s)
[575.676258] Subtest resubmit-new-all: SUCCESS (0.120s)
[576.842378] [091/133] (456s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[576.904379] Starting subtest: mixed-tiled-to-y-tiled-ccs
[576.906350] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[577.118516] [092/133] (456s left) syncobj_timeline (invalid-signal-illegal-point)
[577.181343] Starting subtest: invalid-signal-illegal-point
[577.182332] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[577.311998] [093/133] (456s left) gem_exec_schedule (preempt-contexts)
[577.386917] Starting subtest: preempt-contexts
[577.388054] Starting dynamic subtest: rcs0
[577.481240] Dynamic subtest rcs0: SUCCESS (0.094s)
[577.491867] Starting dynamic subtest: bcs0
[577.564134] Dynamic subtest bcs0: SUCCESS (0.083s)
[577.574196] Starting dynamic subtest: vcs0
[577.627819] Dynamic subtest vcs0: SUCCESS (0.063s)
[577.636128] Starting dynamic subtest: vcs1
[577.679883] Dynamic subtest vcs1: SUCCESS (0.051s)
[577.688554] Starting dynamic subtest: vecs0
[577.734705] Dynamic subtest vecs0: SUCCESS (0.054s)
[577.743563] Starting dynamic subtest: ccs0
[577.816492] Dynamic subtest ccs0: SUCCESS (0.081s)
[577.817480] Subtest preempt-contexts: SUCCESS (0.430s)
[578.907720] [094/133] (454s left) gem_pwrite_snooped
[579.042334] [095/133] (454s left) kms_tiled_display (basic-test-pattern)
[579.165037] Subtest basic-test-pattern: SKIP (0.000s)
[579.221396] [096/133] (454s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[579.318649] Starting subtest: psr-shrfb-scaledprimary
[585.070434] Subtest psr-shrfb-scaledprimary: SUCCESS (5.754s)
[585.229594] [097/133] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[585.319612] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[585.321480] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[585.461894] [098/133] (448s left) gem_pwrite (basic-self)
[585.506553] Subtest basic-self: SKIP (0.000s)
[585.564506] [099/133] (448s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[587.079602] Starting subtest: dpms-mode-unset-non-lpsp
[588.229317] Subtest dpms-mode-unset-non-lpsp: SKIP (1.150s)
[588.615929] [100/133] (445s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[588.719656] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[588.721490] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[588.848757] [101/133] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[588.951571] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[588.953442] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[589.090509] [102/133] (445s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[589.191465] Starting subtest: plane-lut1d-ctm3x4-lut1d
[589.209200] Starting dynamic subtest: pipe-A-eDP-1
[589.689035] Dynamic subtest pipe-A-eDP-1: FAIL (0.334s)
[590.597547] Starting dynamic subtest: pipe-B-eDP-1
[591.119200] Dynamic subtest pipe-B-eDP-1: FAIL (0.322s)
[592.032582] Starting dynamic subtest: pipe-C-eDP-1
[592.514585] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[593.363809] Starting dynamic subtest: pipe-D-eDP-1
[593.817200] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[593.888873] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.699s)
[594.776415] [103/133] (439s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[594.874151] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[601.582968] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.711s)
[601.752097] [104/133] (432s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[601.850149] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[608.815434] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.969s)
[608.969947] [105/133] (425s left) gem_exec_schedule (preempt-queue-contexts-chain)
[609.042192] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[609.360376] [106/133] (424s left) api_intel_bb (object-noreloc-keep-cache-simple)
[609.414702] Starting subtest: object-noreloc-keep-cache-simple
[609.417103] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[609.561448] [107/133] (424s left) gem_mmap (bad-object)
[609.623030] Subtest bad-object: SKIP (0.000s)
[609.682936] [108/133] (424s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[609.783152] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[609.784034] Starting dynamic subtest: pipe-A-default-mode
[610.069157] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[610.070803] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.286s)
[610.915805] [109/133] (423s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[611.013413] Starting subtest: bo-too-small-due-to-tiling
[611.015162] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[611.168576] [110/133] (423s left) kms_psr (pr-sprite-blt)
[611.260242] Starting subtest: pr-sprite-blt
[611.261895] Subtest pr-sprite-blt: SKIP (0.000s)
[611.359838] [111/133] (423s left) kms_draw_crc (fill-fb)
[611.450610] Starting subtest: fill-fb
[611.880951] Subtest fill-fb: SUCCESS (0.430s)
[612.018363] [112/133] (422s left) perf_pmu (busy-idle)
[612.051719] Starting subtest: busy-idle
[612.052547] Starting dynamic subtest: rcs0
[612.761395] Dynamic subtest rcs0: SUCCESS (0.709s)
[612.773034] Starting dynamic subtest: bcs0
[613.436904] Dynamic subtest bcs0: SUCCESS (0.673s)
[613.447729] Starting dynamic subtest: vcs0
[614.799446] Dynamic subtest vcs0: SUCCESS (1.358s)
[614.810201] Starting dynamic subtest: vcs1
[616.784291] Dynamic subtest vcs1: SUCCESS (1.982s)
[616.795629] Starting dynamic subtest: vecs0
[618.767912] Dynamic subtest vecs0: SUCCESS (1.981s)
[618.778723] Starting dynamic subtest: ccs0
[619.445188] Dynamic subtest ccs0: SUCCESS (0.677s)
[619.448458] Subtest busy-idle: SUCCESS (7.396s)
[619.599798] [113/133] (414s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[619.694390] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[619.696709] Starting dynamic subtest: pipe-A-eDP-1
[619.718756] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[619.727684] Starting dynamic subtest: pipe-B-eDP-1
[619.749798] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[619.758255] Starting dynamic subtest: pipe-C-eDP-1
[619.782123] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[619.792242] Starting dynamic subtest: pipe-D-eDP-1
[619.813683] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[619.815542] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.024s)
[622.002107] [114/133] (412s left) gem_exec_flush (basic-batch-kernel-default-uc)
[622.073304] Starting subtest: basic-batch-kernel-default-uc
[629.061053] Subtest basic-batch-kernel-default-uc: SUCCESS (6.989s)
[629.267248] [115/133] (405s left) gem_mmap_wc (write-read-distinct)
[629.318828] Subtest write-read-distinct: SKIP (0.000s)
[629.384346] [116/133] (405s left) kms_plane_lowres (tiling-x)
[629.477914] Starting subtest: tiling-x
[629.478766] Starting dynamic subtest: pipe-A-eDP-1
[629.480439] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[629.771485] Starting dynamic subtest: pipe-B-eDP-1
[629.773096] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[629.781820] Starting dynamic subtest: pipe-C-eDP-1
[629.783953] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[629.792048] Starting dynamic subtest: pipe-D-eDP-1
[629.793991] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[629.795797] Subtest tiling-x: SKIP (0.292s)
[630.624421] [117/133] (404s left) sw_sync (alloc_merge_fence)
[630.664248] Starting subtest: alloc_merge_fence
[630.665217] Subtest alloc_merge_fence: SUCCESS (0.000s)
[630.735224] [118/133] (404s left) kms_pm_backlight (fade)
[630.835143] Starting subtest: fade
[630.887507] Starting dynamic subtest: eDP-1
[633.577051] Dynamic subtest eDP-1: SUCCESS (2.691s)
[633.577997] Subtest fade: SUCCESS (2.743s)
[634.465324] [119/133] (400s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[634.568954] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[634.569811] Starting dynamic subtest: pipe-A-default-mode
[635.714888] Dynamic subtest pipe-A-default-mode: SKIP (1.144s)
[635.716536] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.146s)
[635.905514] [120/133] (398s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[635.966000] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[636.075546] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[636.168945] [121/133] (398s left) kms_psr (psr-cursor-mmap-cpu)
[636.268373] Starting subtest: psr-cursor-mmap-cpu
[636.269254] Starting dynamic subtest: eDP-1
[637.968376] Dynamic subtest eDP-1: SUCCESS (1.699s)
[637.969272] Subtest psr-cursor-mmap-cpu: SUCCESS (1.701s)
[638.857426] [122/133] (396s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[638.961660] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[639.620758] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[639.778401] [123/133] (395s left) gem_exec_whisper (basic-queues-priority-all)
[639.848628] Starting subtest: basic-queues-priority-all
[662.211444] Subtest basic-queues-priority-all: SUCCESS (22.364s)
[662.416459] [124/133] (372s left) syncobj_timeline (etime-single-wait-all-submitted)
[662.471820] Starting subtest: etime-single-wait-all-submitted
[662.580313] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[662.674599] [125/133] (372s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[662.763704] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[662.765497] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[662.881382] [126/133] (372s left) kms_async_flips (async-flip-dpms)
[662.974332] Starting subtest: async-flip-dpms
[663.350212] Starting dynamic subtest: pipe-A-eDP-1
[667.148921] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.799s)
[667.550367] Starting dynamic subtest: pipe-B-eDP-1
[670.316676] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.775s)
[670.714498] Starting dynamic subtest: pipe-C-eDP-1
[673.493138] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.787s)
[673.885791] Starting dynamic subtest: pipe-D-eDP-1
[676.666024] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.789s)
[676.668339] Subtest async-flip-dpms: SUCCESS (13.696s)
[677.864912] [127/133] (357s left) gem_exec_reloc (basic-cpu-read-noreloc)
[677.917108] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[677.989375] [128/133] (357s left) syncobj_wait (invalid-reset-illegal-handle)
[678.041016] Starting subtest: invalid-reset-illegal-handle
[678.042047] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[678.169528] [129/133] (356s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[678.222416] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[678.331742] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[678.424599] [130/133] (356s left) gem_tiled_swapping (non-threaded)
[678.478821] Subtest non-threaded: SKIP (0.000s)
[678.525800] [131/133] (356s left) gem_exec_fence (syncobj-timeline-chain-engines)
[679.075031] Starting subtest: syncobj-timeline-chain-engines
[679.201365] Subtest syncobj-timeline-chain-engines: SUCCESS (0.127s)
[680.907637] [132/133] (354s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[681.035233] Starting subtest: flip-vs-cursor-legacy
[688.129219] Subtest flip-vs-cursor-legacy: SUCCESS (7.094s)
[688.997202] [133/133] (346s left) syncobj_basic (illegal-fd-to-handle)
[689.052349] Starting subtest: illegal-fd-to-handle
[689.053206] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[689.174206] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_suspend
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: drm_read
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_debugfs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_big
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_request_retire
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_tiled_display
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: syncobj_basic
Done.