[61.588379] Initializing watchdogs
[61.588427]   /dev/watchdog0
[61.603020] [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]
[61.607261] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.610202] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.613685] [001/133] (960s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[61.752259] Starting subtest: yf-tiled-64bpp-rotate-90
[61.756800] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.002s)
[61.857185] [002/133] (960s left) i915_pm_rps (waitboost)
[61.924597] Starting subtest: waitboost
[68.254914] Subtest waitboost: SUCCESS (6.329s)
[68.348401] [003/133] (953s left) gem_exec_parallel (userptr)
[68.418445] Starting subtest: userptr
[68.420781] Starting dynamic subtest: rcs0
[69.933502] Dynamic subtest rcs0: SUCCESS (1.514s)
[69.941209] Starting dynamic subtest: bcs0
[71.427558] Dynamic subtest bcs0: SUCCESS (1.493s)
[71.435121] Starting dynamic subtest: vcs0
[72.936116] Dynamic subtest vcs0: SUCCESS (1.506s)
[72.943356] Starting dynamic subtest: vcs1
[74.838118] Dynamic subtest vcs1: SUCCESS (1.900s)
[74.848948] Starting dynamic subtest: vecs0
[76.885814] Dynamic subtest vecs0: SUCCESS (2.047s)
[76.895977] Starting dynamic subtest: ccs0
[78.400750] Dynamic subtest ccs0: SUCCESS (1.515s)
[78.403208] Subtest userptr: SUCCESS (9.981s)
[78.585889] [004/133] (943s left) gem_workarounds (suspend-resume-context)
[78.658772] Starting subtest: suspend-resume-context
[94.323651] Subtest suspend-resume-context: SUCCESS (2.066s)
[94.477141] [005/133] (927s left) i915_drm_fdinfo (virtual-busy)
[94.533579] Starting subtest: virtual-busy
[94.538179] Subtest virtual-busy: SKIP (0.000s)
[94.604129] [006/133] (927s left) gem_lmem_swapping (verify-random-ccs)
[94.644318] Subtest verify-random-ccs: SKIP (0.000s)
[94.689036] [007/133] (927s left) syncobj_timeline (invalid-transfer-bad-pad)
[94.739931] Starting subtest: invalid-transfer-bad-pad
[94.741828] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[94.844541] [008/133] (927s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[94.931396] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[94.936250] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[96.023779] [009/133] (926s left) kms_pm_rpm (cursor)
[97.696768] Starting subtest: cursor
[97.706040] Subtest cursor: SKIP (0.000s)
[98.387710] [010/133] (924s left) gem_exec_reloc (basic-write-cpu-active)
[98.454551] Subtest basic-write-cpu-active: SKIP (0.000s)
[98.521531] [011/133] (923s left) gem_render_linear_blits (basic)
[98.580157] Starting subtest: basic
[98.600911] Subtest basic: SUCCESS (0.022s)
[98.681409] [012/133] (923s left) gem_softpin (allocator-nopin-reserve)
[98.738897] Starting subtest: allocator-nopin-reserve
[98.853168] Subtest allocator-nopin-reserve: SUCCESS (0.113s)
[98.968806] [013/133] (923s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[99.085256] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[99.090101] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[99.163010] [014/133] (923s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[99.266543] Starting subtest: psr-modesetfrombusy
[105.432824] Subtest psr-modesetfrombusy: SUCCESS (6.164s)
[105.549160] [015/133] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[105.645441] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[105.648979] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[105.732333] [016/133] (916s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[105.778291] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[105.889178] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[105.961237] [017/133] (916s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[106.023173] Starting subtest: multi-wait-all-for-submit-submitted
[106.128877] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[106.200924] [018/133] (916s left) syncobj_timeline (host-signal-ordered)
[106.261259] Starting subtest: host-signal-ordered
[106.263383] Subtest host-signal-ordered: SUCCESS (0.000s)
[106.341050] [019/133] (916s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[106.440944] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[106.445129] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[106.542417] [020/133] (916s left) api_intel_allocator (fork-simple-stress-signal)
[106.605228] Starting subtest: fork-simple-stress-signal
[112.066823] Subtest fork-simple-stress-signal: SUCCESS (5.405s)
[112.147399] [021/133] (910s left) gem_exec_balancer (bonded-sync)
[112.213770] Starting subtest: bonded-sync
[112.218559] Subtest bonded-sync: SKIP (0.000s)
[112.531294] [022/133] (910s left) kms_psr (psr2-suspend)
[112.651206] Starting subtest: psr2-suspend
[112.653692] Starting dynamic subtest: eDP-1
[130.742828] Dynamic subtest eDP-1: SUCCESS (4.112s)
[130.745314] Subtest psr2-suspend: SUCCESS (4.113s)
[131.629953] [023/133] (891s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[131.728123] Starting subtest: y-tiled-64bpp-rotate-90
[131.732639] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[131.828675] [024/133] (891s left) gem_userptr_blits (readonly-pwrite-unsync)
[131.896569] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[132.030603] [025/133] (891s left) gem_exec_schedule (u-independent)
[132.101910] Starting subtest: u-independent
[132.104154] Starting dynamic subtest: rcs0
[133.516720] Dynamic subtest rcs0: SUCCESS (1.424s)
[133.528944] Starting dynamic subtest: vcs0
[135.517381] Dynamic subtest vcs0: SUCCESS (1.999s)
[135.529407] Starting dynamic subtest: vcs1
[137.499838] Dynamic subtest vcs1: SUCCESS (1.980s)
[137.511982] Starting dynamic subtest: vecs0
[139.480619] Dynamic subtest vecs0: SUCCESS (1.979s)
[139.492528] Starting dynamic subtest: ccs0
[141.516596] Dynamic subtest ccs0: SUCCESS (2.034s)
[141.519341] Subtest u-independent: SUCCESS (9.421s)
[141.819111] [026/133] (881s left) kms_big_fb (x-tiled-addfb-size-overflow)
[141.933312] Starting subtest: x-tiled-addfb-size-overflow
[141.935228] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[142.035313] [027/133] (881s left) kms_cursor_edge_walk (128x128-top-edge)
[142.124950] Starting subtest: 128x128-top-edge
[142.127349] Starting dynamic subtest: pipe-A-eDP-1
[145.588116] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s)
[145.605577] Starting dynamic subtest: pipe-D-eDP-1
[148.727451] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[148.729737] Subtest 128x128-top-edge: SUCCESS (6.598s)
[149.514080] [028/133] (873s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[149.611268] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[149.613552] Starting dynamic subtest: pipe-A-eDP-1
[149.635990] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.648675] Starting dynamic subtest: pipe-B-eDP-1
[149.670159] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.678827] Starting dynamic subtest: pipe-C-eDP-1
[149.700020] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.708355] Starting dynamic subtest: pipe-D-eDP-1
[149.730273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.734359] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[151.795866] [029/133] (871s left) kms_addfb_basic (invalid-get-prop-any)
[151.856952] Starting subtest: invalid-get-prop-any
[151.858969] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[151.982934] [030/133] (871s left) gem_pipe_control_store_loop (fresh-buffer)
[152.041161] Starting subtest: fresh-buffer
[154.194563] Subtest fresh-buffer: SUCCESS (2.151s)
[154.308918] [031/133] (868s left) perf (gen12-mi-rpc)
[154.435654] Starting subtest: gen12-mi-rpc
[154.438019] Starting dynamic subtest: rcs0
[154.453312] Dynamic subtest rcs0: SUCCESS (0.017s)
[154.455501] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[154.495153] [032/133] (868s left) gem_mmap_wc (bad-size)
[154.587010] Subtest bad-size: SKIP (0.000s)
[154.643443] [033/133] (868s left) gem_exec_reloc (basic-range-active)
[154.705923] Subtest basic-range-active: SKIP (0.000s)
[154.769531] [034/133] (868s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[154.830549] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[154.835969] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[155.011468] [035/133] (868s left) gen7_exec_parse (bitmasks)
[155.068341] Subtest bitmasks: SKIP (0.000s)
[155.148735] [036/133] (868s left) prime_busy (after-wait)
[155.197820] Starting subtest: after-wait
[155.202589] Starting dynamic subtest: rcs0
[155.241493] Dynamic subtest rcs0: SUCCESS (0.040s)
[155.250583] Starting dynamic subtest: bcs0
[155.306138] Dynamic subtest bcs0: SUCCESS (0.065s)
[155.314528] Starting dynamic subtest: vcs0
[155.347084] Dynamic subtest vcs0: SUCCESS (0.041s)
[155.355546] Starting dynamic subtest: vcs1
[155.389356] Dynamic subtest vcs1: SUCCESS (0.041s)
[155.400068] Starting dynamic subtest: vecs0
[155.430415] Dynamic subtest vecs0: SUCCESS (0.041s)
[155.439676] Starting dynamic subtest: ccs0
[155.474024] Dynamic subtest ccs0: SUCCESS (0.043s)
[155.582837] Subtest after-wait: SUCCESS (0.383s)
[155.662852] [037/133] (867s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[155.780825] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[156.395328] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.614s)
[156.541694] [038/133] (866s left) kms_big_fb (linear-8bpp-rotate-0)
[156.647342] Starting subtest: linear-8bpp-rotate-0
[157.838785] Subtest linear-8bpp-rotate-0: SUCCESS (1.192s)
[157.957001] [039/133] (865s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[158.050097] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[158.053620] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[158.118587] [040/133] (865s left) gem_ctx_persistence (engines-hang)
[158.189671] Starting subtest: engines-hang
[158.191495] Starting dynamic subtest: rcs0
[158.301087] Dynamic subtest rcs0: SUCCESS (0.113s)
[158.311715] Starting dynamic subtest: bcs0
[158.438422] Dynamic subtest bcs0: SUCCESS (0.136s)
[158.449656] Starting dynamic subtest: vcs0
[158.545097] Dynamic subtest vcs0: SUCCESS (0.105s)
[158.554941] Starting dynamic subtest: vcs1
[158.620941] Dynamic subtest vcs1: SUCCESS (0.075s)
[158.629877] Starting dynamic subtest: vecs0
[158.745156] Dynamic subtest vecs0: SUCCESS (0.123s)
[158.756251] Starting dynamic subtest: ccs0
[158.839249] Dynamic subtest ccs0: SUCCESS (0.093s)
[158.841538] Subtest engines-hang: SUCCESS (0.652s)
[158.915888] [041/133] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[159.017540] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[166.336121] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.313s)
[166.483151] [042/133] (857s left) gen7_exec_parse (basic-allocation)
[166.552861] Subtest basic-allocation: SKIP (0.000s)
[166.628397] [043/133] (857s left) kms_cursor_crc (cursor-offscreen-64x64)
[166.802741] Starting subtest: cursor-offscreen-64x64
[166.807448] Starting dynamic subtest: pipe-A-eDP-1
[168.739753] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[168.771860] Starting dynamic subtest: pipe-D-eDP-1
[171.324304] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.558s)
[171.326502] Subtest cursor-offscreen-64x64: SUCCESS (4.514s)
[172.195216] [044/133] (851s left) syncobj_wait (wait-for-submit-snapshot)
[172.251677] Starting subtest: wait-for-submit-snapshot
[172.332252] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[172.405408] [045/133] (851s left) gem_unref_active_buffers
[172.595508] [046/133] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[172.695829] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[180.218767] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.520s)
[180.338949] [047/133] (843s left) kms_cursor_crc (cursor-random-128x42)
[180.578910] Starting subtest: cursor-random-128x42
[180.629264] Subtest cursor-random-128x42: SKIP (0.044s)
[180.806464] [048/133] (843s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[181.412670] Starting subtest: syncobj-timeline-invalid-flags
[181.414777] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[182.541002] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[182.544294] [049/133] (841s left) drm_read (short-buffer-nonblock)
[182.683811] Starting subtest: short-buffer-nonblock
[182.686360] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[182.823404] [050/133] (841s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[182.926436] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[186.903503] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.979s)
[188.138427] [051/133] (835s left) gem_exec_params (no-blt)
[188.197602] Starting subtest: no-blt
[188.200002] Subtest no-blt: SUCCESS (0.002s)
[188.317867] [052/133] (835s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[188.423252] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[188.427808] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.526336] [053/133] (835s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[188.638660] Starting subtest: psr-2p-primscrn-spr-indfb-move
[188.643256] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[188.732084] [054/133] (835s left) kms_pm_rpm (pm-tiling)
[190.660968] Starting subtest: pm-tiling
[190.666055] Subtest pm-tiling: SKIP (0.000s)
[191.047649] [055/133] (833s left) sysfs_heartbeat_interval (mixed)
[191.102334] Starting subtest: mixed
[191.104832] Starting dynamic subtest: vecs0
[196.347403] Dynamic subtest vecs0: SUCCESS (5.244s)
[196.359396] Starting dynamic subtest: ccs0
[201.489262] Dynamic subtest ccs0: SUCCESS (5.141s)
[201.500564] Starting dynamic subtest: vcs0
[206.715547] Dynamic subtest vcs0: SUCCESS (5.225s)
[206.730595] Starting dynamic subtest: bcs0
[211.920465] Dynamic subtest bcs0: SUCCESS (5.203s)
[211.931603] Starting dynamic subtest: rcs0
[217.084450] Dynamic subtest rcs0: SUCCESS (5.162s)
[217.096105] Starting dynamic subtest: vcs1
[222.324193] Dynamic subtest vcs1: SUCCESS (5.239s)
[222.326697] Subtest mixed: SUCCESS (31.223s)
[222.410898] [056/133] (801s left) gem_create (create-clear)
[222.474718] Starting subtest: create-clear
[222.477645] Starting dynamic subtest: smem0
[255.190500] Dynamic subtest smem0: SUCCESS (32.705s)
[255.192979] Subtest create-clear: SUCCESS (32.707s)
[255.380931] [057/133] (768s left) i915_hangman (detector)
[255.460548] Starting subtest: detector
[255.462838] Starting dynamic subtest: rcs0
[266.474157] Dynamic subtest rcs0: SUCCESS (11.014s)
[266.484858] Starting dynamic subtest: bcs0
[278.443478] Dynamic subtest bcs0: SUCCESS (11.969s)
[278.455831] Starting dynamic subtest: vcs0
[289.389008] Dynamic subtest vcs0: SUCCESS (10.944s)
[289.401546] Starting dynamic subtest: vcs1
[300.395418] Dynamic subtest vcs1: SUCCESS (11.002s)
[300.407479] Starting dynamic subtest: vecs0
[312.427631] Dynamic subtest vecs0: SUCCESS (12.029s)
[312.440183] Starting dynamic subtest: ccs0
[324.458774] Dynamic subtest ccs0: SUCCESS (12.027s)
[324.461813] Subtest detector: SUCCESS (68.998s)
[324.552534] [058/133] (699s left) kms_addfb_basic (basic)
[324.612174] Starting subtest: basic
[324.614507] Subtest basic: SUCCESS (0.000s)
[324.764960] [059/133] (699s left) kms_addfb_basic (bad-pitch-1024)
[324.837239] Starting subtest: bad-pitch-1024
[324.839920] Subtest bad-pitch-1024: SUCCESS (0.000s)
[324.974416] [060/133] (699s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[325.368335] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[326.149102] [061/133] (698s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[326.273835] Starting subtest: basic-flip-after-cursor-atomic
[327.190504] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s)
[327.996211] [062/133] (696s left) i915_pm_rpm (gem-execbuf-stress)
[329.627313] Starting subtest: gem-execbuf-stress
[329.629425] Starting dynamic subtest: smem0
[342.436295] Dynamic subtest smem0: SUCCESS (12.809s)
[342.448483] Starting dynamic subtest: extra-wait-smem0
[404.556776] Dynamic subtest extra-wait-smem0: SUCCESS (62.109s)
[404.559738] Subtest gem-execbuf-stress: SUCCESS (74.923s)
[404.939573] [063/133] (619s left) kms_draw_crc (draw-method-pwrite)
[405.044110] Starting subtest: draw-method-pwrite
[405.046229] Starting dynamic subtest: xrgb8888-untiled
[405.586093] Dynamic subtest xrgb8888-untiled: SUCCESS (0.544s)
[405.595856] Starting dynamic subtest: rgb565-untiled
[406.008068] Dynamic subtest rgb565-untiled: SUCCESS (0.422s)
[406.022567] Starting dynamic subtest: xrgb2101010-untiled
[406.530688] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.522s)
[406.539934] Starting dynamic subtest: xbgr16161616f-untiled
[407.341796] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.810s)
[407.350987] Starting dynamic subtest: xrgb8888-xtiled
[409.076660] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.733s)
[409.085663] Starting dynamic subtest: rgb565-xtiled
[410.119270] Dynamic subtest rgb565-xtiled: SUCCESS (1.042s)
[410.128543] Starting dynamic subtest: xrgb2101010-xtiled
[411.841146] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.721s)
[411.850898] Starting dynamic subtest: xbgr16161616f-xtiled
[415.029827] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.188s)
[415.038677] Starting dynamic subtest: xrgb8888-4tiled
[416.085063] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.055s)
[416.093966] Starting dynamic subtest: rgb565-4tiled
[416.640827] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s)
[416.650421] Starting dynamic subtest: xrgb2101010-4tiled
[417.718251] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.077s)
[417.729520] Starting dynamic subtest: xbgr16161616f-4tiled
[420.607001] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.888s)
[420.609419] Subtest draw-method-pwrite: SUCCESS (15.567s)
[420.690714] [064/133] (603s left) kms_joiner (invalid-modeset-force-big-joiner)
[420.799442] Starting subtest: invalid-modeset-force-big-joiner
[420.803602] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[420.879717] [065/133] (603s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[420.983733] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[420.985913] Starting dynamic subtest: pipe-A-default-mode
[423.756898] Dynamic subtest pipe-A-default-mode: SUCCESS (2.772s)
[423.759289] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.773s)
[424.636067] [066/133] (600s left) gem_partial_pwrite_pread (reads-display)
[424.693387] Subtest reads-display: SKIP (0.000s)
[424.769125] [067/133] (599s left) perf_pmu (interrupts-sync)
[424.809805] Starting subtest: interrupts-sync
[425.902572] Subtest interrupts-sync: SUCCESS (1.092s)
[426.019872] [068/133] (598s left) kms_debugfs (display-on-read-all)
[426.101804] Starting subtest: display-on-read-all
[426.270111] Subtest display-on-read-all: SUCCESS (0.169s)
[426.391089] [069/133] (598s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[426.481470] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[432.948606] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.471s)
[433.086689] [070/133] (591s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[433.188574] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[433.192650] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[433.290701] [071/133] (591s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[433.401398] Starting subtest: short-flip-before-cursor-toggle
[434.337955] Subtest short-flip-before-cursor-toggle: SUCCESS (0.937s)
[435.191346] [072/133] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[435.295053] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[435.299259] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[435.420127] [073/133] (589s left) kms_chamelium_edid (dp-edid-read)
[435.795625] Subtest dp-edid-read: SKIP (0.000s)
[436.584403] [074/133] (588s left) syncobj_wait (single-wait-all-submitted)
[436.639147] Starting subtest: single-wait-all-submitted
[436.744792] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[436.836086] [075/133] (588s left) gem_exec_fence (expired-history)
[437.279101] Starting subtest: expired-history
[444.199022] Subtest expired-history: SUCCESS (6.921s)
[444.812461] [076/133] (580s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[444.918159] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[444.922470] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[445.015488] [077/133] (580s left) gem_exec_schedule (implicit-read-write)
[445.084023] Starting subtest: implicit-read-write
[445.086370] Starting dynamic subtest: rcs0
[445.182731] Dynamic subtest rcs0: SUCCESS (0.107s)
[445.197298] Starting dynamic subtest: vcs0
[445.270689] Dynamic subtest vcs0: SUCCESS (0.088s)
[445.282979] Starting dynamic subtest: vcs1
[445.353245] Dynamic subtest vcs1: SUCCESS (0.081s)
[445.366450] Starting dynamic subtest: vecs0
[445.436515] Dynamic subtest vecs0: SUCCESS (0.083s)
[445.448879] Starting dynamic subtest: ccs0
[445.531342] Dynamic subtest ccs0: SUCCESS (0.094s)
[445.533879] Subtest implicit-read-write: SUCCESS (0.458s)
[446.570562] [078/133] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[446.675979] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[446.680019] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[446.794503] [079/133] (578s left) kms_psr (pr-cursor-plane-onoff)
[446.898836] Starting subtest: pr-cursor-plane-onoff
[446.903234] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[446.973154] [080/133] (578s left) kms_psr (fbc-psr-cursor-render)
[447.059323] Starting subtest: fbc-psr-cursor-render
[447.061480] Starting dynamic subtest: eDP-1
[447.065502] Dynamic subtest eDP-1: SKIP (0.000s)
[447.069501] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[447.132770] [081/133] (578s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[447.226982] Starting subtest: fbcpsr-shrfb-scaledprimary
[452.951440] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.728s)
[453.089929] [082/133] (572s left) kms_flip (2x-busy-flip)
[453.190371] Starting subtest: 2x-busy-flip
[453.198809] Subtest 2x-busy-flip: SKIP (0.010s)
[453.278569] [083/133] (572s left) gem_ctx_persistence (legacy-engines-persistence)
[453.333184] Starting subtest: legacy-engines-persistence
[453.335606] Starting dynamic subtest: render
[454.168792] Dynamic subtest render: SUCCESS (0.835s)
[454.181535] Starting dynamic subtest: bsd1
[454.921030] Dynamic subtest bsd1: SUCCESS (0.749s)
[454.933427] Starting dynamic subtest: bsd2
[455.691757] Dynamic subtest bsd2: SUCCESS (0.768s)
[455.705075] Starting dynamic subtest: blt
[456.458824] Dynamic subtest blt: SUCCESS (0.764s)
[456.474491] Starting dynamic subtest: vebox
[457.225657] Dynamic subtest vebox: SUCCESS (0.764s)
[457.228225] Subtest legacy-engines-persistence: SUCCESS (3.893s)
[457.319282] [084/133] (568s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[457.379674] Starting subtest: mixed-tiled-to-y-tiled-ccs
[457.384429] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[457.565430] [085/133] (567s left) gem_exec_params (invalid-ring)
[457.621501] Starting subtest: invalid-ring
[457.623840] Subtest invalid-ring: SUCCESS (0.000s)
[457.723608] [086/133] (567s left) gem_close (basic)
[457.782898] Starting subtest: basic
[457.785293] Subtest basic: SUCCESS (0.000s)
[457.884300] [087/133] (567s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[457.986523] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[457.991080] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[458.098936] [088/133] (567s left) kms_lease (lease-get)
[458.183104] Starting subtest: lease-get
[458.185336] Starting dynamic subtest: pipe-A-eDP-1
[458.187453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[458.197092] Starting dynamic subtest: pipe-B-eDP-1
[458.199234] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[458.208452] Starting dynamic subtest: pipe-C-eDP-1
[458.210662] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[458.219741] Starting dynamic subtest: pipe-D-eDP-1
[458.221938] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[458.224086] Subtest lease-get: SUCCESS (0.009s)
[458.321462] [089/133] (567s left) gem_mmap_offset (partial-mmap)
[458.374663] Starting subtest: partial-mmap
[458.376963] Starting dynamic subtest: smem0
[458.379232] Dynamic subtest smem0: SUCCESS (0.006s)
[458.381394] Subtest partial-mmap: SUCCESS (0.006s)
[458.552140] [090/133] (567s left) gem_tiled_partial_pwrite_pread (reads)
[458.617356] Subtest reads: SKIP (0.000s)
[458.680825] [091/133] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[458.775513] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[458.779088] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[458.883731] [092/133] (566s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[458.993009] Starting subtest: fbc-psr2-cursor-plane-update-sf
[458.995440] Starting dynamic subtest: pipe-A-eDP-1
[459.077740] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[459.088406] Starting dynamic subtest: pipe-B-eDP-1
[460.188095] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s)
[460.192432] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.197s)
[461.380917] [093/133] (564s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[461.480426] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[461.484817] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[461.580098] [094/133] (564s left) gem_exec_reloc (basic-cpu-wc)
[461.646232] Subtest basic-cpu-wc: SKIP (0.000s)
[461.723386] [095/133] (564s left) kms_content_protection (lic-type-1)
[461.859047] Starting subtest: lic-type-1
[461.863520] Subtest lic-type-1: SKIP (0.000s)
[461.969548] [096/133] (564s left) kms_atomic (plane-invalid-params-fence)
[462.055254] Starting subtest: plane-invalid-params-fence
[462.057678] Starting dynamic subtest: pipe-A-eDP-1
[462.410396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.352s)
[462.412540] Subtest plane-invalid-params-fence: SUCCESS (0.354s)
[463.208180] [097/133] (562s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[463.303758] Starting subtest: bad-rotation-90-yf-tiled-ccs
[463.305922] Starting dynamic subtest: pipe-A-eDP-1
[463.328011] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.340595] Starting dynamic subtest: pipe-B-eDP-1
[463.362006] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.371065] Starting dynamic subtest: pipe-C-eDP-1
[463.392724] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.401995] Starting dynamic subtest: pipe-D-eDP-1
[463.423947] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.427978] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[465.481180] [098/133] (560s left) gem_lmem_swapping (massive-random)
[465.526622] Subtest massive-random: SKIP (0.000s)
[465.564286] [099/133] (560s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[465.652532] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[466.039227] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[468.773404] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.731s)
[468.786572] Starting dynamic subtest: pipe-A-eDP-1-4
[470.957234] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.181s)
[470.974354] Starting dynamic subtest: pipe-A-eDP-1-4
[472.965479] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[472.978268] Starting dynamic subtest: pipe-A-eDP-1-x
[475.155549] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[475.525023] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[478.352914] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[478.366130] Starting dynamic subtest: pipe-B-eDP-1-4
[480.496017] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[480.506502] Starting dynamic subtest: pipe-B-eDP-1-4
[482.506164] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[482.516071] Starting dynamic subtest: pipe-B-eDP-1-x
[484.687665] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[485.051608] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[487.828389] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[487.841455] Starting dynamic subtest: pipe-C-eDP-1-4
[490.003305] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[490.015230] Starting dynamic subtest: pipe-C-eDP-1-4
[492.012963] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[492.026668] Starting dynamic subtest: pipe-C-eDP-1-x
[494.191757] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[494.556479] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[497.353090] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[497.365492] Starting dynamic subtest: pipe-D-eDP-1-4
[499.540263] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[499.552824] Starting dynamic subtest: pipe-D-eDP-1-4
[501.549127] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[501.561610] Starting dynamic subtest: pipe-D-eDP-1-x
[503.718507] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[503.721033] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.061s)
[504.956148] [100/133] (521s left) kms_color (ctm-negative)
[505.047960] Starting subtest: ctm-negative
[505.050136] Starting dynamic subtest: pipe-A-eDP-1
[505.759398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[505.769958] Starting dynamic subtest: pipe-B-eDP-1
[507.167677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[507.177425] Starting dynamic subtest: pipe-C-eDP-1
[508.528788] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[508.539439] Starting dynamic subtest: pipe-D-eDP-1
[509.852662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[509.855261] Subtest ctm-negative: SUCCESS (4.805s)
[510.658281] [101/133] (515s left) gem_fence_thrash (bo-write-verify-y)
[510.698646] Starting subtest: bo-write-verify-y
[510.711864] Subtest bo-write-verify-y: SKIP (0.013s)
[510.771902] [102/133] (515s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[510.856070] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[510.860071] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[510.926998] [103/133] (515s left) kms_psr (fbc-pr-primary-mmap-gtt)
[511.012958] Starting subtest: fbc-pr-primary-mmap-gtt
[511.017011] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[511.085968] [104/133] (515s left) core_getversion (basic)
[511.121858] Starting subtest: basic
[511.126215] Subtest basic: SUCCESS (0.000s)
[511.183413] [105/133] (515s left) kms_atomic_transition (plane-all-transition-fencing)
[511.278049] Starting subtest: plane-all-transition-fencing
[511.280309] Starting dynamic subtest: pipe-A-eDP-1
[513.783433] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[514.093721] Starting dynamic subtest: pipe-B-eDP-1
[517.286290] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.202s)
[517.594436] Subtest plane-all-transition-fencing: SUCCESS (6.316s)
[518.427381] [106/133] (507s left) gem_eio (in-flight-immediate)
[518.651868] Starting subtest: in-flight-immediate
[527.340736] Subtest in-flight-immediate: SUCCESS (8.686s)
[527.508567] [107/133] (498s left) kms_pm_backlight (bad-brightness)
[527.603919] Starting subtest: bad-brightness
[527.653942] Starting dynamic subtest: eDP-1
[527.975967] Dynamic subtest eDP-1: SUCCESS (0.322s)
[527.978304] Subtest bad-brightness: SUCCESS (0.373s)
[528.855248] [108/133] (497s left) kms_psr (psr-primary-page-flip)
[528.958317] Starting subtest: psr-primary-page-flip
[528.960733] Starting dynamic subtest: eDP-1
[530.682895] Dynamic subtest eDP-1: SUCCESS (1.726s)
[530.685089] Subtest psr-primary-page-flip: SUCCESS (1.727s)
[531.539689] [109/133] (494s left) gem_exec_store (pages)
[531.600904] Starting subtest: pages
[531.603217] Starting dynamic subtest: rcs0
[531.682052] Dynamic subtest rcs0: SUCCESS (0.084s)
[531.694562] Starting dynamic subtest: bcs0
[531.760986] Dynamic subtest bcs0: SUCCESS (0.076s)
[531.772931] Starting dynamic subtest: vcs0
[531.834047] Dynamic subtest vcs0: SUCCESS (0.072s)
[531.845873] Starting dynamic subtest: vcs1
[531.905026] Dynamic subtest vcs1: SUCCESS (0.070s)
[531.917401] Starting dynamic subtest: vecs0
[531.981730] Dynamic subtest vecs0: SUCCESS (0.075s)
[531.993674] Starting dynamic subtest: ccs0
[532.053087] Dynamic subtest ccs0: SUCCESS (0.070s)
[532.055532] Subtest pages: SUCCESS (0.456s)
[532.251215] [110/133] (494s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[532.350165] Starting subtest: extended-pageflip-modeset-hang-oldfb
[532.352143] Starting dynamic subtest: pipe-A
[540.239969] Dynamic subtest pipe-A: SUCCESS (7.889s)
[540.250418] Starting dynamic subtest: pipe-D
[548.843784] Dynamic subtest pipe-D: SUCCESS (8.598s)
[548.846010] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.491s)
[549.695136] [111/133] (476s left) perf_pmu (busy-start)
[549.738641] Starting subtest: busy-start
[549.740994] Starting dynamic subtest: rcs0
[552.290119] Dynamic subtest rcs0: SUCCESS (2.551s)
[552.302529] Starting dynamic subtest: bcs0
[554.859612] Dynamic subtest bcs0: SUCCESS (2.548s)
[554.870818] Starting dynamic subtest: vcs0
[558.476516] Dynamic subtest vcs0: SUCCESS (3.630s)
[558.489963] Starting dynamic subtest: vcs1
[562.508399] Dynamic subtest vcs1: SUCCESS (4.029s)
[562.521676] Starting dynamic subtest: vecs0
[566.477062] Dynamic subtest vecs0: SUCCESS (3.966s)
[566.489911] Starting dynamic subtest: ccs0
[569.049883] Dynamic subtest ccs0: SUCCESS (2.550s)
[569.051952] Subtest busy-start: SUCCESS (19.289s)
[569.133729] [112/133] (457s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[569.238979] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[569.240958] Starting dynamic subtest: pipe-A-eDP-1
[569.262216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[569.274696] Starting dynamic subtest: pipe-B-eDP-1
[569.295088] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[569.305343] Starting dynamic subtest: pipe-C-eDP-1
[569.325953] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[569.336109] Starting dynamic subtest: pipe-D-eDP-1
[569.356296] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[569.358625] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[571.488553] [113/133] (455s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[571.538115] Starting subtest: single-wait-all-for-submit-signaled
[571.540371] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[571.625239] [114/133] (455s left) gem_exec_schedule (smoketest-all)
[571.693735] Starting subtest: smoketest-all
[604.068719] Subtest smoketest-all: SUCCESS (32.327s)
[605.555463] [115/133] (421s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[605.654465] Starting subtest: primary-yf-tiled-reflect-x-180
[605.725495] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.071s)
[605.828016] [116/133] (420s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[605.930027] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[605.932355] Starting dynamic subtest: pipe-A-eDP-1
[611.781669] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.856s)
[611.792655] Starting dynamic subtest: pipe-B-eDP-1
[618.425983] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.640s)
[618.428151] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.499s)
[619.316664] [117/133] (407s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[619.416468] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[625.947977] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.533s)
[626.076674] [118/133] (400s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[626.167927] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[626.170199] Starting dynamic subtest: pipe-A
[626.188078] Dynamic subtest pipe-A: SKIP (0.016s)
[626.198942] Starting dynamic subtest: pipe-B
[626.216508] Dynamic subtest pipe-B: SKIP (0.028s)
[626.226943] Starting dynamic subtest: pipe-C
[626.244558] Dynamic subtest pipe-C: SKIP (0.028s)
[626.254539] Starting dynamic subtest: pipe-D
[626.272334] Dynamic subtest pipe-D: SKIP (0.028s)
[626.276829] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.102s)
[626.354941] [119/133] (400s left) kms_universal_plane (cursor-fb-leak)
[626.454857] Starting subtest: cursor-fb-leak
[626.457174] Starting dynamic subtest: pipe-A-eDP-1
[626.797783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.344s)
[626.810654] Starting dynamic subtest: pipe-B-eDP-1
[628.167828] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s)
[628.183346] Starting dynamic subtest: pipe-C-eDP-1
[629.565382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[629.577671] Starting dynamic subtest: pipe-D-eDP-1
[630.894381] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[630.896832] Subtest cursor-fb-leak: SUCCESS (4.441s)
[632.049254] [120/133] (394s left) gem_exec_async (concurrent-writes)
[632.111421] Starting subtest: concurrent-writes
[632.113797] Starting dynamic subtest: rcs0
[632.134002] Dynamic subtest rcs0: SUCCESS (0.022s)
[632.145655] Starting dynamic subtest: bcs0
[632.147956] Dynamic subtest bcs0: SUCCESS (0.006s)
[632.159198] Starting dynamic subtest: vcs0
[632.161179] Dynamic subtest vcs0: SUCCESS (0.005s)
[632.171097] Starting dynamic subtest: vcs1
[632.173388] Dynamic subtest vcs1: SUCCESS (0.007s)
[632.183155] Starting dynamic subtest: vecs0
[632.185139] Dynamic subtest vecs0: SUCCESS (0.007s)
[632.194242] Starting dynamic subtest: ccs0
[632.196234] Dynamic subtest ccs0: SUCCESS (0.013s)
[632.198194] Subtest concurrent-writes: SUCCESS (0.066s)
[632.401134] [121/133] (394s left) syncobj_timeline (reset-signaled)
[632.457153] Starting subtest: reset-signaled
[632.459467] Subtest reset-signaled: SUCCESS (0.000s)
[632.551563] [122/133] (394s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[632.666282] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[632.670928] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[632.815262] [123/133] (394s left) kms_getfb (getfb-handle-protection)
[632.908820] Starting subtest: getfb-handle-protection
[632.933319] Subtest getfb-handle-protection: SUCCESS (0.026s)
[633.052522] [124/133] (394s left) kms_addfb_basic (bad-pitch-32)
[633.112015] Starting subtest: bad-pitch-32
[633.114044] Subtest bad-pitch-32: SUCCESS (0.000s)
[633.267122] [125/133] (393s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[633.368663] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[634.495338] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.126s)
[634.623308] [126/133] (392s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[634.721236] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[634.723459] Starting dynamic subtest: pipe-A-eDP-1
[634.740310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[634.752567] Starting dynamic subtest: pipe-B-eDP-1
[634.768182] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[634.777081] Starting dynamic subtest: pipe-C-eDP-1
[634.792703] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[634.801368] Starting dynamic subtest: pipe-D-eDP-1
[634.817074] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[634.818633] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[637.024788] [127/133] (390s left) kms_vblank (query-forked-hang)
[637.123015] Starting subtest: query-forked-hang
[637.124890] Starting dynamic subtest: pipe-A-eDP-1
[663.245466] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.124s)
[663.260395] Starting dynamic subtest: pipe-D-eDP-1
[688.280006] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.035s)
[688.282437] Subtest query-forked-hang: SUCCESS (51.163s)
[689.077956] [128/133] (338s left) kms_flip (flip-vs-absolute-wf_vblank)
[689.181990] Starting subtest: flip-vs-absolute-wf_vblank
[689.184173] Starting dynamic subtest: A-eDP1
[698.117071] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[698.128791] Starting dynamic subtest: B-eDP1
[707.050025] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[707.061605] Starting dynamic subtest: C-eDP1
[716.007941] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[716.018197] Starting dynamic subtest: D-eDP1
[724.942956] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[724.944902] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.721s)
[726.115953] [129/133] (301s left) kms_pipe_crc_basic (hang-read-crc)
[726.205121] Starting subtest: hang-read-crc
[726.207077] Starting dynamic subtest: pipe-A-eDP-1
[728.293480] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.088s)
[728.303985] Starting dynamic subtest: pipe-B-eDP-1
[730.995350] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.701s)
[731.006493] Starting dynamic subtest: pipe-C-eDP-1
[733.697500] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.701s)
[733.708627] Starting dynamic subtest: pipe-D-eDP-1
[736.377694] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.679s)
[736.380024] Subtest hang-read-crc: SUCCESS (10.175s)
[737.205855] [130/133] (290s left) core_debugfs (read-all-entries)
[737.251808] Starting subtest: read-all-entries
[737.333402] Subtest read-all-entries: SUCCESS (0.082s)
[737.407406] [131/133] (290s left) gem_ccs (block-multicopy-compressed)
[737.469329] Starting subtest: block-multicopy-compressed
[737.474071] Subtest block-multicopy-compressed: SKIP (0.000s)
[737.572152] [132/133] (289s left) kms_plane_multiple (tiling-4)
[737.664894] Starting subtest: tiling-4
[737.667105] Starting dynamic subtest: pipe-A-eDP-1
[741.323243] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.659s)
[741.333686] Starting dynamic subtest: pipe-B-eDP-1
[745.779702] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.453s)
[745.790861] Starting dynamic subtest: pipe-C-eDP-1
[750.122005] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.344s)
[750.133410] Starting dynamic subtest: pipe-D-eDP-1
[754.464908] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.342s)
[754.467341] Subtest tiling-4: SUCCESS (16.802s)
[755.274796] [133/133] (272s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[755.373845] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[758.950306] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.581s)
[760.164462] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: i915_pm_rps
results: parsing output: 2/ for test: gem_exec_parallel
results: parsing output: 3/ for test: gem_workarounds
results: parsing output: 4/ for test: i915_drm_fdinfo
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_render_linear_blits
results: parsing output: 11/ for test: gem_softpin
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_edge_walk
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: gem_pipe_control_store_loop
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: gen7_exec_parse
results: parsing output: 35/ for test: prime_busy
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gen7_exec_parse
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_unref_active_buffers
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: drm_read
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: sysfs_heartbeat_interval
results: parsing output: 55/ for test: gem_create
results: parsing output: 56/ for test: i915_hangman
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_chamelium_hpd
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_draw_crc
results: parsing output: 63/ for test: kms_joiner
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_partial_pwrite_pread
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_debugfs
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_chamelium_edid
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: gem_close
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_atomic
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: gem_lmem_swapping
results: parsing output: 98/ for test: kms_async_flips
results: parsing output: 99/ for test: kms_color
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: core_getversion
results: parsing output: 104/ for test: kms_atomic_transition
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_pm_backlight
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_exec_store
results: parsing output: 109/ for test: kms_busy
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_universal_plane
results: parsing output: 119/ for test: gem_exec_async
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_pipe_crc_basic
results: parsing output: 129/ for test: core_debugfs
results: parsing output: 130/ for test: gem_ccs
results: parsing output: 131/ for test: kms_plane_multiple
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.