[58.902622] Initializing watchdogs
[58.902670]   /dev/watchdog0
[58.917502] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.921960] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.924542] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.926822] [001/132] (960s left) gem_ctx_exec (basic)
[58.982992] Starting subtest: basic
[58.991985] Subtest basic: SUCCESS (0.009s)
[59.095653] [002/132] (960s left) syncobj_wait (wait-delayed-signal)
[59.144875] Starting subtest: wait-delayed-signal
[59.248058] Subtest wait-delayed-signal: SUCCESS (0.102s)
[59.317410] [003/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[59.417507] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[63.857538] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.428s)
[64.990109] [004/132] (954s left) kms_chamelium_audio (dp-audio)
[65.378010] Subtest dp-audio: SKIP (0.000s)
[66.193686] [005/132] (953s left) gem_exec_flush (basic-wb-ro-before-default)
[66.244048] Starting subtest: basic-wb-ro-before-default
[71.703636] Subtest basic-wb-ro-before-default: SUCCESS (5.453s)
[71.881257] [006/132] (947s left) gem_exec_balancer (sliced)
[71.940068] Starting subtest: sliced
[71.941960] Subtest sliced: SKIP (0.000s)
[72.225388] [007/132] (947s left) perf_pmu (busy-hang)
[72.264807] Starting subtest: busy-hang
[72.265975] Starting dynamic subtest: rcs0
[73.519558] Dynamic subtest rcs0: SUCCESS (1.254s)
[73.534212] Starting dynamic subtest: bcs0
[74.731593] Dynamic subtest bcs0: SUCCESS (1.211s)
[74.740540] Starting dynamic subtest: vcs0
[76.441613] Dynamic subtest vcs0: SUCCESS (1.707s)
[76.451213] Starting dynamic subtest: vcs1
[78.429755] Dynamic subtest vcs1: SUCCESS (1.986s)
[78.437284] Starting dynamic subtest: vecs0
[80.408349] Dynamic subtest vecs0: SUCCESS (1.978s)
[80.416227] Starting dynamic subtest: ccs0
[81.613502] Dynamic subtest ccs0: SUCCESS (1.203s)
[81.614557] Subtest busy-hang: SUCCESS (9.346s)
[81.705474] [008/132] (937s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[81.801381] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[81.803093] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[81.884586] [009/132] (937s left) syncobj_wait (invalid-signal-zero-handles)
[81.943797] Starting subtest: invalid-signal-zero-handles
[81.944725] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[82.055583] [010/132] (937s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[82.132049] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[82.133685] Starting dynamic subtest: pipe-A
[82.153277] Dynamic subtest pipe-A: SKIP (0.019s)
[82.164734] Starting dynamic subtest: pipe-B
[82.189879] Dynamic subtest pipe-B: SKIP (0.037s)
[82.196736] Starting dynamic subtest: pipe-C
[82.227813] Dynamic subtest pipe-C: SKIP (0.038s)
[82.238591] Starting dynamic subtest: pipe-D
[82.265055] Dynamic subtest pipe-D: SKIP (0.037s)
[82.266662] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.131s)
[82.358397] [011/132] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[82.441222] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[87.047255] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.606s)
[88.243855] [012/132] (931s left) gem_unfence_active_buffers
[88.388009] [013/132] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[88.469851] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[88.471577] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.557036] [014/132] (931s left) perf_pmu (interrupts-sync)
[88.601423] Starting subtest: interrupts-sync
[89.703254] Subtest interrupts-sync: SUCCESS (1.092s)
[89.828099] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[89.829824] [015/132] (930s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[89.914577] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[89.916541] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[89.983155] [016/132] (929s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[90.084945] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[90.787779] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.703s)
[90.948009] [017/132] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[91.036601] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[97.876126] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.839s)
[98.006432] [018/132] (921s left) gen9_exec_parse (allowed-single)
[98.065724] Subtest allowed-single: SKIP (0.000s)
[98.133927] [019/132] (921s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[98.212143] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[98.214060] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[98.292326] [020/132] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[98.383336] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[98.384962] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[98.497324] [021/132] (921s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[98.549827] Starting subtest: etime-single-wait-all-for-submit-submitted
[98.667831] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.109s)
[98.725754] [022/132] (921s left) vgem_basic (dmabuf-fence)
[98.763150] Starting subtest: dmabuf-fence
[98.763987] Subtest dmabuf-fence: SUCCESS (0.001s)
[98.821129] [023/132] (921s left) gem_wait (write-busy)
[98.875939] Starting subtest: write-busy
[98.876918] Starting dynamic subtest: all-engines
[99.463811] Dynamic subtest all-engines: SUCCESS (0.587s)
[99.477526] Starting dynamic subtest: rcs0
[100.012190] Dynamic subtest rcs0: SUCCESS (0.548s)
[100.026717] Starting dynamic subtest: bcs0
[100.570621] Dynamic subtest bcs0: SUCCESS (0.558s)
[100.585651] Starting dynamic subtest: vcs0
[101.920421] Dynamic subtest vcs0: SUCCESS (1.338s)
[101.929943] Starting dynamic subtest: vcs1
[103.905704] Dynamic subtest vcs1: SUCCESS (1.982s)
[103.915046] Starting dynamic subtest: vecs0
[105.888313] Dynamic subtest vecs0: SUCCESS (1.982s)
[105.898880] Starting dynamic subtest: ccs0
[106.428048] Dynamic subtest ccs0: SUCCESS (0.549s)
[106.429322] Subtest write-busy: SUCCESS (7.551s)
[106.620720] [024/132] (913s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[106.707860] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[106.708871] Starting dynamic subtest: pipe-A-eDP-1
[106.717808] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.726033] Starting dynamic subtest: pipe-B-eDP-1
[106.734622] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.741548] Starting dynamic subtest: pipe-C-eDP-1
[106.749678] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.756576] Starting dynamic subtest: pipe-D-eDP-1
[106.764664] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.766325] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[109.031461] [025/132] (911s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[109.110254] Starting subtest: modeset-transition-nonblocking-fencing
[109.111175] Starting dynamic subtest: 1x-outputs
[120.141369] Dynamic subtest 1x-outputs: SUCCESS (11.029s)
[120.142910] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.030s)
[121.003539] [026/132] (899s left) kms_psr (pr-primary-blt)
[121.093227] Starting subtest: pr-primary-blt
[121.094986] Subtest pr-primary-blt: SKIP (0.000s)
[121.163404] [027/132] (899s left) kms_atomic_transition (plane-all-transition-fencing)
[121.242221] Starting subtest: plane-all-transition-fencing
[121.243207] Starting dynamic subtest: pipe-A-eDP-1
[123.740958] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[124.043439] Starting dynamic subtest: pipe-B-eDP-1
[127.235620] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.198s)
[127.538782] Subtest plane-all-transition-fencing: SUCCESS (6.289s)
[128.347951] [028/132] (891s left) gem_madvise (dontneed-after-mmap)
[128.383416] Starting subtest: dontneed-after-mmap
[128.402588] Subtest dontneed-after-mmap: SUCCESS (0.019s)
[128.492139] [029/132] (891s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[128.856666] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[129.660848] [030/132] (890s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[130.029900] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[130.794759] [031/132] (889s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[130.888575] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[135.112084] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.224s)
[136.224702] [032/132] (884s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[136.311730] Starting subtest: fbc-psr2-primary-mmap-cpu
[136.312716] Starting dynamic subtest: eDP-1
[136.314514] Dynamic subtest eDP-1: SKIP (0.000s)
[136.316424] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[136.391028] [033/132] (884s left) gem_exec_balancer (bonded-chain)
[136.447615] Starting subtest: bonded-chain
[143.500680] Subtest bonded-chain: SUCCESS (7.042s)
[143.814781] [034/132] (876s left) kms_prime (d3hot)
[143.898550] Subtest D3hot: SKIP (0.000s)
[143.998633] [035/132] (876s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[144.088263] Starting subtest: sprite-rotation-90-pos-100-0
[144.089868] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[144.155236] [036/132] (876s left) gem_softpin (allocator-basic)
[144.213351] Starting subtest: allocator-basic
[144.286291] Subtest allocator-basic: SUCCESS (0.074s)
[144.410233] [037/132] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[144.508114] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[144.509690] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[144.592656] [038/132] (876s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[144.683516] Starting subtest: psr-rgb101010-draw-mmap-cpu
[151.828640] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.146s)
[151.922549] [039/132] (868s left) kms_flip (flip-vs-expired-vblank)
[152.028052] Starting subtest: flip-vs-expired-vblank
[152.030024] Starting dynamic subtest: A-eDP1
[160.763269] Dynamic subtest A-eDP1: SUCCESS (8.708s)
[160.772299] Starting dynamic subtest: B-eDP1
[169.391924] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[169.400688] Starting dynamic subtest: C-eDP1
[178.024948] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[178.032071] Starting dynamic subtest: D-eDP1
[186.657071] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[186.657983] Subtest flip-vs-expired-vblank: SUCCESS (34.595s)
[187.792631] [040/132] (832s left) syncobj_timeline (invalid-query-bad-pad)
[187.850791] Starting subtest: invalid-query-bad-pad
[187.851714] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[187.951616] [041/132] (832s left) kms_hdr (static-swap)
[188.036424] Starting subtest: static-swap
[188.045382] Subtest static-swap: SKIP (0.000s)
[188.104387] [042/132] (832s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[188.156656] Starting subtest: y-tiled-to-vebox-yf-tiled
[188.158338] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[188.348674] [043/132] (832s left) kms_flip (blocking-wf_vblank)
[188.430118] Starting subtest: blocking-wf_vblank
[188.430931] Starting dynamic subtest: A-eDP1
[197.360887] Dynamic subtest A-eDP1: SUCCESS (8.904s)
[197.370200] Starting dynamic subtest: B-eDP1
[206.295422] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[206.305320] Starting dynamic subtest: C-eDP1
[215.230728] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[215.240423] Starting dynamic subtest: D-eDP1
[224.166842] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[224.167793] Subtest blocking-wf_vblank: SUCCESS (35.705s)
[225.342822] [044/132] (795s left) gem_mmap_gtt (pf-nonblock)
[225.398931] Subtest pf-nonblock: SKIP (0.000s)
[225.456540] [045/132] (795s left) kms_psr (psr2-primary-blt)
[225.542438] Starting subtest: psr2-primary-blt
[225.543361] Starting dynamic subtest: eDP-1
[227.227338] Dynamic subtest eDP-1: SUCCESS (1.684s)
[227.228088] Subtest psr2-primary-blt: SUCCESS (1.686s)
[228.110257] [046/132] (792s left) gem_exec_schedule (thriceslice)
[228.173697] Starting subtest: thriceslice
[228.174702] Starting dynamic subtest: rcs0
[228.202832] Dynamic subtest rcs0: SUCCESS (0.029s)
[228.213090] Starting dynamic subtest: bcs0
[228.231341] Dynamic subtest bcs0: SUCCESS (0.028s)
[228.238339] Starting dynamic subtest: vcs0
[228.281760] Dynamic subtest vcs0: SUCCESS (0.049s)
[228.291641] Starting dynamic subtest: vcs1
[228.312302] Dynamic subtest vcs1: SUCCESS (0.029s)
[228.319359] Starting dynamic subtest: vecs0
[228.342588] Dynamic subtest vecs0: SUCCESS (0.029s)
[228.355549] Starting dynamic subtest: ccs0
[228.371563] Dynamic subtest ccs0: SUCCESS (0.029s)
[228.372581] Subtest thriceslice: SUCCESS (0.199s)
[229.950565] [047/132] (790s left) device_reset (unbind-reset-rebind)
[230.000801] Starting subtest: unbind-reset-rebind
[234.560211] Subtest unbind-reset-rebind: SUCCESS (4.557s)
[234.599348] [048/132] (786s left) i915_suspend (fence-restore-tiled2untiled)
[234.643612] Starting subtest: fence-restore-tiled2untiled
[234.645368] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[234.720558] [049/132] (786s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[234.809686] Starting subtest: yf-tiled-8bpp-rotate-0
[234.811405] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[234.905786] [050/132] (786s left) gem_ccs (ctrl-surf-copy-new-ctx)
[234.960544] Starting subtest: ctrl-surf-copy-new-ctx
[234.962523] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[235.072419] [051/132] (785s left) kms_flip (dpms-off-confusion-interruptible)
[235.151186] Starting subtest: dpms-off-confusion-interruptible
[235.153429] Starting dynamic subtest: A-eDP1
[243.843278] Dynamic subtest A-eDP1: SUCCESS (8.664s)
[243.854522] Starting dynamic subtest: B-eDP1
[252.474513] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[252.485050] Starting dynamic subtest: C-eDP1
[261.106378] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[261.115058] Starting dynamic subtest: D-eDP1
[269.731059] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[269.732083] Subtest dpms-off-confusion-interruptible: SUCCESS (34.545s)
[270.865632] [052/132] (750s left) kms_flip (2x-modeset-vs-vblank-race)
[270.951160] Starting subtest: 2x-modeset-vs-vblank-race
[270.961367] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[271.037661] [053/132] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[271.118721] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[278.392180] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.274s)
[278.506291] [054/132] (742s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[278.594162] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[286.102047] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.509s)
[286.208664] [055/132] (734s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[286.274058] Starting subtest: map-fixed-invalidate-overlap
[286.276232] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[286.385119] [056/132] (734s left) gem_mmap_gtt (cpuset-big-copy)
[286.430631] Subtest cpuset-big-copy: SKIP (0.000s)
[286.485542] [057/132] (734s left) kms_psr (psr-sprite-mmap-cpu)
[286.574631] Starting subtest: psr-sprite-mmap-cpu
[286.575572] Starting dynamic subtest: eDP-1
[288.340463] Dynamic subtest eDP-1: SUCCESS (1.766s)
[288.341366] Subtest psr-sprite-mmap-cpu: SUCCESS (1.767s)
[289.184207] [058/132] (732s left) kms_busy (extended-modeset-hang-oldfb)
[289.290250] Starting subtest: extended-modeset-hang-oldfb
[289.291066] Starting dynamic subtest: pipe-A
[300.971301] Dynamic subtest pipe-A: SUCCESS (11.671s)
[300.979553] Starting dynamic subtest: pipe-D
[313.254429] Dynamic subtest pipe-D: SUCCESS (12.287s)
[313.255307] Subtest extended-modeset-hang-oldfb: SUCCESS (23.963s)
[314.048450] [059/132] (707s left) kms_flip (2x-plain-flip)
[314.142068] Starting subtest: 2x-plain-flip
[314.152254] Subtest 2x-plain-flip: SKIP (0.011s)
[314.229703] [060/132] (707s left) syncobj_wait (reset-during-wait-for-submit)
[314.281343] Starting subtest: reset-during-wait-for-submit
[314.386391] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[314.459412] [061/132] (706s left) kms_frontbuffer_tracking (fbc-1p-rte)
[314.548280] Starting subtest: fbc-1p-rte
[320.046823] Subtest fbc-1p-rte: SUCCESS (5.501s)
[321.191952] [062/132] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[321.284163] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[321.285782] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[321.376992] [063/132] (700s left) gem_ctx_param (invalid-set-no-zeromap)
[321.427609] Starting subtest: invalid-set-no-zeromap
[321.428451] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[321.485630] [064/132] (700s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[321.569076] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[321.570131] Starting dynamic subtest: pipe-A-eDP-1
[321.579944] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[321.587913] Starting dynamic subtest: pipe-B-eDP-1
[321.597306] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[321.605237] Starting dynamic subtest: pipe-C-eDP-1
[321.613522] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[321.623245] Starting dynamic subtest: pipe-D-eDP-1
[321.632518] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[321.634156] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.018s)
[323.818923] [065/132] (697s left) kms_cursor_crc (cursor-sliding-32x32)
[323.966890] Starting subtest: cursor-sliding-32x32
[324.012533] Subtest cursor-sliding-32x32: SKIP (0.043s)
[324.301498] [066/132] (697s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[324.350043] Starting subtest: saturated-hostile-nopreempt
[324.351065] Starting dynamic subtest: rcs0
[324.411530] Dynamic subtest rcs0: SKIP (0.060s)
[324.421809] Starting dynamic subtest: bcs0
[324.425877] Dynamic subtest bcs0: SKIP (0.013s)
[324.432941] Starting dynamic subtest: vcs0
[324.437919] Dynamic subtest vcs0: SKIP (0.011s)
[324.444866] Starting dynamic subtest: vcs1
[324.451731] Dynamic subtest vcs1: SKIP (0.013s)
[324.458806] Starting dynamic subtest: vecs0
[324.464917] Dynamic subtest vecs0: SKIP (0.012s)
[324.471879] Starting dynamic subtest: ccs0
[324.477797] Dynamic subtest ccs0: SKIP (0.012s)
[324.479522] Subtest saturated-hostile-nopreempt: SKIP (0.128s)
[324.550418] [067/132] (697s left) gem_mmap_wc (pf-nonblock)
[324.591766] Subtest pf-nonblock: SKIP (0.000s)
[324.646608] [068/132] (696s left) gem_mmap_gtt (basic-short)
[324.692438] Subtest basic-short: SKIP (0.000s)
[324.741466] [069/132] (696s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[324.826821] Starting subtest: pr-overlay-plane-update-continuous-sf
[324.828446] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[324.893877] [070/132] (696s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[324.980479] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[329.620759] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.640s)
[330.751164] [071/132] (690s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[330.870334] Starting subtest: cursorB-vs-flipB-toggle
[330.873170] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[331.009159] [072/132] (690s left) kms_cursor_crc (cursor-random-32x10)
[331.176314] Starting subtest: cursor-random-32x10
[331.224377] Subtest cursor-random-32x10: SKIP (0.046s)
[331.464787] [073/132] (690s left) api_intel_allocator (gem-pool)
[331.513529] Starting subtest: gem-pool
[331.518791] Subtest gem-pool: SUCCESS (0.007s)
[331.631704] [074/132] (690s left) kms_vblank (query-forked-busy-hang)
[331.716134] Starting subtest: query-forked-busy-hang
[331.716947] Starting dynamic subtest: pipe-A-eDP-1
[338.240264] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.522s)
[338.253159] Starting dynamic subtest: pipe-D-eDP-1
[345.286055] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.044s)
[345.286934] Subtest query-forked-busy-hang: SUCCESS (13.570s)
[346.081446] [075/132] (675s left) gem_exercise_blt (fast-copy)
[346.148193] Starting subtest: fast-copy
[346.149142] Starting dynamic subtest: linear-smem-smem
[346.172198] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[346.181956] Starting dynamic subtest: xmajor-smem-smem
[346.189720] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[346.197485] Starting dynamic subtest: tile4-smem-smem
[346.214050] Dynamic subtest tile4-smem-smem: SUCCESS (0.023s)
[346.221566] Starting dynamic subtest: tile64-smem-smem
[346.230982] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[346.232364] Subtest fast-copy: SUCCESS (0.083s)
[346.347066] [076/132] (675s left) gem_exec_params (no-vebox)
[346.393033] Starting subtest: no-vebox
[346.395647] Subtest no-vebox: SUCCESS (0.002s)
[347.970196] [077/132] (673s left) kms_plane_multiple (tiling-none)
[348.057226] Starting subtest: tiling-none
[348.058169] Starting dynamic subtest: pipe-A-eDP-1
[351.737812] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.680s)
[351.746845] Starting dynamic subtest: pipe-B-eDP-1
[356.201304] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.460s)
[356.215538] Starting dynamic subtest: pipe-C-eDP-1
[360.547039] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.346s)
[360.554999] Starting dynamic subtest: pipe-D-eDP-1
[364.891450] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.342s)
[364.892391] Subtest tiling-none: SUCCESS (16.834s)
[365.683388] [078/132] (656s left) kms_dsc (dsc-basic)
[365.775870] Starting subtest: dsc-basic
[365.781369] Subtest dsc-basic: SKIP (0.000s)
[365.843544] [079/132] (656s left) gem_exec_schedule (preempt-other-chain)
[365.901591] Starting subtest: preempt-other-chain
[365.902573] Starting dynamic subtest: rcs0
[365.986451] Dynamic subtest rcs0: SUCCESS (0.084s)
[365.997822] Starting dynamic subtest: bcs0
[366.064570] Dynamic subtest bcs0: SUCCESS (0.077s)
[366.077533] Starting dynamic subtest: vcs0
[366.139102] Dynamic subtest vcs0: SUCCESS (0.074s)
[366.150992] Starting dynamic subtest: vcs1
[366.216372] Dynamic subtest vcs1: SUCCESS (0.076s)
[366.226096] Starting dynamic subtest: vecs0
[366.298731] Dynamic subtest vecs0: SUCCESS (0.080s)
[366.309732] Starting dynamic subtest: ccs0
[366.382306] Dynamic subtest ccs0: SUCCESS (0.084s)
[366.384250] Subtest preempt-other-chain: SUCCESS (0.480s)
[367.983412] [080/132] (654s left) kms_flip (nonexisting-fb)
[368.079239] Starting subtest: nonexisting-fb
[368.092452] Starting dynamic subtest: A-eDP1
[369.279241] Dynamic subtest A-eDP1: SUCCESS (1.198s)
[369.294384] Starting dynamic subtest: B-eDP1
[370.408263] Dynamic subtest B-eDP1: SUCCESS (1.128s)
[370.417818] Starting dynamic subtest: C-eDP1
[371.545330] Dynamic subtest C-eDP1: SUCCESS (1.136s)
[371.561452] Starting dynamic subtest: D-eDP1
[372.680866] Dynamic subtest D-eDP1: SUCCESS (1.133s)
[372.685098] Subtest nonexisting-fb: SUCCESS (4.606s)
[373.857334] [081/132] (648s left) gem_exec_params (cliprects_ptr-dirt)
[373.915464] Starting subtest: cliprects_ptr-dirt
[373.916463] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[374.010057] [082/132] (648s left) gem_exec_create (basic)
[374.065046] Starting subtest: basic
[374.066517] Starting dynamic subtest: smem
[376.158505] Dynamic subtest smem: SUCCESS (2.093s)
[376.159876] Subtest basic: SUCCESS (2.094s)
[376.343904] [083/132] (645s left) kms_content_protection (suspend-resume)
[376.478860] Starting subtest: suspend-resume
[376.480827] Subtest suspend-resume: SKIP (0.000s)
[376.610077] [084/132] (645s left) gem_exec_fence (syncobj-wait)
[377.064224] Starting subtest: syncobj-wait
[378.923234] Subtest syncobj-wait: SUCCESS (1.850s)
[379.245653] [085/132] (642s left) kms_psr (fbc-psr-primary-mmap-cpu)
[379.339977] Starting subtest: fbc-psr-primary-mmap-cpu
[379.340797] Starting dynamic subtest: eDP-1
[379.342334] Dynamic subtest eDP-1: SKIP (0.000s)
[379.343837] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[379.408762] [086/132] (642s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[379.499262] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[379.500074] Starting dynamic subtest: pipe-A-eDP-1
[379.521669] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[379.529748] Starting dynamic subtest: pipe-B-eDP-1
[379.550774] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[379.558810] Starting dynamic subtest: pipe-C-eDP-1
[379.579476] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[379.586756] Starting dynamic subtest: pipe-D-eDP-1
[379.607158] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[379.608716] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[381.820476] [087/132] (640s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[381.903929] Starting subtest: basic-modeset-with-all-modifiers-formats
[382.282008] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[383.092161] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.810s)
[383.099814] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[383.114122] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[383.123365] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[383.136492] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[383.145726] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[383.291719] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[383.299449] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[383.313872] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[383.321147] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[383.336064] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[383.343292] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[383.358396] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[383.365537] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[383.380814] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[383.389964] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[383.402932] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[383.410382] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[383.425238] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[383.434651] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[383.447355] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[383.456069] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[383.469540] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[383.477046] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[383.613974] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[383.621753] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[383.636419] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[383.643709] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[383.658516] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[383.665899] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[383.681104] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[383.691070] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[383.703283] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[383.710668] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[383.725087] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[383.734128] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[383.747372] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[383.754788] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[383.769735] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[383.779099] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[383.792053] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[383.799282] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[383.948095] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[383.957647] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[383.969966] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[383.977610] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[383.992245] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[383.999693] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[384.014588] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[384.022066] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[384.036736] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[384.045087] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[384.059170] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[384.067258] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[384.081224] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[384.088890] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[384.103656] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[384.112262] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[384.125488] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[384.523285] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.616s)
[385.298720] [088/132] (637s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[385.385800] Starting subtest: psr-dirtyfb-ioctl
[385.386809] Starting dynamic subtest: A-eDP-1
[389.286885] Dynamic subtest A-eDP-1: SUCCESS (3.901s)
[389.287802] Subtest psr-dirtyfb-ioctl: SUCCESS (3.903s)
[390.164584] [089/132] (632s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[390.262439] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[391.252617] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s)
[391.378169] [090/132] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[391.462458] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[398.559186] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.098s)
[398.676680] [091/132] (623s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[398.782277] Starting subtest: fbc-rgb101010-draw-pwrite
[404.175731] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.394s)
[405.372103] [092/132] (617s left) kms_plane_alpha_blend (alpha-7efc)
[405.462589] Starting subtest: alpha-7efc
[405.780110] Starting dynamic subtest: pipe-A-eDP-1
[406.390623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[406.420393] Starting dynamic subtest: pipe-D-eDP-1
[407.680642] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.267s)
[407.681546] Subtest alpha-7efc: SUCCESS (2.218s)
[408.526029] [093/132] (613s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[408.627778] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[408.629485] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[408.702521] [094/132] (613s left) gem_set_tiling_vs_gtt
[408.808544] [095/132] (613s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[408.914977] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[408.955722] [096/132] (613s left) kms_addfb_basic (bad-pitch-65536)
[409.006312] Starting subtest: bad-pitch-65536
[409.007261] Subtest bad-pitch-65536: SUCCESS (0.001s)
[409.149108] [097/132] (613s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[409.240726] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[409.241975] Starting dynamic subtest: pipe-A-eDP-1
[409.250705] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[409.258726] Starting dynamic subtest: pipe-B-eDP-1
[409.267260] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[409.274659] Starting dynamic subtest: pipe-C-eDP-1
[409.282794] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[409.290410] Starting dynamic subtest: pipe-D-eDP-1
[409.299047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[409.300655] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.014s)
[411.602288] [098/132] (611s left) kms_plane (plane-position-hole-dpms)
[411.702701] Starting subtest: plane-position-hole-dpms
[412.239484] Starting dynamic subtest: pipe-A-plane-1
[414.637446] Dynamic subtest pipe-A-plane-1: SUCCESS (2.398s)
[414.645104] Starting dynamic subtest: pipe-A-plane-2
[417.056188] Dynamic subtest pipe-A-plane-2: SUCCESS (2.417s)
[417.063672] Starting dynamic subtest: pipe-A-plane-3
[419.458326] Dynamic subtest pipe-A-plane-3: SUCCESS (2.397s)
[419.469032] Starting dynamic subtest: pipe-A-plane-4
[421.918160] Dynamic subtest pipe-A-plane-4: SUCCESS (2.464s)
[421.928119] Starting dynamic subtest: pipe-A-plane-5
[421.949271] Dynamic subtest pipe-A-plane-5: SUCCESS (0.030s)
[423.171134] Starting dynamic subtest: pipe-B-plane-1
[425.568800] Dynamic subtest pipe-B-plane-1: SUCCESS (2.403s)
[425.576144] Starting dynamic subtest: pipe-B-plane-2
[427.923830] Dynamic subtest pipe-B-plane-2: SUCCESS (2.355s)
[427.931465] Starting dynamic subtest: pipe-B-plane-3
[430.292135] Dynamic subtest pipe-B-plane-3: SUCCESS (2.367s)
[430.299735] Starting dynamic subtest: pipe-B-plane-4
[432.668770] Dynamic subtest pipe-B-plane-4: SUCCESS (2.375s)
[432.676421] Starting dynamic subtest: pipe-B-plane-5
[432.696151] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[432.696948] Subtest plane-position-hole-dpms: SUCCESS (20.993s)
[433.477424] [099/132] (589s left) api_intel_bb (object-noreloc-keep-cache-simple)
[433.536328] Starting subtest: object-noreloc-keep-cache-simple
[433.542348] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[433.651042] [100/132] (589s left) gem_exec_suspend (basic-s0)
[433.704554] Starting subtest: basic-S0
[433.705498] Starting dynamic subtest: smem
[453.275362] Dynamic subtest smem: SUCCESS (6.189s)
[453.276979] Subtest basic-S0: SUCCESS (6.191s)
[459.469964] [101/132] (569s left) gem_ctx_engines (none)
[459.528909] Starting subtest: none
[459.531638] Subtest none: SUCCESS (0.001s)
[459.711565] [102/132] (569s left) i915_drm_fdinfo (virtual-busy-hang-all)
[459.755705] Starting subtest: virtual-busy-hang-all
[459.757496] Subtest virtual-busy-hang-all: SKIP (0.000s)
[459.825894] [103/132] (569s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[459.869565] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[459.974741] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[460.068054] [104/132] (568s left) kms_cursor_crc (cursor-offscreen-512x512)
[460.351228] Starting subtest: cursor-offscreen-512x512
[460.360935] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[460.504500] [105/132] (568s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[460.596899] Starting subtest: x-tiled-8bpp-rotate-180
[461.842917] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.225s)
[461.962723] [106/132] (567s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[462.053860] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[462.054817] Starting dynamic subtest: pipe-A-default-mode
[464.817199] Dynamic subtest pipe-A-default-mode: SUCCESS (2.725s)
[464.818284] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.727s)
[465.696627] [107/132] (563s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[465.778184] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[465.779090] Starting dynamic subtest: pipe-A-eDP-1
[472.586550] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.762s)
[472.594946] Starting dynamic subtest: pipe-B-eDP-1
[479.625402] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.017s)
[479.626379] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.782s)
[480.485022] [108/132] (548s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[480.540572] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[480.542211] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[480.718989] [109/132] (548s left) i915_pm_rpm (gem-pread)
[482.460021] Starting subtest: gem-pread
[484.696816] Subtest gem-pread: SUCCESS (2.234s)
[484.782260] [110/132] (544s left) gem_readwrite (write-bad-handle)
[484.833476] Subtest write-bad-handle: SKIP (0.000s)
[484.890431] [111/132] (544s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[484.978626] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[484.980394] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[485.044008] [112/132] (544s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[485.134376] Starting subtest: yf-tiled-16bpp-rotate-180
[485.136193] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[485.226412] [113/132] (543s left) kms_hdr (bpc-switch-dpms)
[485.317832] Starting subtest: bpc-switch-dpms
[486.428387] Starting dynamic subtest: pipe-A-eDP-1
[490.946518] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.515s)
[490.947506] Subtest bpc-switch-dpms: SUCCESS (5.625s)
[491.051937] [114/132] (538s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[491.134775] Starting subtest: primary-y-tiled-reflect-x-180
[491.195609] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[491.293102] [115/132] (537s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[491.383798] Starting subtest: y-tiled-8bpp-rotate-270
[491.385734] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[491.481088] [116/132] (537s left) gem_workarounds (basic-read)
[491.537840] Starting subtest: basic-read
[491.553535] Subtest basic-read: SUCCESS (0.016s)
[491.666837] [117/132] (537s left) gem_partial_pwrite_pread (write-snoop)
[491.711562] Subtest write-snoop: SKIP (0.000s)
[491.782457] [118/132] (537s left) gem_sync (basic-store-all)
[491.836659] Starting subtest: basic-store-all
[495.171945] Subtest basic-store-all: SUCCESS (3.336s)
[495.354862] [119/132] (534s left) syncobj_wait (single-wait-submitted)
[495.409788] Starting subtest: single-wait-submitted
[495.517841] Subtest single-wait-submitted: SUCCESS (0.107s)
[495.591429] [120/132] (533s left) sysfs_heartbeat_interval (precise)
[495.639884] Starting subtest: precise
[495.640811] Starting dynamic subtest: vecs0
[503.256061] Dynamic subtest vecs0: SUCCESS (7.604s)
[503.266628] Starting dynamic subtest: ccs0
[504.397225] Dynamic subtest ccs0: SUCCESS (1.147s)
[504.411134] Starting dynamic subtest: vcs0
[512.288163] Dynamic subtest vcs0: SUCCESS (7.879s)
[512.299246] Starting dynamic subtest: bcs0
[513.396872] Dynamic subtest bcs0: SUCCESS (1.115s)
[513.407221] Starting dynamic subtest: rcs0
[514.494215] Dynamic subtest rcs0: SUCCESS (1.097s)
[514.507573] Starting dynamic subtest: vcs1
[522.264692] Dynamic subtest vcs1: SUCCESS (7.756s)
[522.265825] Subtest precise: SUCCESS (26.608s)
[522.326016] [121/132] (507s left) perf_pmu (busy-check-all)
[522.367890] Starting subtest: busy-check-all
[522.368866] Starting dynamic subtest: rcs0
[522.924135] Dynamic subtest rcs0: SUCCESS (0.555s)
[522.936059] Starting dynamic subtest: bcs0
[523.478609] Dynamic subtest bcs0: SUCCESS (0.552s)
[523.490195] Starting dynamic subtest: vcs0
[525.275592] Dynamic subtest vcs0: SUCCESS (1.783s)
[525.286470] Starting dynamic subtest: vcs1
[527.323610] Dynamic subtest vcs1: SUCCESS (2.045s)
[527.335115] Starting dynamic subtest: vecs0
[529.307597] Dynamic subtest vecs0: SUCCESS (1.980s)
[529.318820] Starting dynamic subtest: ccs0
[529.854537] Dynamic subtest ccs0: SUCCESS (0.554s)
[529.855888] Subtest busy-check-all: SUCCESS (7.485s)
[529.980107] [122/132] (499s left) prime_busy (hang-wait)
[530.041736] Starting subtest: hang-wait
[530.042616] Starting dynamic subtest: rcs0
[555.825076] Dynamic subtest rcs0: SUCCESS (25.773s)
[555.836081] Starting dynamic subtest: bcs0
[562.916768] Dynamic subtest bcs0: SUCCESS (7.092s)
[562.928580] Starting dynamic subtest: vcs0
[569.888776] Dynamic subtest vcs0: SUCCESS (6.971s)
[569.901127] Starting dynamic subtest: vcs1
[576.864353] Dynamic subtest vcs1: SUCCESS (6.971s)
[576.874617] Starting dynamic subtest: vecs0
[583.912968] Dynamic subtest vecs0: SUCCESS (7.045s)
[583.922444] Starting dynamic subtest: ccs0
[597.738526] Dynamic subtest ccs0: SUCCESS (13.824s)
[597.739776] Subtest hang-wait: SUCCESS (67.693s)
[597.875685] [123/132] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[597.976271] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[604.645770] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.668s)
[604.767871] [124/132] (424s left) i915_drm_fdinfo (memory-info-shared)
[604.806793] Starting subtest: memory-info-shared
[604.808064] Starting dynamic subtest: smem0
[604.859881] Dynamic subtest smem0: SUCCESS (0.052s)
[604.860977] Subtest memory-info-shared: SUCCESS (0.053s)
[604.930821] [125/132] (424s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[606.458357] Starting subtest: dpms-mode-unset-lpsp
[610.522655] Subtest dpms-mode-unset-lpsp: SUCCESS (4.064s)
[610.887953] [126/132] (418s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[610.969252] Starting subtest: fbcpsr-indfb-scaledprimary
[616.765827] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.795s)
[616.889074] [127/132] (412s left) kms_hdmi_inject (inject-4k)
[617.220484] Starting subtest: inject-4k
[617.537392] Subtest inject-4k: SUCCESS (0.317s)
[618.075482] [128/132] (411s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[618.162396] Starting subtest: plane-lut1d-ctm3x4-lut1d
[618.310449] Starting dynamic subtest: pipe-A-plane-0
[618.477045] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[618.485808] Starting dynamic subtest: pipe-A-plane-1
[618.643671] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[618.652571] Starting dynamic subtest: pipe-A-plane-2
[618.810317] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[620.030746] Starting dynamic subtest: pipe-B-plane-0
[620.222720] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[620.231511] Starting dynamic subtest: pipe-B-plane-1
[620.389325] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[620.400165] Starting dynamic subtest: pipe-B-plane-2
[620.556063] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[621.703921] Starting dynamic subtest: pipe-C-plane-0
[621.829161] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[621.838209] Starting dynamic subtest: pipe-C-plane-1
[621.995780] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[622.004218] Starting dynamic subtest: pipe-C-plane-2
[622.140521] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[623.313778] Starting dynamic subtest: pipe-D-plane-0
[623.460741] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[623.472605] Starting dynamic subtest: pipe-D-plane-1
[623.616329] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[623.625244] Starting dynamic subtest: pipe-D-plane-2
[623.782924] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[624.076671] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.912s)
[624.938105] [129/132] (404s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[624.993536] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[624.994475] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[625.084714] [130/132] (404s left) syncobj_timeline (wait-any-interrupted)
[625.144449] Starting subtest: wait-any-interrupted
[625.246197] Subtest wait-any-interrupted: SUCCESS (0.102s)
[625.331048] [131/132] (404s left) gem_ctx_param (set-priority-not-supported)
[625.377242] Starting subtest: set-priority-not-supported
[625.379652] Subtest set-priority-not-supported: SKIP (0.000s)
[625.455195] [132/132] (404s left) gem_exec_fence (syncobj-invalid-flags)
[625.898671] Starting subtest: syncobj-invalid-flags
[625.900194] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[627.367225] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_exec
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_chamelium_audio
results: parsing output: 4/ for test: gem_exec_flush
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_unfence_active_buffers
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: vgem_basic
results: parsing output: 22/ for test: gem_wait
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_atomic_transition
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: gem_madvise
results: parsing output: 28/ for test: kms_chamelium_edid
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: kms_prime
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_hdr
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: device_reset
results: parsing output: 47/ for test: i915_suspend
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_ccs
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_busy
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: gem_mmap_wc
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: api_intel_allocator
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: gem_exercise_blt
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: kms_plane_multiple
results: parsing output: 77/ for test: kms_dsc
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: gem_exec_create
results: parsing output: 82/ for test: kms_content_protection
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_async_flips
results: parsing output: 87/ for test: kms_dirtyfb
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_plane_alpha_blend
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_set_tiling_vs_gtt
results: parsing output: 94/ for test: kms_tiled_display
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: gem_exec_suspend
results: parsing output: 100/ for test: gem_ctx_engines
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: gem_readwrite
results: parsing output: 110/ for test: kms_joiner
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_hdr
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_workarounds
results: parsing output: 116/ for test: gem_partial_pwrite_pread
results: parsing output: 117/ for test: gem_sync
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: sysfs_heartbeat_interval
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: prime_busy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_hdmi_inject
results: parsing output: 127/ for test: kms_color_pipeline
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_ctx_param
results: parsing output: 131/ for test: gem_exec_fence
Done.