[56.464711] Initializing watchdogs
[56.464840]   /dev/watchdog0
[56.481225] [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]
[56.486081] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.488468] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.492293] [001/156] (960s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[56.634207] Starting subtest: 2x-cursor-vs-flip-legacy
[56.638904] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[56.805029] [002/156] (960s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[56.867158] Starting subtest: single-wait-all-for-submit-available-submitted
[56.869549] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[56.969344] [003/156] (960s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[57.062440] Starting subtest: async-flip-with-page-flip-events-linear
[57.451776] Starting dynamic subtest: pipe-A-eDP-1
[60.249555] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s)
[60.625436] Starting dynamic subtest: pipe-B-eDP-1
[63.431897] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.783s)
[63.804099] Starting dynamic subtest: pipe-C-eDP-1
[66.585669] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[66.954071] Starting dynamic subtest: pipe-D-eDP-1
[69.737822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[69.740313] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.549s)
[70.934640] [004/156] (946s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[71.032851] Starting subtest: read-crc-frame-sequence
[71.034781] Starting dynamic subtest: pipe-A-eDP-1
[71.749593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[71.758790] Starting dynamic subtest: pipe-B-eDP-1
[73.143322] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s)
[73.153360] Starting dynamic subtest: pipe-C-eDP-1
[74.530637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[74.539405] Starting dynamic subtest: pipe-D-eDP-1
[75.862825] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[75.865200] Subtest read-crc-frame-sequence: SUCCESS (4.819s)
[76.681937] [005/156] (940s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[76.778380] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[76.782312] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[76.875077] [006/156] (940s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[76.993224] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[95.389271] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.382s)
[96.271409] [007/156] (920s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[96.346209] Starting subtest: invalid-bsd2-flag-on-blt
[96.348780] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[96.448599] [008/156] (920s left) gem_ctx_param (get-priority-new-ctx)
[96.518201] Starting subtest: get-priority-new-ctx
[96.520594] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[96.641244] [009/156] (920s left) gem_exec_params (dr1-dirt)
[96.694184] Starting subtest: DR1-dirt
[96.696625] Subtest DR1-dirt: SUCCESS (0.000s)
[96.793899] [010/156] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[96.908725] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[96.912718] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[97.009800] [011/156] (920s left) gem_render_copy (yf-tiled-ccs-to-linear)
[97.071322] Starting subtest: yf-tiled-ccs-to-linear
[97.075653] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[97.265563] [012/156] (920s left) kms_frontbuffer_tracking (psr-2p-rte)
[97.369389] Starting subtest: psr-2p-rte
[97.374331] Subtest psr-2p-rte: SKIP (0.000s)
[97.464346] [013/156] (919s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[97.555992] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[97.560069] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[97.622206] [014/156] (919s left) kms_psr (fbc-psr-sprite-blt)
[97.718236] Starting subtest: fbc-psr-sprite-blt
[97.720520] Starting dynamic subtest: eDP-1
[97.724737] Dynamic subtest eDP-1: SKIP (0.000s)
[97.728923] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[97.789866] [015/156] (919s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[97.892343] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[97.896425] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[97.996326] [016/156] (919s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[98.087793] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[98.090067] Starting dynamic subtest: pipe-A-eDP-1
[98.112131] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.120553] Starting dynamic subtest: pipe-B-eDP-1
[98.141359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.149386] Starting dynamic subtest: pipe-C-eDP-1
[98.170390] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.178264] Starting dynamic subtest: pipe-D-eDP-1
[98.199797] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.203695] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[100.353724] [017/156] (917s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[100.397024] Starting subtest: multi-wait-all-for-submit-unsubmitted
[100.498361] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[100.574691] [018/156] (917s left) kms_cursor_crc (cursor-random-32x10)
[100.733687] Starting subtest: cursor-random-32x10
[100.781949] Subtest cursor-random-32x10: SKIP (0.046s)
[101.051137] [019/156] (916s left) kms_cursor_edge_walk (128x128-top-edge)
[101.152818] Starting subtest: 128x128-top-edge
[101.155118] Starting dynamic subtest: pipe-A-eDP-1
[104.613234] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[104.622355] Starting dynamic subtest: pipe-D-eDP-1
[107.810770] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.194s)
[107.813188] Subtest 128x128-top-edge: SUCCESS (6.657s)
[108.631194] [020/156] (909s left) gem_reg_read (timestamp-monotonic)
[108.691829] Starting subtest: timestamp-monotonic
[113.209243] Subtest timestamp-monotonic: SUCCESS (4.514s)
[113.280963] [021/156] (904s left) kms_tv_load_detect (load-detect)
[113.342705] Subtest load-detect: SKIP (0.000s)
[113.404389] [022/156] (904s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[113.512725] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[113.516878] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[113.598061] [023/156] (904s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render)
[113.697042] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render
[113.701483] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[113.799326] [024/156] (904s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[113.901800] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[113.906152] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[114.012729] [025/156] (903s left) kms_content_protection (legacy)
[114.146051] Starting subtest: legacy
[114.150574] Subtest legacy: SKIP (0.000s)
[114.269670] [026/156] (903s left) kms_atomic (test-only)
[114.354119] Starting subtest: test-only
[114.403219] Starting dynamic subtest: pipe-A-eDP-1
[116.928062] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.523s)
[116.930433] Subtest test-only: SUCCESS (2.572s)
[117.733834] [027/156] (900s left) gem_exec_flush (basic-wb-pro-default)
[117.799520] Starting subtest: basic-wb-pro-default
[123.256903] Subtest basic-wb-pro-default: SUCCESS (5.458s)
[123.447065] [028/156] (894s left) gem_exec_schedule (wide)
[123.637603] Starting subtest: wide
[123.639606] Starting dynamic subtest: rcs0
[134.576874] Dynamic subtest rcs0: SUCCESS (10.939s)
[134.591117] Starting dynamic subtest: vcs0
[146.570953] Dynamic subtest vcs0: SUCCESS (11.993s)
[146.580262] Starting dynamic subtest: vcs1
[158.274060] Dynamic subtest vcs1: SUCCESS (11.701s)
[158.285824] Starting dynamic subtest: vecs0
[170.049091] Dynamic subtest vecs0: SUCCESS (11.774s)
[170.058432] Starting dynamic subtest: ccs0
[183.075614] Dynamic subtest ccs0: SUCCESS (13.024s)
[183.078612] Subtest wide: SUCCESS (59.435s)
[185.983724] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[185.987270] [029/156] (832s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[186.086844] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[186.091085] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[186.189823] [030/156] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[186.293229] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[193.838435] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.550s)
[193.973819] [031/156] (824s left) gem_request_retire (retire-vma-not-inactive)
[194.038456] Starting subtest: retire-vma-not-inactive
[194.101822] Subtest retire-vma-not-inactive: SUCCESS (0.060s)
[194.225354] [032/156] (823s left) syncobj_timeline (multi-wait-all-available-submitted)
[194.279409] Starting subtest: multi-wait-all-available-submitted
[194.281839] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[194.363990] [033/156] (823s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[196.400149] Starting subtest: dpms-mode-unset-lpsp
[200.467817] Subtest dpms-mode-unset-lpsp: SUCCESS (4.067s)
[200.863626] [034/156] (817s left) kms_cursor_crc (cursor-offscreen-128x42)
[201.099906] Starting subtest: cursor-offscreen-128x42
[201.154285] Subtest cursor-offscreen-128x42: SKIP (0.050s)
[201.366274] [035/156] (816s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[201.469155] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[201.473487] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[201.573142] [036/156] (816s left) kms_scaling_modes (scaling-mode-none)
[201.658924] Starting subtest: scaling-mode-none
[201.661093] Starting dynamic subtest: pipe-A-eDP-1
[201.755430] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[201.767267] Starting dynamic subtest: pipe-B-eDP-1
[201.792428] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[201.801055] Starting dynamic subtest: pipe-C-eDP-1
[201.827376] Dynamic subtest pipe-C-eDP-1: SKIP (0.034s)
[201.837967] Starting dynamic subtest: pipe-D-eDP-1
[201.863567] Dynamic subtest pipe-D-eDP-1: SKIP (0.035s)
[201.867123] Subtest scaling-mode-none: SKIP (0.205s)
[201.986915] [037/156] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[202.094889] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[202.098338] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[202.209967] [038/156] (816s left) kms_hdmi_inject (inject-audio)
[202.565130] Starting subtest: inject-audio
[202.867818] Subtest inject-audio: SUCCESS (0.304s)
[203.415492] [039/156] (815s left) vgem_basic (dmabuf-mmap)
[203.458025] Starting subtest: dmabuf-mmap
[203.488794] Subtest dmabuf-mmap: SUCCESS (0.032s)
[203.572508] [040/156] (814s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[203.675119] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[203.679414] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[203.778266] [041/156] (814s left) gen9_exec_parse (unaligned-jump)
[203.828024] Subtest unaligned-jump: SKIP (0.000s)
[203.891221] [042/156] (814s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[203.988267] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[203.992713] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[204.078457] [043/156] (814s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[204.193465] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[204.197760] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[204.308887] [044/156] (814s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[204.412871] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[204.416420] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[204.509317] [045/156] (814s left) kms_prop_blob (blob-prop-lifetime)
[204.567657] Starting subtest: blob-prop-lifetime
[204.569709] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[204.690363] [046/156] (814s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[204.795394] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[204.799051] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[204.893867] [047/156] (813s left) kms_lease (implicit-plane-lease)
[204.985760] Starting subtest: implicit-plane-lease
[204.987790] Subtest implicit-plane-lease: SUCCESS (0.003s)
[205.096901] [048/156] (813s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[205.197329] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[212.409575] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.214s)
[212.562293] [049/156] (806s left) kms_getfb (getfb-handle-closed)
[212.652365] Starting subtest: getfb-handle-closed
[212.654720] Subtest getfb-handle-closed: SUCCESS (0.000s)
[212.764550] [050/156] (806s left) syncobj_wait (wait-any-interrupted)
[212.822219] Starting subtest: wait-any-interrupted
[212.930993] Subtest wait-any-interrupted: SUCCESS (0.108s)
[213.019371] [051/156] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[213.123488] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[219.650798] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.533s)
[219.762565] [052/156] (799s left) gem_mmap_offset (open-flood)
[219.817215] Starting subtest: open-flood
[241.306822] Subtest open-flood: SUCCESS (21.491s)
[241.431479] [053/156] (777s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[241.542859] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[241.546441] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[241.665949] [054/156] (777s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[241.774772] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[241.778383] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[241.880725] [055/156] (777s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[241.981364] Starting subtest: psrhdr-indfb-scaledprimary
[241.984970] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[242.083135] [056/156] (777s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[242.176266] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[242.178214] Starting dynamic subtest: pipe-A-eDP-1
[242.197574] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.208130] Starting dynamic subtest: pipe-B-eDP-1
[242.225691] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.234610] Starting dynamic subtest: pipe-C-eDP-1
[242.253279] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.261806] Starting dynamic subtest: pipe-D-eDP-1
[242.279900] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.283308] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[244.372044] [057/156] (774s left) gem_exec_reloc (basic-cpu)
[244.424316] Subtest basic-cpu: SKIP (0.000s)
[244.501335] [058/156] (774s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[244.598351] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[244.600611] Starting dynamic subtest: pipe-A-eDP-1
[245.368576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s)
[245.380716] Starting dynamic subtest: pipe-B-eDP-1
[247.180992] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.811s)
[247.190837] Starting dynamic subtest: pipe-C-eDP-1
[248.997215] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.814s)
[249.008414] Starting dynamic subtest: pipe-D-eDP-1
[250.797925] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.798s)
[250.800363] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.193s)
[251.985659] [059/156] (767s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[252.081260] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[252.083619] Starting dynamic subtest: pipe-A-eDP-1
[263.063219] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.986s)
[263.076039] Starting dynamic subtest: pipe-B-eDP-1
[274.761676] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.698s)
[274.764080] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.686s)
[275.588098] [060/156] (743s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[275.691639] Starting subtest: extended-pageflip-modeset-hang-oldfb
[275.694251] Starting dynamic subtest: pipe-A
[283.600888] Dynamic subtest pipe-A: SUCCESS (7.909s)
[283.611035] Starting dynamic subtest: pipe-D
[292.255690] Dynamic subtest pipe-D: SUCCESS (8.652s)
[292.257962] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.565s)
[293.077710] [061/156] (726s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[293.192878] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[293.197796] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[293.294323] [062/156] (726s left) gem_workarounds (suspend-resume-fd)
[293.350612] Starting subtest: suspend-resume-fd
[308.788101] Subtest suspend-resume-fd: SUCCESS (1.284s)
[309.932283] [063/156] (710s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[310.058436] Starting subtest: 4-tiled-64bpp-rotate-270
[310.079774] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[310.200791] [064/156] (710s left) kms_dsc (dsc-with-output-formats-with-bpc)
[310.295015] Starting subtest: dsc-with-output-formats-with-bpc
[310.354255] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[310.397326] [065/156] (710s left) dmabuf (all-tests)
[310.433228] Starting subtest: all-tests
[310.437408] Subtest all-tests: SKIP (0.000s)
[310.494183] [066/156] (710s left) i915_suspend (fence-restore-tiled2untiled)
[310.547757] Starting subtest: fence-restore-tiled2untiled
[310.552277] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[310.655141] [067/156] (710s left) gen9_exec_parse (allowed-single)
[310.718299] Subtest allowed-single: SKIP (0.000s)
[310.785284] [068/156] (709s left) gem_exec_schedule (preempt-contexts)
[310.862137] Starting subtest: preempt-contexts
[310.864776] Starting dynamic subtest: rcs0
[310.911039] Dynamic subtest rcs0: SUCCESS (0.056s)
[310.921835] Starting dynamic subtest: bcs0
[310.967652] Dynamic subtest bcs0: SUCCESS (0.054s)
[310.980029] Starting dynamic subtest: vcs0
[311.023629] Dynamic subtest vcs0: SUCCESS (0.053s)
[311.033489] Starting dynamic subtest: vcs1
[311.069894] Dynamic subtest vcs1: SUCCESS (0.044s)
[311.080248] Starting dynamic subtest: vecs0
[311.112846] Dynamic subtest vecs0: SUCCESS (0.041s)
[311.123021] Starting dynamic subtest: ccs0
[311.157677] Dynamic subtest ccs0: SUCCESS (0.042s)
[311.159621] Subtest preempt-contexts: SUCCESS (0.295s)
[312.487752] [069/156] (708s left) sysfs_timeslice_duration (idempotent)
[312.552335] Starting subtest: idempotent
[312.554631] Starting dynamic subtest: vecs0
[312.557155] Dynamic subtest vecs0: SUCCESS (0.000s)
[312.567322] Starting dynamic subtest: ccs0
[312.569643] Dynamic subtest ccs0: SUCCESS (0.000s)
[312.579337] Starting dynamic subtest: vcs0
[312.581592] Dynamic subtest vcs0: SUCCESS (0.000s)
[312.593816] Starting dynamic subtest: bcs0
[312.595752] Dynamic subtest bcs0: SUCCESS (0.000s)
[312.605933] Starting dynamic subtest: rcs0
[312.608251] Dynamic subtest rcs0: SUCCESS (0.000s)
[312.618419] Starting dynamic subtest: vcs1
[312.620760] Dynamic subtest vcs1: SUCCESS (0.000s)
[312.622989] Subtest idempotent: SUCCESS (0.006s)
[312.663659] [070/156] (708s left) gem_close_race (multigpu-basic-threads)
[312.730270] Starting subtest: multigpu-basic-threads
[312.734993] Subtest multigpu-basic-threads: SKIP (0.000s)
[312.975017] [071/156] (707s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)
[313.078461] Starting subtest: hdr-rgb565-draw-mmap-cpu
[313.083171] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[313.201123] [072/156] (707s left) gem_lmem_swapping (parallel-random-engines)
[313.245189] Subtest parallel-random-engines: SKIP (0.000s)
[313.288139] [073/156] (707s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[313.683509] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[314.511934] [074/156] (706s left) gem_exec_schedule (semaphore-noskip)
[314.583823] Starting subtest: semaphore-noskip
[315.017910] Subtest semaphore-noskip: SUCCESS (0.432s)
[315.343771] [075/156] (705s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[315.443408] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[315.447897] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[315.539813] [076/156] (705s left) gem_exec_balancer (nop)
[315.595538] Starting subtest: nop
[362.329508] Subtest nop: SUCCESS (46.595s)
[362.638478] [077/156] (658s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[362.737497] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[362.741966] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[362.830922] [078/156] (658s left) perf (blocking-parameterized)
[362.950335] Starting subtest: blocking-parameterized
[382.976017] Subtest blocking-parameterized: SUCCESS (20.016s)
[383.026848] [079/156] (638s left) kms_dp_aux_dev (basic)
[383.087603] Starting subtest: basic
[383.312501] Subtest basic: SUCCESS (0.225s)
[383.386499] [080/156] (637s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[383.490586] Starting subtest: fbchdr-rgb565-draw-pwrite
[383.494778] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[383.587918] [081/156] (637s left) kms_flip (dpms-off-confusion-interruptible)
[383.678942] Starting subtest: dpms-off-confusion-interruptible
[383.681288] Starting dynamic subtest: A-eDP1
[392.358948] Dynamic subtest A-eDP1: SUCCESS (8.674s)
[392.371342] Starting dynamic subtest: B-eDP1
[401.062695] Dynamic subtest B-eDP1: SUCCESS (8.699s)
[401.076551] Starting dynamic subtest: C-eDP1
[409.760865] Dynamic subtest C-eDP1: SUCCESS (8.696s)
[409.773581] Starting dynamic subtest: D-eDP1
[418.455748] Dynamic subtest D-eDP1: SUCCESS (8.695s)
[418.461094] Subtest dpms-off-confusion-interruptible: SUCCESS (34.774s)
[419.691736] [082/156] (601s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[419.787742] Starting subtest: 2x-flip-vs-rmfb-interruptible
[419.800311] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[419.906774] [083/156] (601s left) kms_universal_plane (disable-primary-vs-flip)
[419.999880] Starting subtest: disable-primary-vs-flip
[420.002191] Starting dynamic subtest: pipe-A-eDP-1
[421.559745] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.560s)
[421.570738] Starting dynamic subtest: pipe-B-eDP-1
[423.758192] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.197s)
[423.768924] Starting dynamic subtest: pipe-C-eDP-1
[425.935292] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.176s)
[425.946729] Starting dynamic subtest: pipe-D-eDP-1
[428.134325] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.196s)
[428.136498] Subtest disable-primary-vs-flip: SUCCESS (8.135s)
[428.992078] [084/156] (592s left) prime_vgem (busy)
[429.066235] Starting subtest: busy
[429.068536] Starting dynamic subtest: rcs0
[429.136498] Dynamic subtest rcs0: SUCCESS (0.070s)
[429.148167] Starting dynamic subtest: bcs0
[429.196553] Dynamic subtest bcs0: SUCCESS (0.059s)
[429.206733] Starting dynamic subtest: vcs0
[429.243393] Dynamic subtest vcs0: SUCCESS (0.046s)
[429.253623] Starting dynamic subtest: vcs1
[429.290748] Dynamic subtest vcs1: SUCCESS (0.045s)
[429.300577] Starting dynamic subtest: vecs0
[429.336014] Dynamic subtest vecs0: SUCCESS (0.044s)
[429.345392] Starting dynamic subtest: ccs0
[429.382356] Dynamic subtest ccs0: SUCCESS (0.045s)
[429.384682] Subtest busy: SUCCESS (0.317s)
[429.501377] [085/156] (591s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[429.596441] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[429.601053] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[429.708650] [086/156] (591s left) kms_pm_backlight (brightness-with-dpms)
[429.797028] Starting subtest: brightness-with-dpms
[429.845579] Starting dynamic subtest: eDP-1
[432.283882] Dynamic subtest eDP-1: SUCCESS (2.435s)
[432.286385] Subtest brightness-with-dpms: SUCCESS (2.486s)
[433.093054] [087/156] (588s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[433.160576] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[433.266015] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[433.345317] [088/156] (588s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[433.437440] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[433.439377] Starting dynamic subtest: A-eDP1
[437.128889] Dynamic subtest A-eDP1: SUCCESS (3.691s)
[437.139724] Starting dynamic subtest: B-eDP1
[440.413034] Dynamic subtest B-eDP1: SUCCESS (3.283s)
[440.424713] Starting dynamic subtest: C-eDP1
[443.719023] Dynamic subtest C-eDP1: SUCCESS (3.305s)
[443.730550] Starting dynamic subtest: D-eDP1
[447.028848] Dynamic subtest D-eDP1: SUCCESS (3.307s)
[447.031196] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.595s)
[447.887104] [089/156] (573s left) kms_prop_blob (invalid-set-prop-any)
[447.946501] Starting subtest: invalid-set-prop-any
[447.948596] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[448.032859] [090/156] (573s left) kms_rotation_crc (primary-rotation-180)
[448.133731] Starting subtest: primary-rotation-180
[455.159634] Subtest primary-rotation-180: SUCCESS (7.027s)
[456.398676] [091/156] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[456.496785] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[456.500906] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[456.596367] [092/156] (565s left) gem_mmap_wc (close)
[456.648803] Subtest close: SKIP (0.000s)
[456.707007] [093/156] (565s left) kms_addfb_basic (unused-handle)
[456.760081] Starting subtest: unused-handle
[456.761952] Subtest unused-handle: SUCCESS (0.000s)
[456.901498] [094/156] (564s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[456.997867] Starting subtest: fbcpsr-tiling-y
[457.002243] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[457.104964] [095/156] (564s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[457.203609] Starting subtest: fbc-indfb-scaledprimary
[460.094972] Subtest fbc-indfb-scaledprimary: SUCCESS (2.897s)
[461.291148] [096/156] (560s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[461.415006] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[472.596164] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.178s)
[473.487066] [097/156] (548s left) i915_pciid
[473.645389] [098/156] (548s left) gem_userptr_blits (nohangcheck)
[473.711517] Starting subtest: nohangcheck
[473.970258] Subtest nohangcheck: SUCCESS (0.255s)
[474.098924] [099/156] (547s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[474.202360] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[474.206362] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[474.322170] [100/156] (547s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[474.417445] Starting subtest: flip-vs-dpms-on-nop-interruptible
[474.419742] Starting dynamic subtest: A-eDP1
[476.247350] Dynamic subtest A-eDP1: SUCCESS (1.827s)
[476.259760] Starting dynamic subtest: B-eDP1
[478.062875] Dynamic subtest B-eDP1: SUCCESS (1.814s)
[478.078153] Starting dynamic subtest: C-eDP1
[479.940868] Dynamic subtest C-eDP1: SUCCESS (1.874s)
[479.959057] Starting dynamic subtest: D-eDP1
[481.740918] Dynamic subtest D-eDP1: SUCCESS (1.797s)
[481.743380] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.324s)
[482.992781] [101/156] (539s left) kms_color (degamma)
[483.093742] Starting subtest: degamma
[483.095825] Starting dynamic subtest: pipe-A-eDP-1
[483.813949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[483.824076] Starting dynamic subtest: pipe-B-eDP-1
[485.280795] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.468s)
[485.291485] Starting dynamic subtest: pipe-C-eDP-1
[486.639129] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.354s)
[486.649433] Starting dynamic subtest: pipe-D-eDP-1
[488.041378] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[488.043861] Subtest degamma: SUCCESS (4.949s)
[488.895662] [102/156] (533s left) kms_rotation_crc (cursor-rotation-180)
[488.989297] Starting subtest: cursor-rotation-180
[490.539436] Subtest cursor-rotation-180: SUCCESS (1.550s)
[491.787360] [103/156] (530s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[491.890879] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[495.994734] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.108s)
[497.200096] [104/156] (525s left) gem_ctx_persistence (engines-cleanup)
[497.264309] Starting subtest: engines-cleanup
[497.266652] Starting dynamic subtest: rcs0
[497.343977] Dynamic subtest rcs0: SUCCESS (0.079s)
[497.358104] Starting dynamic subtest: bcs0
[497.390420] Dynamic subtest bcs0: SUCCESS (0.044s)
[497.401527] Starting dynamic subtest: vcs0
[497.438757] Dynamic subtest vcs0: SUCCESS (0.046s)
[497.450571] Starting dynamic subtest: vcs1
[497.481687] Dynamic subtest vcs1: SUCCESS (0.041s)
[497.492524] Starting dynamic subtest: vecs0
[497.518430] Dynamic subtest vecs0: SUCCESS (0.035s)
[497.528438] Starting dynamic subtest: ccs0
[497.564191] Dynamic subtest ccs0: SUCCESS (0.044s)
[497.566561] Subtest engines-cleanup: SUCCESS (0.301s)
[497.645587] [105/156] (524s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[497.757673] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[497.762026] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[497.858045] [106/156] (524s left) kms_vblank (ts-continuation-modeset)
[497.954853] Starting subtest: ts-continuation-modeset
[497.956743] Starting dynamic subtest: pipe-A-eDP-1
[499.520800] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.563s)
[499.538302] Starting dynamic subtest: pipe-D-eDP-1
[501.734728] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.212s)
[501.736892] Subtest ts-continuation-modeset: SUCCESS (3.779s)
[502.593541] [107/156] (519s left) kms_psr (fbc-pr-primary-blt)
[502.684177] Starting subtest: fbc-pr-primary-blt
[502.688375] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[502.770284] [108/156] (519s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[502.861303] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[502.865357] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[502.958155] [109/156] (519s left) kms_plane_scaling (planes-downscale-factor-0-75)
[503.044125] Starting subtest: planes-downscale-factor-0-75
[503.046569] Starting dynamic subtest: pipe-A
[503.069519] Dynamic subtest pipe-A: SKIP (0.020s)
[503.081362] Starting dynamic subtest: pipe-B
[503.104963] Dynamic subtest pipe-B: SKIP (0.035s)
[503.117261] Starting dynamic subtest: pipe-C
[503.140791] Dynamic subtest pipe-C: SKIP (0.035s)
[503.152478] Starting dynamic subtest: pipe-D
[503.175540] Dynamic subtest pipe-D: SKIP (0.035s)
[503.179865] Subtest planes-downscale-factor-0-75: SKIP (0.129s)
[503.290488] [110/156] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[503.404557] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[510.277107] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.875s)
[510.404672] [111/156] (512s left) perf (non-sampling-read-error)
[510.505326] Starting subtest: non-sampling-read-error
[510.513988] Subtest non-sampling-read-error: SUCCESS (0.007s)
[510.555574] [112/156] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[510.656997] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[510.660940] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[510.771787] [113/156] (511s left) syncobj_timeline (multi-wait-submitted-signaled)
[510.829106] Starting subtest: multi-wait-submitted-signaled
[510.831403] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[510.949483] [114/156] (511s left) syncobj_wait (wait-for-submit-delayed-submit)
[511.010576] Starting subtest: wait-for-submit-delayed-submit
[511.114462] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[511.193436] [115/156] (511s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[511.299289] Starting subtest: y-tiled-64bpp-rotate-270
[511.303749] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[511.412568] [116/156] (511s left) kms_flip (flip-vs-panning)
[511.513008] Starting subtest: flip-vs-panning
[511.515329] Starting dynamic subtest: A-eDP1
[520.278155] Dynamic subtest A-eDP1: SUCCESS (8.762s)
[520.288923] Starting dynamic subtest: B-eDP1
[528.978213] Dynamic subtest B-eDP1: SUCCESS (8.695s)
[528.990181] Starting dynamic subtest: C-eDP1
[537.666821] Dynamic subtest C-eDP1: SUCCESS (8.687s)
[537.678487] Starting dynamic subtest: D-eDP1
[546.361799] Dynamic subtest D-eDP1: SUCCESS (8.697s)
[546.366255] Subtest flip-vs-panning: SUCCESS (34.851s)
[547.594403] [117/156] (475s left) gem_exec_reloc (basic-wc-cpu)
[547.664172] Subtest basic-wc-cpu: SKIP (0.000s)
[547.733453] [118/156] (475s left) gem_userptr_blits (readonly-unsync)
[547.792580] Subtest readonly-unsync: SKIP (0.000s)
[547.912764] [119/156] (474s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[548.014403] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[548.019045] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[549.197774] [120/156] (473s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[549.295362] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[549.299411] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[549.403300] [121/156] (473s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[549.496564] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[549.498932] Starting dynamic subtest: pipe-A-eDP-1
[549.508231] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[549.519978] Starting dynamic subtest: pipe-B-eDP-1
[549.529184] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[549.539541] Starting dynamic subtest: pipe-C-eDP-1
[549.548268] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[549.558571] Starting dynamic subtest: pipe-D-eDP-1
[549.567347] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[549.571763] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[551.795752] [122/156] (471s left) gem_ctx_shared (q-promotion)
[551.862523] Starting subtest: Q-promotion
[551.865046] Starting dynamic subtest: rcs0
[551.979334] Dynamic subtest rcs0: SUCCESS (0.115s)
[551.997962] Starting dynamic subtest: vcs0
[552.076441] Dynamic subtest vcs0: SUCCESS (0.097s)
[552.092667] Starting dynamic subtest: vcs1
[552.157833] Dynamic subtest vcs1: SUCCESS (0.079s)
[552.176075] Starting dynamic subtest: vecs0
[552.240028] Dynamic subtest vecs0: SUCCESS (0.081s)
[552.258221] Starting dynamic subtest: ccs0
[552.321325] Dynamic subtest ccs0: SUCCESS (0.080s)
[552.323952] Subtest Q-promotion: SUCCESS (0.459s)
[553.576667] [123/156] (469s left) gem_exec_fence (basic-busy-all)
[553.636050] Starting subtest: basic-busy-all
[553.730310] Subtest basic-busy-all: SUCCESS (0.095s)
[555.548567] [124/156] (467s left) gem_exec_schedule (fairslice)
[555.619819] Starting subtest: fairslice
[555.621793] Starting dynamic subtest: rcs0
[557.648208] Dynamic subtest rcs0: SUCCESS (2.031s)
[557.660008] Starting dynamic subtest: bcs0
[559.671211] Dynamic subtest bcs0: SUCCESS (2.023s)
[559.681487] Starting dynamic subtest: vcs0
[561.690672] Dynamic subtest vcs0: SUCCESS (2.019s)
[561.702388] Starting dynamic subtest: vcs1
[563.713032] Dynamic subtest vcs1: SUCCESS (2.020s)
[563.727913] Starting dynamic subtest: vecs0
[565.728896] Dynamic subtest vecs0: SUCCESS (2.017s)
[565.744384] Starting dynamic subtest: ccs0
[567.751583] Dynamic subtest ccs0: SUCCESS (2.022s)
[567.753799] Subtest fairslice: SUCCESS (12.137s)
[568.068865] [125/156] (455s left) kms_plane_multiple (2x-tiling-x)
[568.168764] Starting subtest: 2x-tiling-x
[568.172857] Subtest 2x-tiling-x: SKIP (0.000s)
[568.241735] [126/156] (454s left) api_intel_bb (crc32)
[568.295984] Starting subtest: crc32
[568.298334] Starting dynamic subtest: rcs0-smem0
[568.585031] Dynamic subtest rcs0-smem0: SUCCESS (0.289s)
[568.595795] Starting dynamic subtest: bcs0-smem0
[568.911994] Dynamic subtest bcs0-smem0: SUCCESS (0.324s)
[568.924760] Starting dynamic subtest: vcs0-smem0
[569.260393] Dynamic subtest vcs0-smem0: SUCCESS (0.347s)
[569.274863] Starting dynamic subtest: vcs1-smem0
[569.622858] Dynamic subtest vcs1-smem0: SUCCESS (0.359s)
[569.638207] Starting dynamic subtest: vecs0-smem0
[569.971309] Dynamic subtest vecs0-smem0: SUCCESS (0.345s)
[569.983676] Starting dynamic subtest: ccs0-smem0
[570.317192] Dynamic subtest ccs0-smem0: SUCCESS (0.343s)
[570.320269] Subtest crc32: SUCCESS (2.024s)
[570.451945] [127/156] (452s left) kms_psr (psr2-sprite-mmap-gtt)
[570.556749] Starting subtest: psr2-sprite-mmap-gtt
[570.559202] Starting dynamic subtest: eDP-1
[571.953316] Dynamic subtest eDP-1: SKIP (1.394s)
[571.958229] Subtest psr2-sprite-mmap-gtt: SKIP (1.396s)
[572.095604] [128/156] (451s left) kms_big_fb (linear-32bpp-rotate-270)
[572.196604] Starting subtest: linear-32bpp-rotate-270
[572.216625] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[572.334461] [129/156] (450s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[572.392289] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[572.498172] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[572.579259] [130/156] (450s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[572.666618] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[572.670996] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[572.754178] [131/156] (450s left) gem_exec_fence (syncobj-invalid-flags)
[573.172050] Starting subtest: syncobj-invalid-flags
[573.174525] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[574.551677] [132/156] (448s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[574.607025] Subtest tiled-to-tiled: SKIP (0.000s)
[574.677583] [133/156] (448s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[574.780800] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[574.784948] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[574.878205] [134/156] (448s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[574.983586] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[574.988016] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[575.094408] [135/156] (448s left) gem_busy (parallel)
[575.280370] Starting subtest: parallel
[575.282940] Starting dynamic subtest: rcs0
[576.454289] Dynamic subtest rcs0: SUCCESS (1.172s)
[576.467974] Starting dynamic subtest: bcs0
[578.438526] Dynamic subtest bcs0: SUCCESS (1.981s)
[578.450975] Starting dynamic subtest: vcs0
[580.421225] Dynamic subtest vcs0: SUCCESS (1.980s)
[580.434645] Starting dynamic subtest: vcs1
[582.470256] Dynamic subtest vcs1: SUCCESS (2.046s)
[582.485389] Starting dynamic subtest: vecs0
[584.454468] Dynamic subtest vecs0: SUCCESS (1.981s)
[584.468511] Starting dynamic subtest: ccs0
[586.438619] Dynamic subtest ccs0: SUCCESS (1.981s)
[586.441911] Subtest parallel: SUCCESS (11.159s)
[586.669928] [136/156] (436s left) kms_psr (pr-primary-blt)
[586.764671] Starting subtest: pr-primary-blt
[586.769124] Subtest pr-primary-blt: SKIP (0.000s)
[586.853145] [137/156] (436s left) gem_exec_reloc (basic-gtt-wc)
[586.906255] Subtest basic-gtt-wc: SKIP (0.000s)
[586.990658] [138/156] (436s left) gem_spin_batch (engines)
[587.052057] Starting subtest: engines
[587.054300] Starting dynamic subtest: rcs0
[590.291901] Dynamic subtest rcs0: SUCCESS (3.235s)
[590.304387] Starting dynamic subtest: bcs0
[593.531683] Dynamic subtest bcs0: SUCCESS (3.235s)
[593.548098] Starting dynamic subtest: vcs0
[596.769658] Dynamic subtest vcs0: SUCCESS (3.236s)
[596.782344] Starting dynamic subtest: vcs1
[600.006931] Dynamic subtest vcs1: SUCCESS (3.234s)
[600.019281] Starting dynamic subtest: vecs0
[603.247382] Dynamic subtest vecs0: SUCCESS (3.238s)
[603.259719] Starting dynamic subtest: ccs0
[606.483442] Dynamic subtest ccs0: SUCCESS (3.233s)
[606.486064] Subtest engines: SUCCESS (19.428s)
[606.723407] [139/156] (417s left) gem_exec_fence (invalid-fence-array)
[607.150799] Starting subtest: invalid-fence-array
[607.152951] Subtest invalid-fence-array: SUCCESS (0.003s)
[608.541966] [140/156] (415s left) kms_hdr (bpc-switch-dpms)
[608.632735] Starting subtest: bpc-switch-dpms
[608.635035] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[614.224743] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.593s)
[614.236450] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[619.825447] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.598s)
[619.827939] Subtest bpc-switch-dpms: SUCCESS (11.194s)
[619.949368] [141/156] (403s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[620.017157] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[620.021901] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[620.202892] [142/156] (403s left) gem_ppgtt (shrink-vs-evict-any)
[620.265207] Starting subtest: shrink-vs-evict-any
[625.433370] Subtest shrink-vs-evict-any: SUCCESS (5.169s)
[625.514974] [143/156] (398s left) i915_pm_rc6_residency (rc6-idle)
[625.580551] Starting subtest: rc6-idle
[625.613479] Starting dynamic subtest: gt0-rcs0
[649.824892] Dynamic subtest gt0-rcs0: SUCCESS (24.208s)
[649.837733] Starting dynamic subtest: gt0-bcs0
[674.107635] Dynamic subtest gt0-bcs0: SUCCESS (24.277s)
[674.120768] Starting dynamic subtest: gt0-ccs0
[698.479262] Dynamic subtest gt0-ccs0: SUCCESS (24.366s)
[698.489942] Starting dynamic subtest: gt1-vcs0
[704.655775] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[704.668879] Starting dynamic subtest: gt1-vecs0
[710.828783] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[710.831483] Subtest rc6-idle: SUCCESS (85.237s)
[710.911560] [144/156] (313s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[711.013863] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[711.018211] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[711.110002] [145/156] (312s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[711.210042] Starting subtest: yf-tiled-16bpp-rotate-270
[711.214508] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[711.322651] [146/156] (312s left) gem_ctx_persistence (saturated-hostile)
[711.385886] Starting subtest: saturated-hostile
[711.387897] Starting dynamic subtest: rcs0
[712.204752] Dynamic subtest rcs0: SUCCESS (0.820s)
[712.221391] Starting dynamic subtest: bcs0
[712.994986] Dynamic subtest bcs0: SUCCESS (0.787s)
[713.008565] Starting dynamic subtest: vcs0
[713.791501] Dynamic subtest vcs0: SUCCESS (0.794s)
[713.804091] Starting dynamic subtest: vcs1
[714.586897] Dynamic subtest vcs1: SUCCESS (0.793s)
[714.600408] Starting dynamic subtest: vecs0
[715.382901] Dynamic subtest vecs0: SUCCESS (0.794s)
[715.396745] Starting dynamic subtest: ccs0
[716.219220] Dynamic subtest ccs0: SUCCESS (0.835s)
[716.222024] Subtest saturated-hostile: SUCCESS (4.835s)
[716.304002] [147/156] (307s left) kms_chamelium_edid (dp-edid-resolution-list)
[716.690581] Subtest dp-edid-resolution-list: SKIP (0.000s)
[717.482448] [148/156] (306s left) api_intel_bb (object-noreloc-keep-cache-simple)
[717.533318] Starting subtest: object-noreloc-keep-cache-simple
[717.535550] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[717.661781] [149/156] (306s left) i915_query (query-topology-kernel-writes)
[717.723384] Starting subtest: query-topology-kernel-writes
[717.725300] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[717.844130] [150/156] (306s left) gem_exec_flush (basic-batch-kernel-default-uc)
[717.900519] Starting subtest: basic-batch-kernel-default-uc
[725.448872] Subtest basic-batch-kernel-default-uc: SUCCESS (7.547s)
[725.640454] [151/156] (298s left) kms_lease (possible-crtcs-filtering)
[725.734348] Starting subtest: possible-crtcs-filtering
[725.740340] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[725.872820] [152/156] (298s left) kms_psr (fbc-psr2-cursor-blt)
[725.977885] Starting subtest: fbc-psr2-cursor-blt
[725.979764] Starting dynamic subtest: eDP-1
[725.983739] Dynamic subtest eDP-1: SKIP (0.000s)
[725.987943] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[726.062768] [153/156] (298s left) gem_mmap_gtt (cpuset-big-copy-odd)
[726.113416] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[726.174246] [154/156] (298s left) gem_ctx_param (invalid-ctx-get)
[726.217429] Starting subtest: invalid-ctx-get
[726.219758] Subtest invalid-ctx-get: SUCCESS (0.000s)
[726.285320] [155/156] (298s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[726.347877] Subtest no-spare-fences-busy: SKIP (0.000s)
[726.423802] [156/156] (298s left) perf_pmu (render-node-busy)
[726.489822] Starting subtest: render-node-busy
[726.492239] Starting dynamic subtest: rcs0
[727.082308] Dynamic subtest rcs0: SUCCESS (0.592s)
[727.095060] Starting dynamic subtest: bcs0
[727.654424] Dynamic subtest bcs0: SUCCESS (0.570s)
[727.667986] Starting dynamic subtest: vcs0
[729.479374] Dynamic subtest vcs0: SUCCESS (1.819s)
[729.491718] Starting dynamic subtest: vcs1
[731.462430] Dynamic subtest vcs1: SUCCESS (1.981s)
[731.476330] Starting dynamic subtest: vecs0
[733.446110] Dynamic subtest vecs0: SUCCESS (1.980s)
[733.459408] Starting dynamic subtest: ccs0
[734.012907] Dynamic subtest ccs0: SUCCESS (0.566s)
[734.015332] Subtest render-node-busy: SUCCESS (7.523s)
[734.088481] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: kms_pipe_crc_basic
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_ctx_param
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_cursor_edge_walk
results: parsing output: 19/ for test: gem_reg_read
results: parsing output: 20/ for test: kms_tv_load_detect
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_content_protection
results: parsing output: 25/ for test: kms_atomic
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_request_retire
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_scaling_modes
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_hdmi_inject
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gen9_exec_parse
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_prop_blob
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_getfb
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_busy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_workarounds
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: dmabuf
results: parsing output: 65/ for test: i915_suspend
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: sysfs_timeslice_duration
results: parsing output: 69/ for test: gem_close_race
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_lmem_swapping
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: kms_dp_aux_dev
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_universal_plane
results: parsing output: 83/ for test: prime_vgem
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_pm_backlight
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_prop_blob
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: kms_addfb_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: i915_pciid
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_color
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_ctx_shared
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_plane_multiple
results: parsing output: 125/ for test: api_intel_bb
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: gem_set_tiling_vs_blt
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_busy
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: gem_exec_reloc
results: parsing output: 137/ for test: gem_spin_batch
results: parsing output: 138/ for test: gem_exec_fence
results: parsing output: 139/ for test: kms_hdr
results: parsing output: 140/ for test: gem_render_copy
results: parsing output: 141/ for test: gem_ppgtt
results: parsing output: 142/ for test: i915_pm_rc6_residency
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: gem_ctx_persistence
results: parsing output: 146/ for test: kms_chamelium_edid
results: parsing output: 147/ for test: api_intel_bb
results: parsing output: 148/ for test: i915_query
results: parsing output: 149/ for test: gem_exec_flush
results: parsing output: 150/ for test: kms_lease
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: gem_mmap_gtt
results: parsing output: 153/ for test: gem_ctx_param
results: parsing output: 154/ for test: gem_fenced_exec_thrash
results: parsing output: 155/ for test: perf_pmu
Done.