[57.628363] Initializing watchdogs
[57.628408]   /dev/watchdog0
[57.643148] [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]
[57.647425] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.649627] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.653817] [001/156] (960s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[57.735293] Starting subtest: multi-wait-for-submit-available-submitted
[57.737600] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[57.841022] [002/156] (960s left) gem_watchdog (default-virtual)
[57.908959] Starting subtest: default-virtual
[64.196056] Subtest default-virtual: SUCCESS (6.293s)
[64.294592] [003/156] (953s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[64.698542] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[65.529259] [004/156] (952s left) gem_mmap_gtt (basic-read-write)
[65.589186] Subtest basic-read-write: SKIP (0.000s)
[65.633662] [005/156] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[65.735689] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[65.740256] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[65.807432] [006/156] (952s left) gem_partial_pwrite_pread (write-uncached)
[65.863890] Subtest write-uncached: SKIP (0.000s)
[65.931922] [007/156] (952s left) prime_mmap (test_invalid_sync_flags)
[65.986999] Starting subtest: test_invalid_sync_flags
[65.989402] Starting dynamic subtest: test_invalid_sync_flags-smem
[65.991553] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[65.993655] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[66.097599] [008/156] (952s left) kms_hdmi_inject (inject-4k)
[66.442608] Starting subtest: inject-4k
[66.792479] Subtest inject-4k: SUCCESS (0.353s)
[67.306593] [009/156] (951s left) gem_exec_whisper (basic-fds-forked-all)
[67.367083] Starting subtest: basic-fds-forked-all
[87.658059] Subtest basic-fds-forked-all: SUCCESS (20.292s)
[87.839657] [010/156] (930s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[87.938579] Starting subtest: pipe-fbc-rte
[87.945596] Starting dynamic subtest: pipe-B-eDP-1
[93.393720] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.462s)
[93.401074] Subtest pipe-fbc-rte: SUCCESS (5.463s)
[95.684875] [011/156] (922s left) perf_pmu (gt-awake)
[95.733418] Starting subtest: gt-awake
[104.326517] Subtest gt-awake: SUCCESS (8.593s)
[104.431828] [012/156] (914s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[104.541646] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[104.546210] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[104.640112] [013/156] (913s left) kms_psr (psr-primary-mmap-gtt)
[104.747884] Starting subtest: psr-primary-mmap-gtt
[104.750335] Starting dynamic subtest: eDP-1
[106.236060] Dynamic subtest eDP-1: SKIP (1.485s)
[106.240885] Subtest psr-primary-mmap-gtt: SKIP (1.486s)
[106.388862] [014/156] (912s left) kms_chamelium_color (ctm-max)
[106.485418] Subtest ctm-max: SKIP (0.000s)
[106.525475] [015/156] (912s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-move)
[106.634050] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-move
[106.638249] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[106.742386] [016/156] (911s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[106.834029] Starting subtest: psr-rgb565-draw-mmap-gtt
[106.837942] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[106.932798] [017/156] (911s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[107.025814] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[107.028119] Starting dynamic subtest: pipe-A-default-mode
[108.205901] Dynamic subtest pipe-A-default-mode: SKIP (1.178s)
[108.210462] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.179s)
[108.361678] [018/156] (910s left) core_auth (getclient-master-drop)
[108.403345] Starting subtest: getclient-master-drop
[108.429180] Subtest getclient-master-drop: SUCCESS (0.024s)
[108.550967] [019/156] (910s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[108.684188] Starting subtest: cursorB-vs-flipB-legacy
[108.688939] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[108.847812] [020/156] (910s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-render)
[108.946840] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-render
[108.951189] Subtest psrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[109.042245] [021/156] (909s left) kms_flip (blocking-wf_vblank)
[109.136361] Starting subtest: blocking-wf_vblank
[109.138370] Starting dynamic subtest: A-eDP1
[118.090734] Dynamic subtest A-eDP1: SUCCESS (8.952s)
[118.099636] Starting dynamic subtest: B-eDP1
[126.992411] Dynamic subtest B-eDP1: SUCCESS (8.901s)
[127.003138] Starting dynamic subtest: C-eDP1
[135.879995] Dynamic subtest C-eDP1: SUCCESS (8.885s)
[135.890901] Starting dynamic subtest: D-eDP1
[144.773758] Dynamic subtest D-eDP1: SUCCESS (8.893s)
[144.779493] Subtest blocking-wf_vblank: SUCCESS (35.640s)
[145.976687] [022/156] (872s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[146.069661] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[146.072085] Starting dynamic subtest: A-eDP1
[149.704698] Dynamic subtest A-eDP1: SUCCESS (3.633s)
[149.715227] Starting dynamic subtest: B-eDP1
[153.003274] Dynamic subtest B-eDP1: SUCCESS (3.296s)
[153.013151] Starting dynamic subtest: C-eDP1
[156.308869] Dynamic subtest C-eDP1: SUCCESS (3.307s)
[156.319062] Starting dynamic subtest: D-eDP1
[159.588520] Dynamic subtest D-eDP1: SUCCESS (3.277s)
[159.590497] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.519s)
[160.469873] [023/156] (858s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[160.573617] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[164.773828] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.207s)
[165.972306] [024/156] (853s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[166.073421] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[166.075870] Starting dynamic subtest: pipe-A-eDP-1
[166.085835] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.098605] Starting dynamic subtest: pipe-B-eDP-1
[166.108118] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.116518] Starting dynamic subtest: pipe-C-eDP-1
[166.125155] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.133630] Starting dynamic subtest: pipe-D-eDP-1
[166.142475] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.146675] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[168.376933] [025/156] (850s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[168.477719] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[168.481720] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[168.585765] [026/156] (850s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[168.641958] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[168.751085] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[168.827287] [027/156] (850s left) sw_sync (sync_multi_consumer_producer)
[168.862922] Starting subtest: sync_multi_consumer_producer
[169.152410] Subtest sync_multi_consumer_producer: SUCCESS (0.291s)
[169.222948] [028/156] (849s left) prime_vgem (busy)
[169.393203] Starting subtest: busy
[169.395495] Starting dynamic subtest: rcs0
[169.431758] Dynamic subtest rcs0: SUCCESS (0.041s)
[169.441128] Starting dynamic subtest: bcs0
[169.483463] Dynamic subtest bcs0: SUCCESS (0.051s)
[169.492303] Starting dynamic subtest: vcs0
[169.531934] Dynamic subtest vcs0: SUCCESS (0.047s)
[169.540800] Starting dynamic subtest: vcs1
[169.577942] Dynamic subtest vcs1: SUCCESS (0.045s)
[169.586884] Starting dynamic subtest: vecs0
[169.624803] Dynamic subtest vecs0: SUCCESS (0.046s)
[169.633896] Starting dynamic subtest: ccs0
[169.670964] Dynamic subtest ccs0: SUCCESS (0.046s)
[169.673714] Subtest busy: SUCCESS (0.281s)
[169.791285] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[169.795182] [029/156] (849s left) intel_hwmon (hwmon-write)
[169.847987] Subtest hwmon-write: SKIP (0.000s)
[169.902080] [030/156] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[169.992342] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[169.996881] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[170.080693] [031/156] (849s left) kms_chamelium_frames (hdmi-crc-single)
[170.485475] Subtest hdmi-crc-single: SKIP (0.000s)
[171.347165] [032/156] (847s left) gem_ctx_shared (q-smoketest-all)
[171.405451] Starting subtest: Q-smoketest-all
[203.791248] Subtest Q-smoketest-all: SUCCESS (32.338s)
[205.294072] [033/156] (814s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt)
[205.387426] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt
[205.391721] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[205.479263] [034/156] (813s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[205.570226] Starting subtest: fbcpsr-rgb565-draw-render
[212.570254] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.005s)
[212.693559] [035/156] (806s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[212.801829] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[212.806261] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[212.881624] [036/156] (806s left) gem_exec_parallel (fds)
[212.943305] Starting subtest: fds
[212.945648] Starting dynamic subtest: rcs0
[215.456537] Dynamic subtest rcs0: SUCCESS (2.512s)
[215.466835] Starting dynamic subtest: bcs0
[218.882091] Dynamic subtest bcs0: SUCCESS (3.423s)
[218.890791] Starting dynamic subtest: vcs0
[222.568042] Dynamic subtest vcs0: SUCCESS (3.684s)
[222.576960] Starting dynamic subtest: vcs1
[226.584086] Dynamic subtest vcs1: SUCCESS (4.015s)
[226.594357] Starting dynamic subtest: vecs0
[230.576951] Dynamic subtest vecs0: SUCCESS (3.991s)
[230.588168] Starting dynamic subtest: ccs0
[234.431910] Dynamic subtest ccs0: SUCCESS (3.853s)
[234.434837] Subtest fds: SUCCESS (21.488s)
[234.625030] [037/156] (784s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[234.741799] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[235.886487] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.145s)
[235.995924] [038/156] (783s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff)
[236.097468] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff
[236.100798] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[236.203810] [039/156] (783s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[236.290061] Starting subtest: disable-crc-after-crtc
[236.291783] Starting dynamic subtest: pipe-A-eDP-1
[237.979902] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.686s)
[237.990329] Starting dynamic subtest: pipe-B-eDP-1
[240.365766] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.387s)
[240.374510] Starting dynamic subtest: pipe-C-eDP-1
[242.666768] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.299s)
[242.676919] Starting dynamic subtest: pipe-D-eDP-1
[245.065082] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.397s)
[245.067320] Subtest disable-crc-after-crtc: SUCCESS (8.777s)
[245.965305] [040/156] (773s left) syncobj_wait (multi-wait-all-submitted)
[246.022700] Starting subtest: multi-wait-all-submitted
[246.126539] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[246.205449] [041/156] (773s left) kms_dsc (dsc-with-output-formats-with-bpc)
[246.293488] Starting subtest: dsc-with-output-formats-with-bpc
[246.351585] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[246.393316] [042/156] (773s left) kms_vrr (lobf)
[246.492624] Starting subtest: lobf
[246.496572] Subtest lobf: SKIP (0.000s)
[246.577142] [043/156] (773s left) kms_draw_crc (fill-fb)
[246.672488] Starting subtest: fill-fb
[247.148903] Subtest fill-fb: SUCCESS (0.477s)
[247.238151] [044/156] (772s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[247.330088] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[247.333658] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[247.424557] [045/156] (772s left) kms_busy (basic-hang)
[247.521728] Starting subtest: basic-hang
[247.523629] Starting dynamic subtest: flip-pipe-A
[248.114114] Dynamic subtest flip-pipe-A: SUCCESS (0.592s)
[248.124353] Starting dynamic subtest: modeset-pipe-A
[251.500189] Dynamic subtest modeset-pipe-A: SUCCESS (3.386s)
[251.509854] Starting dynamic subtest: flip-pipe-D
[252.753061] Dynamic subtest flip-pipe-D: SUCCESS (1.248s)
[252.762273] Starting dynamic subtest: modeset-pipe-D
[256.090713] Dynamic subtest modeset-pipe-D: SUCCESS (3.339s)
[256.093287] Subtest basic-hang: SUCCESS (8.571s)
[256.955583] [046/156] (762s left) kms_cursor_edge_walk (64x64-left-edge)
[257.042158] Starting subtest: 64x64-left-edge
[257.044478] Starting dynamic subtest: pipe-A-eDP-1
[260.505438] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[260.515275] Starting dynamic subtest: pipe-D-eDP-1
[263.691324] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.185s)
[263.693592] Subtest 64x64-left-edge: SUCCESS (6.651s)
[264.559694] [047/156] (755s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[264.660160] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[264.662724] Starting dynamic subtest: pipe-A-eDP-1
[265.173374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[265.184611] Starting dynamic subtest: pipe-B-eDP-1
[266.567739] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[266.578034] Starting dynamic subtest: pipe-C-eDP-1
[267.995350] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.427s)
[268.005792] Starting dynamic subtest: pipe-D-eDP-1
[269.426494] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.431s)
[269.428421] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.741s)
[270.654505] [048/156] (749s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[270.745381] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[270.771462] Starting dynamic subtest: pipe-A-plane-0
[271.037906] Dynamic subtest pipe-A-plane-0: SUCCESS (0.267s)
[271.047324] Starting dynamic subtest: pipe-A-plane-3
[271.249168] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[272.417299] Starting dynamic subtest: pipe-B-plane-0
[272.685434] Dynamic subtest pipe-B-plane-0: SUCCESS (0.277s)
[272.694190] Starting dynamic subtest: pipe-B-plane-3
[272.895851] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[273.208140] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.463s)
[274.083782] [049/156] (745s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[274.176726] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[274.179076] Starting dynamic subtest: pipe-A
[274.237563] Dynamic subtest pipe-A: SUCCESS (0.064s)
[274.248739] Starting dynamic subtest: pipe-B
[275.344567] Dynamic subtest pipe-B: SUCCESS (1.105s)
[275.359783] Starting dynamic subtest: pipe-C
[276.534049] Dynamic subtest pipe-C: SUCCESS (1.189s)
[276.544595] Starting dynamic subtest: pipe-D
[277.641255] Dynamic subtest pipe-D: SUCCESS (1.106s)
[277.643602] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.468s)
[278.853842] [050/156] (741s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[278.950217] Starting subtest: primary-y-tiled-reflect-x-180
[279.009701] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[279.110655] [051/156] (740s left) syncobj_basic (bad-pad-fd-to-handle)
[279.167928] Starting subtest: bad-pad-fd-to-handle
[279.171649] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[279.262139] [052/156] (740s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[279.384295] Starting subtest: basic-flip-before-cursor-varying-size
[280.323502] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.938s)
[281.155041] [053/156] (739s left) drm_buddy (drm_buddy)
[281.189028] Starting subtest: drm_buddy
[281.193608] Subtest drm_buddy: SKIP (0.000s)
[281.253609] [054/156] (738s left) gen7_exec_parse (chained-batch)
[281.307979] Subtest chained-batch: SKIP (0.000s)
[281.378135] [055/156] (738s left) gem_exec_reloc (basic-wc-read-noreloc)
[281.429542] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[281.505540] [056/156] (738s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[281.598941] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[286.917949] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.325s)
[288.067655] [057/156] (732s left) gem_exec_parallel (userptr)
[288.123713] Starting subtest: userptr
[288.126132] Starting dynamic subtest: rcs0
[289.572716] Dynamic subtest rcs0: SUCCESS (1.449s)
[289.584874] Starting dynamic subtest: bcs0
[291.051972] Dynamic subtest bcs0: SUCCESS (1.478s)
[291.062882] Starting dynamic subtest: vcs0
[294.274559] Dynamic subtest vcs0: SUCCESS (3.220s)
[294.285992] Starting dynamic subtest: vcs1
[296.322335] Dynamic subtest vcs1: SUCCESS (2.045s)
[296.334057] Starting dynamic subtest: vecs0
[298.242769] Dynamic subtest vecs0: SUCCESS (1.917s)
[298.254542] Starting dynamic subtest: ccs0
[299.750669] Dynamic subtest ccs0: SUCCESS (1.507s)
[299.753103] Subtest userptr: SUCCESS (11.629s)
[299.941110] [058/156] (720s left) syncobj_timeline (wait-zero-handles)
[299.995986] Starting subtest: wait-zero-handles
[299.998083] Subtest wait-zero-handles: SUCCESS (0.000s)
[300.109488] [059/156] (720s left) kms_flip (plain-flip-interruptible)
[300.203826] Starting subtest: plain-flip-interruptible
[300.206099] Starting dynamic subtest: A-eDP1
[301.923991] Dynamic subtest A-eDP1: SUCCESS (1.718s)
[301.935144] Starting dynamic subtest: B-eDP1
[303.621232] Dynamic subtest B-eDP1: SUCCESS (1.695s)
[303.633245] Starting dynamic subtest: C-eDP1
[305.316637] Dynamic subtest C-eDP1: SUCCESS (1.694s)
[305.326657] Starting dynamic subtest: D-eDP1
[307.024226] Dynamic subtest D-eDP1: SUCCESS (1.706s)
[307.029589] Subtest plain-flip-interruptible: SUCCESS (6.824s)
[308.260923] [060/156] (712s left) sw_sync (alloc_timeline)
[308.298404] Starting subtest: alloc_timeline
[308.300856] Subtest alloc_timeline: SUCCESS (0.000s)
[308.364103] [061/156] (712s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[308.452848] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[308.457219] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[308.561515] [062/156] (711s left) kms_content_protection (dp-mst-type-0-hdcp14)
[308.686324] Starting subtest: dp-mst-type-0-hdcp14
[308.690738] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[308.826813] [063/156] (711s left) gem_exec_schedule (semaphore-codependency)
[308.897713] Starting subtest: semaphore-codependency
[308.903400] Subtest semaphore-codependency: SUCCESS (0.014s)
[309.252700] [064/156] (711s left) i915_pm_rps (reset)
[309.313597] Starting subtest: reset
[317.747678] Subtest reset: SUCCESS (8.431s)
[317.856799] [065/156] (702s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[317.947677] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[317.949914] Starting dynamic subtest: pipe-A-eDP-1
[317.970627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[317.986735] Starting dynamic subtest: pipe-B-eDP-1
[318.006268] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[318.016161] Starting dynamic subtest: pipe-C-eDP-1
[318.035315] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[318.044775] Starting dynamic subtest: pipe-D-eDP-1
[318.064310] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[318.066524] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[320.253062] [066/156] (700s left) kms_invalid_mode (zero-clock)
[320.349422] Starting subtest: zero-clock
[320.351676] Starting dynamic subtest: pipe-A-eDP-1
[320.634607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[320.645331] Starting dynamic subtest: pipe-B-eDP-1
[320.647563] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[320.657289] Starting dynamic subtest: pipe-C-eDP-1
[320.659590] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[320.668800] Starting dynamic subtest: pipe-D-eDP-1
[320.671096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[320.673406] Subtest zero-clock: SUCCESS (0.291s)
[321.466475] [067/156] (699s left) syncobj_eventfd (timeline-wait)
[321.524876] Starting subtest: timeline-wait
[321.532834] Subtest timeline-wait: SUCCESS (0.010s)
[321.611189] [068/156] (699s left) kms_flip (busy-flip)
[321.707191] Starting subtest: busy-flip
[321.709519] Starting dynamic subtest: A-eDP1
[323.426072] Dynamic subtest A-eDP1: SUCCESS (1.718s)
[323.440862] Starting dynamic subtest: B-eDP1
[325.133331] Dynamic subtest B-eDP1: SUCCESS (1.704s)
[325.143425] Starting dynamic subtest: C-eDP1
[326.818515] Dynamic subtest C-eDP1: SUCCESS (1.684s)
[326.828860] Starting dynamic subtest: D-eDP1
[328.517937] Dynamic subtest D-eDP1: SUCCESS (1.699s)
[328.524784] Subtest busy-flip: SUCCESS (6.815s)
[329.745223] [069/156] (691s left) kms_flip (flip-vs-rmfb-interruptible)
[329.849330] Starting subtest: flip-vs-rmfb-interruptible
[329.851720] Starting dynamic subtest: A-eDP1
[338.508724] Dynamic subtest A-eDP1: SUCCESS (8.659s)
[338.520622] Starting dynamic subtest: B-eDP1
[347.216078] Dynamic subtest B-eDP1: SUCCESS (8.706s)
[347.227389] Starting dynamic subtest: C-eDP1
[355.896662] Dynamic subtest C-eDP1: SUCCESS (8.678s)
[355.906587] Starting dynamic subtest: D-eDP1
[364.504679] Dynamic subtest D-eDP1: SUCCESS (8.606s)
[364.509104] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.661s)
[365.758547] [070/156] (655s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[367.491602] Starting subtest: modeset-non-lpsp-stress-no-wait
[367.545822] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.057s)
[368.060478] [071/156] (652s left) api_intel_allocator (simple-allocator)
[368.118217] Starting subtest: simple-allocator
[368.120569] Starting dynamic subtest: basic
[368.122881] Dynamic subtest basic: SUCCESS (0.004s)
[368.133948] Starting dynamic subtest: parallel-one
[368.289703] Dynamic subtest parallel-one: SUCCESS (0.166s)
[368.303675] Starting dynamic subtest: print
[368.305620] Dynamic subtest print: SUCCESS (0.000s)
[368.315347] Starting dynamic subtest: reuse
[368.317473] Dynamic subtest reuse: SUCCESS (0.000s)
[368.326470] Starting dynamic subtest: reserve
[368.328663] Dynamic subtest reserve: SUCCESS (0.000s)
[368.337884] Starting dynamic subtest: fork-reopen-allocator
[368.340083] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[368.342203] Subtest simple-allocator: SUCCESS (0.191s)
[368.449290] [072/156] (652s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[368.552455] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[368.556717] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[368.649196] [073/156] (652s left) kms_plane_cursor (viewport)
[368.745216] Starting subtest: viewport
[368.749640] Starting dynamic subtest: pipe-A-eDP-1-size-64
[371.310361] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.567s)
[371.371601] Starting dynamic subtest: pipe-A-eDP-1-size-128
[373.910077] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[373.974819] Starting dynamic subtest: pipe-A-eDP-1-size-256
[376.499608] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.539s)
[376.849907] Starting dynamic subtest: pipe-B-eDP-1-size-64
[380.016193] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.177s)
[380.076718] Starting dynamic subtest: pipe-B-eDP-1-size-128
[382.572521] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.505s)
[382.633880] Starting dynamic subtest: pipe-B-eDP-1-size-256
[385.196059] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[385.543797] Starting dynamic subtest: pipe-C-eDP-1-size-64
[388.372268] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.839s)
[388.410668] Starting dynamic subtest: pipe-C-eDP-1-size-128
[390.594314] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[390.633143] Starting dynamic subtest: pipe-C-eDP-1-size-256
[392.816344] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[393.150382] Starting dynamic subtest: pipe-D-eDP-1-size-64
[396.005788] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.867s)
[396.044798] Starting dynamic subtest: pipe-D-eDP-1-size-128
[398.196813] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.161s)
[398.232803] Starting dynamic subtest: pipe-D-eDP-1-size-256
[400.394482] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.170s)
[400.713512] Subtest viewport: SUCCESS (31.968s)
[401.547576] [074/156] (619s left) gem_exec_params (rsvd2-dirt)
[401.602104] Starting subtest: rsvd2-dirt
[401.607068] Subtest rsvd2-dirt: SKIP (0.000s)
[401.699056] [075/156] (619s left) gem_pxp (create-regular-buffer)
[401.812051] Starting subtest: create-regular-buffer
[401.814368] Subtest create-regular-buffer: SUCCESS (0.000s)
[401.927623] [076/156] (619s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[402.015787] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[402.020215] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[402.124292] [077/156] (619s left) perf (global-sseu-config)
[402.252072] Starting subtest: global-sseu-config
[402.256249] Subtest global-sseu-config: SKIP (0.000s)
[402.293754] [078/156] (618s left) kms_cursor_crc (cursor-onscreen-128x128)
[402.493118] Starting subtest: cursor-onscreen-128x128
[402.497966] Starting dynamic subtest: pipe-A-eDP-1
[404.618841] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[404.646281] Starting dynamic subtest: pipe-D-eDP-1
[407.411174] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[407.413418] Subtest cursor-onscreen-128x128: SUCCESS (4.915s)
[408.250617] [079/156] (613s left) kms_getfb (getfb-handle-not-fb)
[408.359421] Starting subtest: getfb-handle-not-fb
[408.361700] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[408.459392] [080/156] (612s left) kms_atomic_transition (plane-all-modeset-transition)
[408.554180] Starting subtest: plane-all-modeset-transition
[408.558246] Subtest plane-all-modeset-transition: SKIP (0.000s)
[408.629725] [081/156] (612s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[408.725957] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[408.730419] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[408.816604] [082/156] (612s left) gem_exec_reloc (basic-softpin)
[408.884068] Subtest basic-softpin: SKIP (0.000s)
[408.958199] [083/156] (612s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[409.018572] Starting subtest: yf-tiled-ccs-to-x-tiled
[409.023450] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[409.216505] [084/156] (612s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[409.319199] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[416.452544] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (7.139s)
[416.578222] [085/156] (604s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[416.674088] Starting subtest: y-tiled-32bpp-rotate-0
[416.678609] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[416.782790] [086/156] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[416.878684] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[416.883124] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[416.980776] [087/156] (604s left) gem_exec_params (rel-constants-invalid-ring)
[417.033602] Starting subtest: rel-constants-invalid-ring
[417.035926] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[417.162289] [088/156] (604s left) gem_mmap_gtt (big-bo)
[417.222078] Subtest big-bo: SKIP (0.000s)
[417.292742] [089/156] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[417.397357] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[417.400863] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.491948] [090/156] (604s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[417.586243] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[417.589615] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[417.696240] [091/156] (604s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[417.789413] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[417.792896] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[417.891100] [092/156] (603s left) i915_selftest (mock)
[421.363941] Starting subtest: mock
[421.366277] Starting dynamic subtest: sanitycheck
[422.035519] Dynamic subtest sanitycheck: SUCCESS (0.695s)
[422.051774] Starting dynamic subtest: shmem
[422.699933] Dynamic subtest shmem: SUCCESS (0.663s)
[422.709901] Starting dynamic subtest: fence
[430.399437] Dynamic subtest fence: SUCCESS (7.696s)
[430.409720] Starting dynamic subtest: scatterlist
[432.083047] Dynamic subtest scatterlist: SUCCESS (1.682s)
[432.093266] Starting dynamic subtest: syncmap
[435.176432] Dynamic subtest syncmap: SUCCESS (3.091s)
[435.186569] Starting dynamic subtest: uncore
[435.843342] Dynamic subtest uncore: SUCCESS (0.665s)
[435.853292] Starting dynamic subtest: ring
[436.538461] Dynamic subtest ring: SUCCESS (0.692s)
[436.548761] Starting dynamic subtest: engine
[437.234212] Dynamic subtest engine: SUCCESS (0.693s)
[437.243685] Starting dynamic subtest: timelines
[440.986096] Dynamic subtest timelines: SUCCESS (3.749s)
[440.996764] Starting dynamic subtest: requests
[444.725042] Dynamic subtest requests: SUCCESS (3.736s)
[444.734713] Starting dynamic subtest: objects
[445.471965] Dynamic subtest objects: SUCCESS (0.746s)
[445.482253] Starting dynamic subtest: phys
[446.248949] Dynamic subtest phys: SUCCESS (0.776s)
[446.259065] Starting dynamic subtest: dmabuf
[447.026510] Dynamic subtest dmabuf: SUCCESS (0.776s)
[447.035043] Starting dynamic subtest: vma
[452.691958] Dynamic subtest vma: SUCCESS (5.662s)
[452.701805] Starting dynamic subtest: evict
[454.058207] Dynamic subtest evict: SUCCESS (1.365s)
[454.067536] Starting dynamic subtest: gtt
[457.319067] Dynamic subtest gtt: SUCCESS (3.260s)
[457.327248] Starting dynamic subtest: hugepages
[458.230082] Dynamic subtest hugepages: SUCCESS (0.909s)
[458.240296] Starting dynamic subtest: memory_region
[460.713015] Dynamic subtest memory_region: SUCCESS (2.481s)
[460.715666] Subtest mock: SUCCESS (39.374s)
[460.742578] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[460.743280] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[460.746402] [093/156] (561s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[462.313616] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[462.318040] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[462.417474] [FACT kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[462.419258] [FACT kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[462.423460] [094/156] (559s left) gem_exec_balancer (busy)
[462.493738] Starting subtest: busy
[464.323105] Subtest busy: SUCCESS (1.828s)
[464.634956] [095/156] (557s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[464.735904] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[464.739997] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[464.815456] [096/156] (557s left) gem_partial_pwrite_pread (reads-uncached)
[464.885162] Subtest reads-uncached: SKIP (0.000s)
[464.961737] [097/156] (557s left) gem_exec_reloc (basic-cpu)
[465.016808] Subtest basic-cpu: SKIP (0.000s)
[465.088854] [098/156] (556s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[465.186273] Starting subtest: yf-tiled-8bpp-rotate-0
[465.190726] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[465.296378] [099/156] (556s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[465.391962] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[465.396611] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[465.484795] [100/156] (556s left) gem_exec_fence (nb-await)
[465.663285] Starting subtest: nb-await
[465.665890] Starting dynamic subtest: rcs0
[465.737244] Dynamic subtest rcs0: SUCCESS (0.073s)
[465.750065] Starting dynamic subtest: bcs0
[465.796214] Dynamic subtest bcs0: SUCCESS (0.057s)
[465.807330] Starting dynamic subtest: vcs0
[465.855459] Dynamic subtest vcs0: SUCCESS (0.057s)
[465.867121] Starting dynamic subtest: vcs1
[465.915981] Dynamic subtest vcs1: SUCCESS (0.059s)
[465.927506] Starting dynamic subtest: vecs0
[465.975044] Dynamic subtest vecs0: SUCCESS (0.056s)
[465.987368] Starting dynamic subtest: ccs0
[466.033064] Dynamic subtest ccs0: SUCCESS (0.056s)
[466.035668] Subtest nb-await: SUCCESS (0.371s)
[467.320867] [101/156] (554s left) kms_hdr (bpc-switch-suspend)
[467.419502] Starting subtest: bpc-switch-suspend
[467.421873] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[488.223282] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.773s)
[488.234682] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[509.200992] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.664s)
[509.203886] Subtest bpc-switch-suspend: SUCCESS (11.440s)
[509.345009] [102/156] (512s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[509.456711] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[509.461587] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[509.552562] [103/156] (512s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[509.652679] Starting subtest: pr-plane-move-sf-dmg-area
[509.657912] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[509.733883] [104/156] (512s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[509.822298] Starting subtest: bad-aux-stride-y-tiled-ccs
[509.824850] Starting dynamic subtest: pipe-A-eDP-1
[509.848369] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[509.859879] Starting dynamic subtest: pipe-B-eDP-1
[509.884683] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[509.893743] Starting dynamic subtest: pipe-C-eDP-1
[509.918623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[509.927671] Starting dynamic subtest: pipe-D-eDP-1
[509.953506] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[509.958633] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[512.126669] [105/156] (510s left) gem_lmem_swapping (heavy-verify-random-ccs)
[512.168388] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[512.230066] [106/156] (510s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[512.344617] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[512.349707] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[512.495425] [107/156] (509s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render)
[512.594436] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render
[512.599264] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[512.681838] [108/156] (509s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[512.773728] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[512.778911] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[512.848719] [109/156] (509s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[512.938738] Starting subtest: flip-primary-invalidate-overlay
[524.637795] Subtest flip-primary-invalidate-overlay: SUCCESS (11.692s)
[524.789158] [110/156] (497s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[524.879703] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[524.884147] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.980460] [111/156] (497s left) gem_create (create-ext-cpu-access-big)
[525.142845] Starting subtest: create-ext-cpu-access-big
[525.148026] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[525.219682] [112/156] (497s left) kms_psr (fbc-pr-suspend)
[525.310473] Starting subtest: fbc-pr-suspend
[525.315695] Subtest fbc-pr-suspend: SKIP (0.000s)
[525.385154] [113/156] (497s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[525.489794] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[529.105966] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.623s)
[530.249513] [114/156] (492s left) gem_media_vme
[530.381135] [115/156] (492s left) kms_psr (fbc-pr-primary-blt)
[530.468658] Starting subtest: fbc-pr-primary-blt
[530.473803] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[530.540666] [116/156] (492s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[530.639860] Starting subtest: x-tiled-addfb-size-offset-overflow
[530.642687] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[530.723724] [117/156] (492s left) kms_vblank (query-busy-hang)
[530.803707] Starting subtest: query-busy-hang
[530.806429] Starting dynamic subtest: pipe-A-eDP-1
[557.385496] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.573s)
[557.402647] Starting dynamic subtest: pipe-D-eDP-1
[572.424255] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.033s)
[572.426987] Subtest query-busy-hang: SUCCESS (41.609s)
[573.301847] [118/156] (449s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[573.400307] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[573.405108] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[573.489269] [119/156] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[573.598508] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[573.603704] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[573.716489] [120/156] (449s left) kms_cursor_crc (cursor-size-hints)
[573.842855] Starting subtest: cursor-size-hints
[573.845668] Starting dynamic subtest: pipe-A-eDP-1
[574.461643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[574.472672] Starting dynamic subtest: pipe-D-eDP-1
[575.767727] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[575.770467] Subtest cursor-size-hints: SUCCESS (1.922s)
[576.583021] [121/156] (446s left) gem_mmap_offset (mmap-boundaries)
[576.640615] Starting subtest: mmap-boundaries
[576.642871] Starting dynamic subtest: smem0
[576.925294] Dynamic subtest smem0: SUCCESS (0.286s)
[576.928505] Subtest mmap-boundaries: SUCCESS (0.287s)
[577.049106] [122/156] (446s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[577.145922] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[577.151778] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[577.246632] [123/156] (445s left) i915_drm_fdinfo (busy)
[577.286884] Starting subtest: busy
[577.289274] Starting dynamic subtest: rcs0
[577.312720] Dynamic subtest rcs0: SKIP (0.024s)
[577.323853] Starting dynamic subtest: bcs0
[577.329263] Dynamic subtest bcs0: SKIP (0.000s)
[577.339657] Starting dynamic subtest: vcs0
[577.344888] Dynamic subtest vcs0: SKIP (0.000s)
[577.355545] Starting dynamic subtest: vcs1
[577.360660] Dynamic subtest vcs1: SKIP (0.000s)
[577.370393] Starting dynamic subtest: vecs0
[577.375634] Dynamic subtest vecs0: SKIP (0.000s)
[577.385676] Starting dynamic subtest: ccs0
[577.391083] Dynamic subtest ccs0: SKIP (0.000s)
[577.396409] Subtest busy: SKIP (0.028s)
[577.437230] [124/156] (445s left) kms_psr (fbc-psr-sprite-blt)
[577.531704] Starting subtest: fbc-psr-sprite-blt
[577.534293] Starting dynamic subtest: eDP-1
[577.539747] Dynamic subtest eDP-1: SKIP (0.000s)
[577.544898] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[577.604842] [125/156] (445s left) kms_addfb_basic (invalid-set-prop-any)
[577.648611] Starting subtest: invalid-set-prop-any
[577.650779] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[577.775053] [126/156] (445s left) kms_big_fb (4-tiled-addfb-size-overflow)
[577.873455] Starting subtest: 4-tiled-addfb-size-overflow
[577.876126] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[577.972304] [127/156] (445s left) kms_color (ctm-0-75)
[578.061687] Starting subtest: ctm-0-75
[578.064065] Starting dynamic subtest: pipe-A-eDP-1
[583.015871] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.951s)
[583.026848] Starting dynamic subtest: pipe-B-eDP-1
[588.759766] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.744s)
[588.771199] Starting dynamic subtest: pipe-C-eDP-1
[594.139729] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.377s)
[594.150446] Starting dynamic subtest: pipe-D-eDP-1
[599.495655] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.353s)
[599.498534] Subtest ctm-0-75: SUCCESS (21.428s)
[600.321355] [128/156] (423s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[600.388719] Starting subtest: single-wait-all-for-submit-signaled
[600.391450] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[600.481537] [129/156] (422s left) syncobj_timeline (invalid-transfer-illegal-handle)
[600.546754] Starting subtest: invalid-transfer-illegal-handle
[600.549510] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[600.663807] [130/156] (422s left) gem_exec_schedule (preempt-queue-contexts-chain)
[600.739555] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[601.047995] [131/156] (422s left) kms_dp_link_training (uhbr-mst)
[601.144619] Starting subtest: uhbr-mst
[601.154909] Subtest uhbr-mst: SKIP (0.000s)
[601.221181] [132/156] (422s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[601.317496] Starting subtest: plane-downscale-factor-0-75-with-rotation
[601.320515] Starting dynamic subtest: pipe-A
[601.546728] Dynamic subtest pipe-A: SUCCESS (0.231s)
[601.556456] Starting dynamic subtest: pipe-B
[602.907614] Dynamic subtest pipe-B: SUCCESS (1.359s)
[602.917307] Starting dynamic subtest: pipe-C
[604.217600] Dynamic subtest pipe-C: SUCCESS (1.309s)
[604.228775] Starting dynamic subtest: pipe-D
[605.554674] Dynamic subtest pipe-D: SUCCESS (1.337s)
[605.557755] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.240s)
[606.730451] [133/156] (416s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[606.828350] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[606.833686] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[606.917393] [134/156] (416s left) gem_exec_reloc (basic-write-wc-active)
[606.973466] Subtest basic-write-wc-active: SKIP (0.000s)
[607.042201] [135/156] (416s left) gem_exec_reloc (basic-cpu-gtt-active)
[607.095622] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[607.156443] [136/156] (416s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[607.251895] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[614.535874] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.294s)
[614.651099] [137/156] (409s left) fbdev (info)
[614.689769] Starting subtest: info
[614.692465] Subtest info: SUCCESS (0.000s)
[614.763385] [138/156] (409s left) kms_pm_rpm (cursor-dpms)
[616.792338] Starting subtest: cursor-dpms
[616.797865] Subtest cursor-dpms: SKIP (0.000s)
[617.177679] [139/156] (406s left) gem_ctx_freq (sysfs)
[617.243657] Starting subtest: sysfs
[617.245833] Starting dynamic subtest: gt0
[622.764273] Dynamic subtest gt0: SUCCESS (5.525s)
[622.776802] Starting dynamic subtest: gt1
[664.643872] Dynamic subtest gt1: SUCCESS (41.881s)
[664.647167] Subtest sysfs: SUCCESS (47.409s)
[664.773323] [140/156] (359s left) gem_exec_balancer (parallel-keep-submit-fence)
[665.023176] Starting subtest: parallel-keep-submit-fence
[666.214127] Subtest parallel-keep-submit-fence: SUCCESS (1.191s)
[666.330063] [141/156] (357s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[666.379350] Starting subtest: yf-tiled-to-vebox-x-tiled
[666.384476] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[666.569513] [142/156] (357s left) gem_spin_batch (user-each)
[666.619638] Starting subtest: user-each
[669.996849] Subtest user-each: SUCCESS (3.377s)
[670.653766] [143/156] (353s left) i915_hangman (gt-error-state-capture)
[670.718701] Starting subtest: gt-error-state-capture
[670.721291] Starting dynamic subtest: rcs0
[682.593210] Dynamic subtest rcs0: SUCCESS (11.874s)
[682.608693] Starting dynamic subtest: bcs0
[693.601472] Dynamic subtest bcs0: SUCCESS (11.004s)
[693.616292] Starting dynamic subtest: vcs0
[705.571194] Dynamic subtest vcs0: SUCCESS (11.964s)
[705.585876] Starting dynamic subtest: vcs1
[717.537590] Dynamic subtest vcs1: SUCCESS (11.961s)
[717.551860] Starting dynamic subtest: vecs0
[728.609232] Dynamic subtest vecs0: SUCCESS (11.067s)
[728.623201] Starting dynamic subtest: ccs0
[740.577993] Dynamic subtest ccs0: SUCCESS (11.967s)
[740.580845] Subtest gt-error-state-capture: SUCCESS (69.855s)
[740.675527] [144/156] (283s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-plflip-blt)
[740.784973] Starting subtest: hdr-1p-primscrn-indfb-plflip-blt
[740.789898] Subtest hdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[740.869155] [145/156] (283s left) sw_sync (sync_multi_timeline_wait)
[740.904858] Starting subtest: sync_multi_timeline_wait
[740.907543] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[740.965280] [146/156] (283s left) gem_tiled_swapping (non-threaded)
[741.014453] Subtest non-threaded: SKIP (0.000s)
[741.075530] [147/156] (283s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[741.185616] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[741.190871] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[741.277481] [148/156] (283s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[741.368681] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[741.373342] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[741.473298] [149/156] (282s left) kms_big_fb (linear-8bpp-rotate-180)
[741.565681] Starting subtest: linear-8bpp-rotate-180
[742.837196] Subtest linear-8bpp-rotate-180: SUCCESS (1.269s)
[742.951135] [150/156] (281s left) kms_frontbuffer_tracking (fbc-tiling-y)
[743.047609] Starting subtest: fbc-tiling-y
[743.051496] Subtest fbc-tiling-y: SKIP (0.000s)
[743.134480] [151/156] (281s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[743.228732] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[743.233414] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[743.331250] [152/156] (281s left) gem_ctx_persistence (heartbeat-hostile)
[743.384977] Starting subtest: heartbeat-hostile
[743.389543] Subtest heartbeat-hostile: SKIP (0.000s)
[743.500429] [153/156] (281s left) kms_atomic (atomic-plane-damage)
[743.584349] Starting subtest: atomic-plane-damage
[743.631460] Starting dynamic subtest: pipe-A-eDP-1
[744.183051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[744.185865] Subtest atomic-plane-damage: SUCCESS (0.599s)
[745.078552] [154/156] (279s left) perf (create-destroy-userspace-config)
[745.196555] Starting subtest: create-destroy-userspace-config
[745.216398] Subtest create-destroy-userspace-config: SUCCESS (0.019s)
[745.269376] [155/156] (279s left) syncobj_basic (bad-pad-handle-to-fd)
[745.316634] Starting subtest: bad-pad-handle-to-fd
[745.319151] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[745.410196] [156/156] (279s left) kms_psr (pr-cursor-plane-onoff)
[745.499343] Starting subtest: pr-cursor-plane-onoff
[745.503857] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[745.573559] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_watchdog
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_partial_pwrite_pread
results: parsing output: 6/ for test: prime_mmap
results: parsing output: 7/ for test: kms_hdmi_inject
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_chamelium_color
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: core_auth
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: intel_hwmon
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_parallel
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_pipe_crc_basic
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: kms_draw_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: kms_rotation_crc
results: parsing output: 50/ for test: syncobj_basic
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: drm_buddy
results: parsing output: 53/ for test: gen7_exec_parse
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_parallel
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: i915_pm_rps
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_plane_cursor
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_getfb
results: parsing output: 79/ for test: kms_atomic_transition
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: i915_selftest
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_partial_pwrite_pread
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_hdr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: gem_lmem_swapping
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_psr_stress_test
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_create
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_media_vme
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_mmap_offset
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_color
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: kms_dp_link_training
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_reloc
results: parsing output: 134/ for test: gem_exec_reloc
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: fbdev
results: parsing output: 137/ for test: kms_pm_rpm
results: parsing output: 138/ for test: gem_ctx_freq
results: parsing output: 139/ for test: gem_exec_balancer
results: parsing output: 140/ for test: gem_render_copy
results: parsing output: 141/ for test: gem_spin_batch
results: parsing output: 142/ for test: i915_hangman
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: sw_sync
results: parsing output: 145/ for test: gem_tiled_swapping
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_big_fb
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_ctx_persistence
results: parsing output: 152/ for test: kms_atomic
results: parsing output: 153/ for test: perf
results: parsing output: 154/ for test: syncobj_basic
results: parsing output: 155/ for test: kms_psr
Done.