[58.828200] Initializing watchdogs
[58.828333]   /dev/watchdog0
[58.846453] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.850851] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.853056] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.856167] [001/133] (960s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[58.979726] Starting subtest: 4-tiled-16bpp-rotate-90
[59.014681] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.033s)
[59.145632] [002/133] (960s left) gem_exec_fence (basic-busy)
[59.326552] Starting subtest: basic-busy
[59.328988] Starting dynamic subtest: rcs0
[59.406339] Dynamic subtest rcs0: SUCCESS (0.083s)
[59.415788] Starting dynamic subtest: bcs0
[59.477117] Dynamic subtest bcs0: SUCCESS (0.070s)
[59.486556] Starting dynamic subtest: vcs0
[59.538246] Dynamic subtest vcs0: SUCCESS (0.060s)
[59.547332] Starting dynamic subtest: vcs1
[59.592637] Dynamic subtest vcs1: SUCCESS (0.053s)
[59.602113] Starting dynamic subtest: vecs0
[59.645099] Dynamic subtest vecs0: SUCCESS (0.052s)
[59.654738] Starting dynamic subtest: ccs0
[59.703725] Dynamic subtest ccs0: SUCCESS (0.056s)
[59.706063] Subtest basic-busy: SUCCESS (0.379s)
[62.032215] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[62.035177] [003/133] (957s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[64.002475] Starting subtest: modeset-lpsp-stress-no-wait
[73.741400] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.738s)
[73.828686] [004/133] (945s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[73.920831] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[73.923312] Starting dynamic subtest: pipe-A-default-mode
[75.054161] Dynamic subtest pipe-A-default-mode: SKIP (1.131s)
[75.058570] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.132s)
[75.243096] [005/133] (944s left) syncobj_timeline (invalid-query-zero-handles)
[75.308020] Starting subtest: invalid-query-zero-handles
[75.310421] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[75.416334] [006/133] (944s left) kms_rmfb (close-fd)
[75.515625] Starting subtest: close-fd
[75.517884] Starting dynamic subtest: pipe-A-eDP-1
[75.622792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[75.631815] Starting dynamic subtest: pipe-B-eDP-1
[76.781961] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[76.791264] Starting dynamic subtest: pipe-C-eDP-1
[77.912857] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[77.921651] Starting dynamic subtest: pipe-D-eDP-1
[79.051079] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[79.053383] Subtest close-fd: SUCCESS (3.535s)
[80.283221] [007/133] (939s left) gem_spin_batch (spin-all)
[80.351785] Starting subtest: spin-all
[80.367528] Subtest spin-all: SUCCESS (0.015s)
[81.927428] [008/133] (937s left) gem_exec_fence (keep-in-fence)
[82.103202] Starting subtest: keep-in-fence
[82.105820] Starting dynamic subtest: rcs0
[82.178254] Dynamic subtest rcs0: SUCCESS (0.075s)
[82.186973] Starting dynamic subtest: bcs0
[82.231747] Dynamic subtest bcs0: SUCCESS (0.053s)
[82.239601] Starting dynamic subtest: vcs0
[83.925446] Dynamic subtest vcs0: SUCCESS (1.692s)
[83.933976] Starting dynamic subtest: vcs1
[85.910226] Dynamic subtest vcs1: SUCCESS (1.982s)
[85.920386] Starting dynamic subtest: vecs0
[87.894187] Dynamic subtest vecs0: SUCCESS (1.983s)
[87.903728] Starting dynamic subtest: ccs0
[88.119984] Dynamic subtest ccs0: SUCCESS (0.226s)
[88.123031] Subtest keep-in-fence: SUCCESS (6.016s)
[90.012935] [009/133] (929s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[90.131819] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[90.136140] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[90.256344] [010/133] (929s left) kms_psr (fbc-psr-dpms)
[90.360253] Starting subtest: fbc-psr-dpms
[90.362607] Starting dynamic subtest: eDP-1
[90.367162] Dynamic subtest eDP-1: SKIP (0.000s)
[90.371729] Subtest fbc-psr-dpms: SKIP (0.000s)
[90.443128] [011/133] (929s left) syncobj_timeline (multi-wait-signaled)
[90.513601] Starting subtest: multi-wait-signaled
[90.515782] Subtest multi-wait-signaled: SUCCESS (0.001s)
[90.634551] [012/133] (929s left) kms_flip (blocking-wf_vblank)
[90.738614] Starting subtest: blocking-wf_vblank
[90.741096] Starting dynamic subtest: A-eDP1
[99.628420] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[99.638232] Starting dynamic subtest: B-eDP1
[108.566069] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[108.575930] Starting dynamic subtest: C-eDP1
[117.488898] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[117.496916] Starting dynamic subtest: D-eDP1
[126.433448] Dynamic subtest D-eDP1: SUCCESS (8.944s)
[126.438378] Subtest blocking-wf_vblank: SUCCESS (35.698s)
[127.678170] [013/133] (892s left) kms_dsc (dsc-with-output-formats)
[127.779016] Starting subtest: dsc-with-output-formats
[127.800355] Subtest dsc-with-output-formats: SKIP (0.001s)
[127.863604] [014/133] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[127.966352] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[127.970561] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[128.101137] [015/133] (891s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[128.205458] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[135.638086] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.436s)
[135.795770] [016/133] (884s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[135.906356] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[135.910894] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[136.024981] [017/133] (883s left) gem_lmem_swapping (parallel-random-engines)
[136.070697] Subtest parallel-random-engines: SKIP (0.000s)
[136.117371] [018/133] (883s left) gem_exec_reloc (basic-wc-cpu-active)
[136.180379] Subtest basic-wc-cpu-active: SKIP (0.000s)
[136.268476] [019/133] (883s left) gem_ctx_isolation (clean)
[136.326425] Starting subtest: clean
[136.328820] Starting dynamic subtest: rcs0
[136.391080] Dynamic subtest rcs0: SUCCESS (0.064s)
[136.400915] Starting dynamic subtest: bcs0
[136.450226] Dynamic subtest bcs0: SUCCESS (0.059s)
[136.457613] Starting dynamic subtest: vcs0
[136.520346] Dynamic subtest vcs0: SUCCESS (0.070s)
[136.529636] Starting dynamic subtest: vcs1
[137.880837] Dynamic subtest vcs1: SUCCESS (1.360s)
[137.888916] Starting dynamic subtest: vecs0
[139.932313] Dynamic subtest vecs0: SUCCESS (2.051s)
[139.941723] Starting dynamic subtest: ccs0
[141.961446] Dynamic subtest ccs0: SUCCESS (2.029s)
[141.963636] Subtest clean: SUCCESS (5.634s)
[142.187931] [020/133] (877s left) kms_rotation_crc (sprite-rotation-90)
[142.284080] Starting subtest: sprite-rotation-90
[142.288466] Subtest sprite-rotation-90: SKIP (0.001s)
[142.368608] [021/133] (877s left) gem_ctx_engines (invalid-engines)
[142.433819] Starting subtest: invalid-engines
[142.440484] Subtest invalid-engines: SUCCESS (0.009s)
[142.733981] [022/133] (877s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[142.837522] Starting subtest: psr-farfromfence-mmap-gtt
[142.841869] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[142.954078] [023/133] (877s left) kms_big_fb (linear-32bpp-rotate-180)
[143.064247] Starting subtest: linear-32bpp-rotate-180
[144.542705] Subtest linear-32bpp-rotate-180: SUCCESS (1.478s)
[144.723974] [024/133] (875s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[144.788444] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[144.792246] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[144.986692] [025/133] (875s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[145.084694] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[145.087069] Starting dynamic subtest: pipe-A-eDP-1
[145.145544] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[145.152652] Starting dynamic subtest: pipe-B-eDP-1
[145.209250] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[145.218329] Starting dynamic subtest: pipe-C-eDP-1
[145.275613] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[145.284902] Starting dynamic subtest: pipe-D-eDP-1
[145.343594] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[145.347592] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[147.267032] [026/133] (873s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[147.369881] Starting subtest: compare-crc-sanitycheck-nv12
[147.372262] Starting dynamic subtest: pipe-A-eDP-1
[148.083541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[148.093075] Starting dynamic subtest: pipe-B-eDP-1
[149.368980] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[149.379415] Starting dynamic subtest: pipe-C-eDP-1
[150.639448] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.267s)
[150.648420] Starting dynamic subtest: pipe-D-eDP-1
[151.847295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.210s)
[151.849527] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.477s)
[152.712478] [027/133] (867s left) kms_invalid_mode (uint-max-clock)
[152.816886] Starting subtest: uint-max-clock
[152.819279] Starting dynamic subtest: pipe-A-eDP-1
[153.106060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[153.114781] Starting dynamic subtest: pipe-B-eDP-1
[153.116736] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[153.123746] Starting dynamic subtest: pipe-C-eDP-1
[153.125714] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[153.133140] Starting dynamic subtest: pipe-D-eDP-1
[153.135373] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[153.137650] Subtest uint-max-clock: SUCCESS (0.297s)
[153.925496] [028/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[154.028996] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[154.033143] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[154.150253] [029/133] (866s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[154.244596] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[154.273447] Starting dynamic subtest: pipe-A-plane-0
[154.573407] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[154.582054] Starting dynamic subtest: pipe-A-plane-3
[154.806772] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[154.815585] Starting dynamic subtest: pipe-A-plane-5
[154.819975] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[155.898437] Starting dynamic subtest: pipe-B-plane-0
[156.188020] Dynamic subtest pipe-B-plane-0: SUCCESS (0.299s)
[156.196936] Starting dynamic subtest: pipe-B-plane-3
[156.445183] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[156.452627] Starting dynamic subtest: pipe-B-plane-5
[156.456648] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[156.762744] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.516s)
[157.590319] [030/133] (862s left) gem_exec_schedule (semaphore-codependency)
[157.676166] Starting subtest: semaphore-codependency
[157.682091] Subtest semaphore-codependency: SUCCESS (0.014s)
[158.086279] [031/133] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[158.183542] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[165.623432] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.442s)
[165.784701] [032/133] (854s left) gem_exec_params (sol-reset-not-gen7)
[165.848575] Starting subtest: sol-reset-not-gen7
[165.854364] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[166.010788] [033/133] (854s left) gem_exec_balancer (bonded-false-hang)
[166.275735] Starting subtest: bonded-false-hang
[166.281036] Subtest bonded-false-hang: SKIP (0.000s)
[166.423061] [034/133] (854s left) gen9_exec_parse (allowed-all)
[166.489847] Subtest allowed-all: SKIP (0.000s)
[166.583546] [035/133] (854s left) gem_ccs (block-multicopy-compressed)
[166.656071] Starting subtest: block-multicopy-compressed
[166.660640] Subtest block-multicopy-compressed: SKIP (0.000s)
[166.784976] [036/133] (854s left) gem_ctx_bad_destroy (invalid-pad)
[166.843290] Starting subtest: invalid-pad
[166.845570] Subtest invalid-pad: SUCCESS (0.000s)
[166.933731] [037/133] (853s left) kms_async_flips (invalid-async-flip-atomic)
[167.024136] Starting subtest: invalid-async-flip-atomic
[167.404066] Starting dynamic subtest: pipe-A-eDP-1
[168.226405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[168.587593] Starting dynamic subtest: pipe-B-eDP-1
[169.360569] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.779s)
[169.741293] Starting dynamic subtest: pipe-C-eDP-1
[170.501665] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[170.863373] Starting dynamic subtest: pipe-D-eDP-1
[171.628544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[171.630937] Subtest invalid-async-flip-atomic: SUCCESS (4.606s)
[172.783712] [038/133] (848s left) vgem_slow (nohang)
[172.824148] Starting subtest: nohang
[182.899432] Subtest nohang: SUCCESS (10.075s)
[182.976535] [039/133] (837s left) kms_chamelium_hpd (hdmi-hpd)
[183.362597] Subtest hdmi-hpd: SKIP (0.000s)
[184.176437] [040/133] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[184.282261] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[193.552326] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.271s)
[193.723243] [041/133] (827s left) kms_addfb_basic (unused-offsets)
[193.785076] Starting subtest: unused-offsets
[193.787297] Subtest unused-offsets: SUCCESS (0.000s)
[193.973460] [042/133] (827s left) prime_udl
[194.053667] [043/133] (827s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[194.174391] Starting subtest: 2x-cursor-vs-flip-atomic
[194.178900] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[194.328947] [044/133] (826s left) kms_lease (empty-lease)
[194.432989] Starting subtest: empty-lease
[194.435291] Starting dynamic subtest: pipe-A-eDP-1
[194.437571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[194.448581] Starting dynamic subtest: pipe-B-eDP-1
[194.450728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[194.458270] Starting dynamic subtest: pipe-C-eDP-1
[194.460426] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[194.467757] Starting dynamic subtest: pipe-D-eDP-1
[194.469958] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[194.472147] Subtest empty-lease: SUCCESS (0.009s)
[194.572333] [045/133] (826s left) gen3_render_tiledy_blits
[194.710667] [046/133] (826s left) kms_cursor_crc (cursor-onscreen-128x128)
[194.928998] Starting subtest: cursor-onscreen-128x128
[194.933430] Starting dynamic subtest: pipe-A-eDP-1
[197.061192] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.126s)
[197.088933] Starting dynamic subtest: pipe-D-eDP-1
[199.848120] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[199.850375] Subtest cursor-onscreen-128x128: SUCCESS (4.917s)
[200.704056] [047/133] (820s left) gem_ctx_shared (q-smoketest-all)
[200.783686] Starting subtest: Q-smoketest-all
[233.173376] Subtest Q-smoketest-all: SUCCESS (32.341s)
[234.974178] [048/133] (786s left) gem_mmap_gtt (basic-write-read-distinct)
[235.035250] Subtest basic-write-read-distinct: SKIP (0.000s)
[235.100160] [049/133] (786s left) kms_frontbuffer_tracking (fbc-stridechange)
[235.212447] Starting subtest: fbc-stridechange
[238.516898] Subtest fbc-stridechange: SUCCESS (3.307s)
[239.719493] [050/133] (781s left) kms_plane (planar-pixel-format-settings)
[239.821570] Starting subtest: planar-pixel-format-settings
[239.886486] Subtest planar-pixel-format-settings: SUCCESS (0.065s)
[240.043610] [051/133] (781s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[240.140151] Starting subtest: plane-upscale-20x20-with-rotation
[240.142443] Starting dynamic subtest: pipe-A
[240.364773] Dynamic subtest pipe-A: SUCCESS (0.226s)
[240.373417] Starting dynamic subtest: pipe-B
[241.681510] Dynamic subtest pipe-B: SUCCESS (1.316s)
[241.690400] Starting dynamic subtest: pipe-C
[243.020067] Dynamic subtest pipe-C: SUCCESS (1.338s)
[243.028404] Starting dynamic subtest: pipe-D
[244.349357] Dynamic subtest pipe-D: SUCCESS (1.329s)
[244.351715] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.212s)
[245.550210] [052/133] (775s left) i915_pm_rps (engine-order)
[245.619574] Starting subtest: engine-order
[251.892675] Subtest engine-order: SUCCESS (6.272s)
[252.046058] [053/133] (769s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[252.154562] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[252.158949] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[252.266100] [054/133] (769s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[252.365221] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[252.367499] Starting dynamic subtest: pipe-A-eDP-1
[252.387888] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[252.397811] Starting dynamic subtest: pipe-B-eDP-1
[252.417193] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[252.425179] Starting dynamic subtest: pipe-C-eDP-1
[252.444356] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[252.452436] Starting dynamic subtest: pipe-D-eDP-1
[252.471466] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[252.473649] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[254.602887] [055/133] (766s left) gem_mmap (short-mmap)
[254.656035] Subtest short-mmap: SKIP (0.000s)
[254.717696] [056/133] (766s left) gem_partial_pwrite_pread (reads-uncached)
[254.771403] Subtest reads-uncached: SKIP (0.000s)
[254.848457] [057/133] (766s left) syncobj_wait (wait-all-delayed-signal)
[254.916670] Starting subtest: wait-all-delayed-signal
[255.021662] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[255.108387] [058/133] (766s left) gem_mmap_offset (mmap-boundaries)
[255.162550] Starting subtest: mmap-boundaries
[255.164589] Starting dynamic subtest: smem0
[255.438155] Dynamic subtest smem0: SUCCESS (0.277s)
[255.440591] Subtest mmap-boundaries: SUCCESS (0.278s)
[255.601654] [059/133] (766s left) syncobj_timeline (wait-for-submit-snapshot)
[255.662986] Starting subtest: wait-for-submit-snapshot
[255.743730] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[255.830529] [060/133] (765s left) kms_chamelium_color (ctm-negative)
[255.921703] Subtest ctm-negative: SKIP (0.000s)
[255.968292] [061/133] (765s left) device_reset (cold-reset-bound)
[256.019047] Starting subtest: cold-reset-bound
[256.023565] Subtest cold-reset-bound: SKIP (0.000s)
[256.103779] [062/133] (765s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[256.195513] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[256.197692] Starting dynamic subtest: A-eDP1
[259.826640] Dynamic subtest A-eDP1: SUCCESS (3.625s)
[259.842265] Starting dynamic subtest: B-eDP1
[263.030260] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[263.039075] Starting dynamic subtest: C-eDP1
[266.132078] Dynamic subtest C-eDP1: SUCCESS (3.100s)
[266.141157] Starting dynamic subtest: D-eDP1
[269.209771] Dynamic subtest D-eDP1: SUCCESS (3.077s)
[269.212140] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.016s)
[270.042505] [063/133] (751s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[270.147421] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[270.151443] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[270.277658] [064/133] (751s left) gem_exec_params (invalid-ring2)
[270.344932] Starting subtest: invalid-ring2
[270.347210] Subtest invalid-ring2: SUCCESS (0.000s)
[270.449228] [065/133] (751s left) gem_userptr_blits (process-exit-busy)
[270.515692] Starting subtest: process-exit-busy
[270.527336] Subtest process-exit-busy: SUCCESS (0.012s)
[270.687942] [066/133] (751s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[270.785151] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[274.779250] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.997s)
[275.960555] [067/133] (746s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[276.057091] Starting subtest: fbc-pr-cursor-mmap-gtt
[276.061643] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[276.149116] [068/133] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[276.236417] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[276.240680] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[276.373845] [069/133] (745s left) api_intel_allocator (simple-allocator)
[276.430942] Starting subtest: simple-allocator
[276.433133] Starting dynamic subtest: basic
[276.435411] Dynamic subtest basic: SUCCESS (0.004s)
[276.444569] Starting dynamic subtest: parallel-one
[276.621614] Dynamic subtest parallel-one: SUCCESS (0.187s)
[276.630429] Starting dynamic subtest: print
[276.632570] Dynamic subtest print: SUCCESS (0.000s)
[276.641813] Starting dynamic subtest: reuse
[276.643921] Dynamic subtest reuse: SUCCESS (0.000s)
[276.651741] Starting dynamic subtest: reserve
[276.653853] Dynamic subtest reserve: SUCCESS (0.000s)
[276.661787] Starting dynamic subtest: fork-reopen-allocator
[276.664023] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[276.666163] Subtest simple-allocator: SUCCESS (0.210s)
[276.767785] [070/133] (745s left) syncobj_timeline (etime-multi-wait-submitted)
[276.825086] Starting subtest: etime-multi-wait-submitted
[276.929271] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[277.016059] [071/133] (745s left) kms_chamelium_edid (dp-edid-read)
[277.392442] Subtest dp-edid-read: SKIP (0.000s)
[278.230806] [072/133] (744s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[278.334148] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[278.346516] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[278.474500] [073/133] (743s left) gem_exec_whisper (basic-contexts)
[278.551788] Starting subtest: basic-contexts
[283.893343] Subtest basic-contexts: SUCCESS (5.337s)
[284.085050] [074/133] (738s left) gem_pwrite (basic-self)
[284.148056] Subtest basic-self: SKIP (0.000s)
[284.215448] [075/133] (738s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[284.329417] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[284.333513] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[284.463409] [076/133] (737s left) kms_cursor_legacy (single-bo)
[284.599266] Starting subtest: single-bo
[284.601108] Starting dynamic subtest: pipe-A
[289.983069] Dynamic subtest pipe-A: SUCCESS (5.381s)
[289.992295] Starting dynamic subtest: pipe-B
[295.365960] Dynamic subtest pipe-B: SUCCESS (5.380s)
[295.376037] Starting dynamic subtest: pipe-C
[300.746038] Dynamic subtest pipe-C: SUCCESS (5.378s)
[300.755590] Starting dynamic subtest: pipe-D
[306.127044] Dynamic subtest pipe-D: SUCCESS (5.379s)
[306.135995] Starting dynamic subtest: all-pipes
[311.518391] Dynamic subtest all-pipes: SUCCESS (5.387s)
[311.520616] Subtest single-bo: SUCCESS (26.917s)
[311.687230] [077/133] (710s left) syncobj_timeline (wait-any-interrupted)
[311.744082] Starting subtest: wait-any-interrupted
[311.846408] Subtest wait-any-interrupted: SUCCESS (0.102s)
[311.934902] [078/133] (710s left) i915_suspend (sysfs-reader)
[311.987050] Starting subtest: sysfs-reader
[330.726113] Subtest sysfs-reader: SUCCESS (3.640s)
[336.779150] [079/133] (691s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[336.889456] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[336.891747] Starting dynamic subtest: pipe-A-eDP-1
[336.914265] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.924894] Starting dynamic subtest: pipe-B-eDP-1
[336.945664] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.954277] Starting dynamic subtest: pipe-C-eDP-1
[336.975583] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.984404] Starting dynamic subtest: pipe-D-eDP-1
[337.006895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[337.011001] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[339.083398] [080/133] (689s left) kms_plane_multiple (2x-tiling-x)
[339.184324] Starting subtest: 2x-tiling-x
[339.188497] Subtest 2x-tiling-x: SKIP (0.000s)
[339.269753] [081/133] (689s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[339.373694] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[346.132180] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.757s)
[346.295082] [082/133] (682s left) perf_pmu (semaphore-busy)
[346.345416] Starting subtest: semaphore-busy
[346.347208] Starting dynamic subtest: rcs0
[348.002426] Dynamic subtest rcs0: SUCCESS (1.652s)
[348.012525] Starting dynamic subtest: bcs0
[348.626660] Dynamic subtest bcs0: FAIL (0.573s)
[348.636043] Starting dynamic subtest: vcs0
[349.193189] Dynamic subtest vcs0: FAIL (0.549s)
[349.204025] Starting dynamic subtest: vcs1
[350.619538] Dynamic subtest vcs1: FAIL (1.423s)
[350.630066] Starting dynamic subtest: vecs0
[352.603554] Dynamic subtest vecs0: FAIL (1.982s)
[352.614469] Starting dynamic subtest: ccs0
[354.586200] Dynamic subtest ccs0: FAIL (1.984s)
[354.588564] Subtest semaphore-busy: FAIL (8.171s)
[354.675551] [083/133] (674s left) kms_cursor_crc (cursor-random-64x21)
[354.875374] Starting subtest: cursor-random-64x21
[354.921316] Subtest cursor-random-64x21: SKIP (0.043s)
[355.196952] [084/133] (673s left) kms_psr (pr-cursor-mmap-gtt)
[355.297972] Starting subtest: pr-cursor-mmap-gtt
[355.301924] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[355.381479] [085/133] (673s left) kms_vblank (ts-continuation-idle-hang)
[355.488699] Starting subtest: ts-continuation-idle-hang
[355.490567] Starting dynamic subtest: pipe-A-eDP-1
[381.854403] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.359s)
[381.868428] Starting dynamic subtest: pipe-D-eDP-1
[406.744886] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.885s)
[406.747188] Subtest ts-continuation-idle-hang: SUCCESS (51.248s)
[407.595288] [086/133] (621s left) syncobj_wait (multi-wait-submitted-signaled)
[407.669093] Starting subtest: multi-wait-submitted-signaled
[407.671396] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[407.770316] [087/133] (621s left) kms_color (degamma)
[407.863305] Starting subtest: degamma
[407.865509] Starting dynamic subtest: pipe-A-eDP-1
[408.590402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s)
[408.599932] Starting dynamic subtest: pipe-B-eDP-1
[410.011222] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s)
[410.022052] Starting dynamic subtest: pipe-C-eDP-1
[411.387796] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[411.406850] Starting dynamic subtest: pipe-D-eDP-1
[412.701124] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[412.703503] Subtest degamma: SUCCESS (4.837s)
[413.532382] [088/133] (615s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[413.589226] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[413.660259] [089/133] (615s left) kms_pm_rpm (cursor)
[415.190984] Starting subtest: cursor
[415.195578] Subtest cursor: SKIP (0.000s)
[415.960571] [090/133] (613s left) gem_exec_schedule (lateslice)
[416.046371] Starting subtest: lateslice
[416.048271] Starting dynamic subtest: rcs0
[416.060166] Dynamic subtest rcs0: SUCCESS (0.021s)
[416.071968] Starting dynamic subtest: bcs0
[416.078771] Dynamic subtest bcs0: SUCCESS (0.018s)
[416.088176] Starting dynamic subtest: vcs0
[416.098266] Dynamic subtest vcs0: SUCCESS (0.019s)
[416.107382] Starting dynamic subtest: vcs1
[416.115552] Dynamic subtest vcs1: SUCCESS (0.016s)
[416.124834] Starting dynamic subtest: vecs0
[416.135531] Dynamic subtest vecs0: SUCCESS (0.019s)
[416.144672] Starting dynamic subtest: ccs0
[416.156108] Dynamic subtest ccs0: SUCCESS (0.020s)
[416.158653] Subtest lateslice: SUCCESS (0.118s)
[418.114406] [091/133] (611s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[418.228958] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[418.233477] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[418.346821] [092/133] (610s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[418.452472] Starting subtest: x-tiled-8bpp-rotate-270
[418.473252] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[418.611091] [093/133] (610s left) gem_wait (await)
[418.685446] Starting subtest: await
[418.687873] Starting dynamic subtest: all-engines
[419.786953] Dynamic subtest all-engines: SUCCESS (1.100s)
[419.799875] Starting dynamic subtest: rcs0
[420.852495] Dynamic subtest rcs0: SUCCESS (1.063s)
[420.870740] Starting dynamic subtest: bcs0
[421.913008] Dynamic subtest bcs0: SUCCESS (1.058s)
[421.935306] Starting dynamic subtest: vcs0
[422.969939] Dynamic subtest vcs0: SUCCESS (1.054s)
[422.986979] Starting dynamic subtest: vcs1
[424.023108] Dynamic subtest vcs1: SUCCESS (1.051s)
[424.040131] Starting dynamic subtest: vecs0
[425.076842] Dynamic subtest vecs0: SUCCESS (1.051s)
[425.092955] Starting dynamic subtest: ccs0
[426.135901] Dynamic subtest ccs0: SUCCESS (1.057s)
[426.138436] Subtest await: SUCCESS (7.450s)
[426.360862] [094/133] (602s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[426.473479] Starting subtest: pr-overlay-plane-update-continuous-sf
[426.478037] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[426.554973] [095/133] (602s left) kms_cursor_crc (cursor-tearing-position-change)
[426.671499] Starting subtest: cursor-tearing-position-change
[426.673720] Starting dynamic subtest: pipe-A-eDP-1
[427.234698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[427.244832] Starting dynamic subtest: pipe-D-eDP-1
[428.466157] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[428.468450] Subtest cursor-tearing-position-change: SUCCESS (1.798s)
[429.325460] [096/133] (600s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[429.437883] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[429.811047] Starting dynamic subtest: pipe-A-eDP-1
[432.576386] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.765s)
[432.951113] Starting dynamic subtest: pipe-B-eDP-1
[435.707154] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s)
[436.079834] Starting dynamic subtest: pipe-C-eDP-1
[438.836187] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[439.204375] Starting dynamic subtest: pipe-D-eDP-1
[441.964855] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[441.967445] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.530s)
[443.160806] [097/133] (586s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[443.292128] Starting subtest: cursorB-vs-flipB-atomic-transitions
[443.296467] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[443.464706] [098/133] (585s left) perf_pmu (busy-accuracy-98)
[443.505244] Starting subtest: busy-accuracy-98
[443.507666] Starting dynamic subtest: rcs0
[446.541566] Dynamic subtest rcs0: SUCCESS (3.034s)
[446.553456] Starting dynamic subtest: bcs0
[449.591997] Dynamic subtest bcs0: SUCCESS (3.048s)
[449.603278] Starting dynamic subtest: vcs0
[452.634450] Dynamic subtest vcs0: SUCCESS (3.040s)
[452.645647] Starting dynamic subtest: vcs1
[455.679689] Dynamic subtest vcs1: SUCCESS (3.043s)
[455.689003] Starting dynamic subtest: vecs0
[458.720682] Dynamic subtest vecs0: SUCCESS (3.039s)
[458.731087] Starting dynamic subtest: ccs0
[461.775458] Dynamic subtest ccs0: SUCCESS (3.052s)
[461.778380] Subtest busy-accuracy-98: SUCCESS (18.270s)
[461.904406] [099/133] (567s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[462.015547] Starting subtest: yf-tiled-16bpp-rotate-270
[462.020039] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[462.141485] [100/133] (567s left) kms_prop_blob (invalid-set-prop)
[462.206919] Starting subtest: invalid-set-prop
[462.209159] Subtest invalid-set-prop: SUCCESS (0.000s)
[462.359357] [101/133] (567s left) gem_exec_params (cliprects-invalid)
[462.419929] Starting subtest: cliprects-invalid
[462.422329] Subtest cliprects-invalid: SUCCESS (0.000s)
[462.544167] [102/133] (567s left) sriov_basic (enable-vfs-bind-unbind-each)
[462.617000] Starting subtest: enable-vfs-bind-unbind-each
[462.619064] Starting dynamic subtest: numvfs-1
[462.690554] Dynamic subtest numvfs-1: FAIL (0.008s)
[462.700742] Starting dynamic subtest: numvfs-2
[462.771593] Dynamic subtest numvfs-2: FAIL (0.004s)
[462.781454] Starting dynamic subtest: numvfs-3
[462.837462] Dynamic subtest numvfs-3: FAIL (0.007s)
[462.846028] Starting dynamic subtest: numvfs-4
[462.901296] Dynamic subtest numvfs-4: FAIL (0.004s)
[462.910179] Starting dynamic subtest: numvfs-5
[462.966541] Dynamic subtest numvfs-5: FAIL (0.007s)
[462.975016] Starting dynamic subtest: numvfs-6
[463.031577] Dynamic subtest numvfs-6: FAIL (0.004s)
[463.040705] Starting dynamic subtest: numvfs-7
[463.096850] Dynamic subtest numvfs-7: FAIL (0.004s)
[463.105414] Starting dynamic subtest: numvfs-random
[463.161725] Dynamic subtest numvfs-random: FAIL (0.004s)
[463.163260] Subtest enable-vfs-bind-unbind-each: FAIL (0.047s)
[463.200485] [103/133] (566s left) gem_exec_flush (basic-uc-pro-default)
[463.260164] Starting subtest: basic-uc-pro-default
[468.721531] Subtest basic-uc-pro-default: SUCCESS (5.461s)
[468.917486] [104/133] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[469.018460] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[469.022967] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[469.157134] [105/133] (560s left) kms_pipe_crc_basic (bad-source)
[469.250560] Starting subtest: bad-source
[469.252850] Subtest bad-source: SUCCESS (0.000s)
[469.333945] [106/133] (560s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[469.435730] Starting subtest: plane-primary-toggle-with-vblank-wait
[469.437985] Starting dynamic subtest: pipe-A-eDP-1
[469.609001] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[469.914653] Starting dynamic subtest: pipe-B-eDP-1
[470.838512] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.933s)
[471.135315] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.701s)
[472.011525] [107/133] (557s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[472.110070] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[472.112508] Starting dynamic subtest: pipe-A-eDP-1
[472.135655] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[472.148446] Starting dynamic subtest: pipe-B-eDP-1
[472.170082] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[472.179386] Starting dynamic subtest: pipe-C-eDP-1
[472.201651] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[472.212061] Starting dynamic subtest: pipe-D-eDP-1
[472.233673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[472.237953] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[474.382480] [108/133] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[474.479590] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[481.325710] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.848s)
[481.449714] [109/133] (548s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[481.557725] Starting subtest: y-tiled-16bpp-rotate-270
[481.562204] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[481.687807] [110/133] (548s left) syncobj_eventfd (invalid-bad-pad)
[481.750354] Starting subtest: invalid-bad-pad
[481.752348] Subtest invalid-bad-pad: SUCCESS (0.000s)
[481.880069] [111/133] (548s left) gem_exec_params (larger-than-life-batch)
[481.952826] Starting subtest: larger-than-life-batch
[484.206809] Subtest larger-than-life-batch: SUCCESS (2.253s)
[485.083092] [112/133] (544s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[485.237324] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[485.241579] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[485.374730] [113/133] (544s left) kms_psr (psr-cursor-mmap-cpu)
[485.482374] Starting subtest: psr-cursor-mmap-cpu
[485.484729] Starting dynamic subtest: eDP-1
[487.189294] Dynamic subtest eDP-1: SUCCESS (1.708s)
[487.191652] Subtest psr-cursor-mmap-cpu: SUCCESS (1.709s)
[488.059073] [114/133] (542s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[488.174264] Starting subtest: yf-tiled-64bpp-rotate-90
[488.178689] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[488.304834] [115/133] (541s left) gem_workarounds (suspend-resume)
[488.372030] Starting subtest: suspend-resume
[504.736431] Subtest suspend-resume: SUCCESS (1.630s)
[510.893560] [116/133] (525s left) gem_ctx_persistence (smoketest)
[511.003199] Starting subtest: smoketest
[550.172697] Subtest smoketest: SUCCESS (39.147s)
[550.268220] [117/133] (485s left) kms_flip (2x-flip-vs-suspend)
[550.362731] Starting subtest: 2x-flip-vs-suspend
[550.373602] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[550.499525] [118/133] (485s left) gem_exec_reloc (basic-gtt-cpu)
[550.561726] Subtest basic-gtt-cpu: SKIP (0.000s)
[550.642879] [119/133] (485s left) i915_drm_fdinfo (all-busy-idle-check-all)
[550.681759] Starting subtest: all-busy-idle-check-all
[550.686329] Subtest all-busy-idle-check-all: SKIP (0.004s)
[550.770402] [120/133] (485s left) core_auth (getclient-master-drop)
[550.806042] Starting subtest: getclient-master-drop
[550.872417] Subtest getclient-master-drop: SUCCESS (0.067s)
[551.006538] [121/133] (485s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[551.090941] Starting subtest: fbc-psr2-cursor-plane-onoff
[551.093090] Starting dynamic subtest: eDP-1
[551.097044] Dynamic subtest eDP-1: SKIP (0.000s)
[551.100966] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[551.176435] [122/133] (485s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[551.273435] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[551.276839] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[551.405307] [123/133] (485s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[551.501068] Starting subtest: primary-4-tiled-reflect-x-180
[558.673215] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.173s)
[559.902880] [124/133] (476s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[560.001335] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[560.005545] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[560.120504] [125/133] (476s left) gem_mmap_wc (set-cache-level)
[560.179635] Subtest set-cache-level: SKIP (0.000s)
[560.240639] [126/133] (476s left) prime_mmap_coherency (write)
[560.303744] Starting subtest: write
[565.683420] Subtest write: SUCCESS (5.377s)
[565.864854] [127/133] (470s left) i915_hangman (engine-engine-hang)
[565.943712] Starting subtest: engine-engine-hang
[565.945902] Starting dynamic subtest: rcs0
[567.681601] Dynamic subtest rcs0: SUCCESS (1.736s)
[567.694732] Starting dynamic subtest: bcs0
[569.728415] Dynamic subtest bcs0: SUCCESS (2.044s)
[569.742123] Starting dynamic subtest: vcs0
[571.712276] Dynamic subtest vcs0: SUCCESS (1.981s)
[571.725562] Starting dynamic subtest: vcs1
[573.696559] Dynamic subtest vcs1: SUCCESS (1.981s)
[573.709726] Starting dynamic subtest: vecs0
[575.679936] Dynamic subtest vecs0: SUCCESS (1.981s)
[575.693252] Starting dynamic subtest: ccs0
[577.727929] Dynamic subtest ccs0: SUCCESS (2.045s)
[577.730909] Subtest engine-engine-hang: SUCCESS (11.782s)
[577.831505] [128/133] (458s left) gem_softpin (overlap)
[577.908283] Starting subtest: overlap
[578.794043] Subtest overlap: SUCCESS (0.883s)
[578.964066] [129/133] (457s left) kms_sequence (get-forked)
[579.053741] Starting subtest: get-forked
[579.056161] Starting dynamic subtest: pipe-A-eDP-1
[580.955006] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.901s)
[580.967546] Starting dynamic subtest: pipe-B-eDP-1
[583.529261] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.574s)
[583.541508] Starting dynamic subtest: pipe-C-eDP-1
[586.045215] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.512s)
[586.055571] Starting dynamic subtest: pipe-D-eDP-1
[588.571073] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s)
[588.573331] Subtest get-forked: SUCCESS (9.517s)
[589.416344] [130/133] (447s left) kms_content_protection (uevent)
[589.554607] Starting subtest: uevent
[589.559145] Subtest uevent: SKIP (0.000s)
[589.718245] [131/133] (447s left) gem_ctx_create (basic)
[589.778780] Starting subtest: basic
[589.781005] Subtest basic: SUCCESS (0.000s)
[589.976778] [132/133] (446s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[590.101982] Starting subtest: protected-encrypted-src-copy-not-readible
[590.213128] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[590.342669] [133/133] (446s left) gem_ppgtt (blt-vs-render-ctxn)
[590.392501] Starting subtest: blt-vs-render-ctxN
[623.267456] Subtest blt-vs-render-ctxN: SUCCESS (32.870s)
[623.422978] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_rmfb
results: parsing output: 6/ for test: gem_spin_batch
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_dsc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: gem_ctx_isolation
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: gem_ctx_engines
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_pipe_crc_basic
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_params
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_ccs
results: parsing output: 35/ for test: gem_ctx_bad_destroy
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: vgem_slow
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: prime_udl
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_lease
results: parsing output: 44/ for test: gen3_render_tiledy_blits
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_ctx_shared
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: i915_pm_rps
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_mmap
results: parsing output: 55/ for test: gem_partial_pwrite_pread
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: device_reset
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: api_intel_allocator
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_chamelium_edid
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: gem_pwrite
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: i915_suspend
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_plane_multiple
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_color
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_wait
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_async_flips
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_prop_blob
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: sriov_basic
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_eventfd
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_workarounds
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_exec_reloc
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: core_auth
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: prime_mmap_coherency
results: parsing output: 126/ for test: i915_hangman
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_sequence
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: gem_ctx_create
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: gem_ppgtt
Done.