[56.819195] Initializing watchdogs
[56.819287]   /dev/watchdog0
[56.833799] [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.837987] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.840526] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.843953] [001/155] (960s left) gem_lmem_swapping (heavy-verify-multi)
[56.911169] Subtest heavy-verify-multi: SKIP (0.000s)
[56.952546] [002/155] (960s left) gem_eio (create-ext)
[57.097935] Starting subtest: create-ext
[57.272547] Subtest create-ext: SUCCESS (0.174s)
[57.416087] [003/155] (960s left) kms_getfb (getfb-addfb-different-handles)
[57.516792] Starting subtest: getfb-addfb-different-handles
[57.519121] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[57.623232] [004/155] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[57.725894] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[57.729626] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[57.846208] [005/155] (959s left) i915_hangman (engine-engine-error)
[57.904954] Starting subtest: engine-engine-error
[57.906815] Starting dynamic subtest: rcs0
[59.300320] Dynamic subtest rcs0: SUCCESS (1.393s)
[59.312733] Starting dynamic subtest: bcs0
[61.282288] Dynamic subtest bcs0: SUCCESS (1.981s)
[61.295899] Starting dynamic subtest: vcs0
[63.267107] Dynamic subtest vcs0: SUCCESS (1.983s)
[63.277085] Starting dynamic subtest: vcs1
[65.250549] Dynamic subtest vcs1: SUCCESS (1.982s)
[65.263414] Starting dynamic subtest: vecs0
[67.233409] Dynamic subtest vecs0: SUCCESS (1.982s)
[67.246767] Starting dynamic subtest: ccs0
[69.282864] Dynamic subtest ccs0: SUCCESS (2.049s)
[69.286070] Subtest engine-engine-error: SUCCESS (11.376s)
[69.359168] [006/155] (948s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[69.412795] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[69.467244] [007/155] (948s left) gem_exec_schedule (noreorder-corked)
[69.642218] Starting subtest: noreorder-corked
[69.644574] Starting dynamic subtest: rcs0
[70.789531] Dynamic subtest rcs0: SUCCESS (1.147s)
[70.799089] Starting dynamic subtest: vcs0
[72.337676] Dynamic subtest vcs0: SUCCESS (1.546s)
[72.348530] Starting dynamic subtest: vcs1
[74.308188] Dynamic subtest vcs1: SUCCESS (1.970s)
[74.318704] Starting dynamic subtest: vecs0
[76.291628] Dynamic subtest vecs0: SUCCESS (1.982s)
[76.300989] Starting dynamic subtest: ccs0
[77.451805] Dynamic subtest ccs0: SUCCESS (1.161s)
[77.454277] Subtest noreorder-corked: SUCCESS (7.810s)
[77.636628] [008/155] (939s left) kms_cursor_crc (cursor-random-max-size)
[77.953513] Starting subtest: cursor-random-max-size
[77.959702] Subtest cursor-random-max-size: SKIP (0.000s)
[78.086585] [009/155] (939s left) kms_psr (psr-sprite-blt)
[78.174866] Starting subtest: psr-sprite-blt
[78.177264] Starting dynamic subtest: eDP-1
[79.892349] Dynamic subtest eDP-1: SUCCESS (1.715s)
[79.894348] Subtest psr-sprite-blt: SUCCESS (1.716s)
[80.744272] [010/155] (936s left) kms_hdr (static-toggle-suspend)
[80.838200] Starting subtest: static-toggle-suspend
[80.840511] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[80.844743] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[80.853031] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[80.857529] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[80.862057] Subtest static-toggle-suspend: SKIP (0.002s)
[80.909142] [011/155] (936s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[80.994070] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[80.998641] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[81.064926] [012/155] (936s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[81.165453] Starting subtest: disable-crc-after-crtc
[81.167935] Starting dynamic subtest: pipe-A-eDP-1
[82.795321] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.627s)
[82.805821] Starting dynamic subtest: pipe-B-eDP-1
[85.082294] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.288s)
[85.094970] Starting dynamic subtest: pipe-C-eDP-1
[87.350639] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.264s)
[87.359161] Starting dynamic subtest: pipe-D-eDP-1
[89.599266] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s)
[89.601147] Subtest disable-crc-after-crtc: SUCCESS (8.431s)
[90.446991] [013/155] (927s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[90.543263] Starting subtest: fbc-psr2-cursor-plane-onoff
[90.545476] Starting dynamic subtest: eDP-1
[90.549901] Dynamic subtest eDP-1: SKIP (0.000s)
[90.554459] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[90.611330] [014/155] (927s left) kms_chamelium_hpd (hdmi-hpd-storm)
[90.987202] Subtest hdmi-hpd-storm: SKIP (0.000s)
[91.847936] [015/155] (926s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[91.957264] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[91.961893] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[92.057263] [016/155] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[92.159496] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[92.163940] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[92.247803] [017/155] (925s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[92.341822] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[92.346426] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[92.440451] [018/155] (925s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[92.546491] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[96.982377] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.442s)
[98.175346] [019/155] (919s left) prime_busy (after-wait)
[98.238560] Starting subtest: after-wait
[98.243642] Starting dynamic subtest: rcs0
[98.278332] Dynamic subtest rcs0: SUCCESS (0.037s)
[98.286872] Starting dynamic subtest: bcs0
[98.319363] Dynamic subtest bcs0: SUCCESS (0.040s)
[98.327332] Starting dynamic subtest: vcs0
[98.359860] Dynamic subtest vcs0: SUCCESS (0.040s)
[98.367912] Starting dynamic subtest: vcs1
[98.399498] Dynamic subtest vcs1: SUCCESS (0.040s)
[98.407615] Starting dynamic subtest: vecs0
[98.440611] Dynamic subtest vecs0: SUCCESS (0.041s)
[98.448730] Starting dynamic subtest: ccs0
[98.481446] Dynamic subtest ccs0: SUCCESS (0.040s)
[98.589554] Subtest after-wait: SUCCESS (0.349s)
[98.663962] [020/155] (919s left) prime_vgem (basic-read)
[98.763920] Starting subtest: basic-read
[98.770864] Subtest basic-read: SKIP (0.005s)
[98.886883] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[98.890883] [021/155] (919s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[98.991850] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[98.996064] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[99.102499] [022/155] (919s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[99.199105] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[99.203178] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[99.299944] [023/155] (918s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[99.402346] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[99.406586] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[99.499741] [024/155] (918s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[99.604254] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[99.607877] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[99.685796] [025/155] (918s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[99.782179] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[100.156913] Starting dynamic subtest: pipe-A-eDP-1
[102.945356] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.787s)
[103.308093] Starting dynamic subtest: pipe-B-eDP-1
[106.079199] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[106.444780] Starting dynamic subtest: pipe-C-eDP-1
[109.211146] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.773s)
[109.568350] Starting dynamic subtest: pipe-D-eDP-1
[112.339515] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[112.342305] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.557s)
[113.529356] [026/155] (904s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[113.598038] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[113.660537] [027/155] (904s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[113.716987] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[113.824055] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[113.902668] [028/155] (904s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[113.997214] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[113.999665] Starting dynamic subtest: pipe-A-default-mode
[116.810448] Dynamic subtest pipe-A-default-mode: SUCCESS (2.815s)
[116.812841] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.816s)
[117.652398] [029/155] (900s left) kms_dsc (dsc-with-bpc-formats)
[117.753892] Starting subtest: dsc-with-bpc-formats
[117.863328] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[117.924766] [030/155] (900s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[118.003736] Starting subtest: random-ccs-data-yf-tiled-ccs
[118.005993] Starting dynamic subtest: pipe-A-eDP-1
[118.031054] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[118.040268] Starting dynamic subtest: pipe-B-eDP-1
[118.063607] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[118.072538] Starting dynamic subtest: pipe-C-eDP-1
[118.095919] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[118.104579] Starting dynamic subtest: pipe-D-eDP-1
[118.128860] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[118.133047] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[120.293173] [031/155] (898s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[120.355302] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[120.418848] [032/155] (898s left) kms_pm_backlight (fade-with-suspend)
[120.506810] Starting subtest: fade-with-suspend
[136.298668] Starting dynamic subtest: eDP-1
[139.314721] Dynamic subtest eDP-1: SUCCESS (3.024s)
[139.317232] Subtest fade-with-suspend: SUCCESS (5.190s)
[140.124331] [033/155] (878s left) kms_flip (2x-plain-flip-interruptible)
[140.252134] Starting subtest: 2x-plain-flip-interruptible
[140.264669] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[140.369681] [034/155] (878s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[140.491486] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[140.628085] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.138s)
[140.752727] [035/155] (877s left) kms_flip (nonblocking-read)
[140.849685] Starting subtest: nonblocking-read
[140.852012] Subtest nonblocking-read: SUCCESS (0.000s)
[140.971075] [036/155] (877s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[141.074285] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[141.077853] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[141.161468] [037/155] (877s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[141.255638] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[142.058641] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[142.243645] [038/155] (876s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[142.343826] Starting subtest: x-tiled-16bpp-rotate-180
[143.557651] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.213s)
[143.679368] [039/155] (875s left) gem_exec_balancer (sequential)
[143.738923] Starting subtest: sequential
[146.812013] Subtest sequential: SUCCESS (3.072s)
[147.133902] [040/155] (871s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[147.240389] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[147.244346] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[147.330666] [041/155] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[147.439927] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[147.443955] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[147.540795] [042/155] (871s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[147.639347] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[147.643598] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[147.741451] [043/155] (871s left) gem_render_copy (yf-tiled-to-vebox-linear)
[147.796486] Starting subtest: yf-tiled-to-vebox-linear
[147.800739] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[147.989511] [044/155] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[148.082143] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[148.086154] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[148.172950] [045/155] (870s left) gem_mmap_gtt (basic-read-write-distinct)
[148.223467] Subtest basic-read-write-distinct: SKIP (0.000s)
[148.285009] [046/155] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[148.392083] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[155.123862] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.735s)
[155.261336] [047/155] (863s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[155.359827] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[155.363880] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[155.461057] [048/155] (863s left) gem_exec_fence (submit3)
[155.639372] Starting subtest: submit3
[155.644016] Subtest submit3: SKIP (0.000s)
[157.002954] [049/155] (862s left) gem_wait (await)
[157.067563] Starting subtest: await
[157.070076] Starting dynamic subtest: all-engines
[158.175131] Dynamic subtest all-engines: SUCCESS (1.107s)
[158.192973] Starting dynamic subtest: rcs0
[159.232300] Dynamic subtest rcs0: SUCCESS (1.055s)
[159.248849] Starting dynamic subtest: bcs0
[160.289229] Dynamic subtest bcs0: SUCCESS (1.055s)
[160.306978] Starting dynamic subtest: vcs0
[161.343512] Dynamic subtest vcs0: SUCCESS (1.053s)
[161.363544] Starting dynamic subtest: vcs1
[162.395733] Dynamic subtest vcs1: SUCCESS (1.051s)
[162.413258] Starting dynamic subtest: vecs0
[163.448931] Dynamic subtest vecs0: SUCCESS (1.051s)
[163.466189] Starting dynamic subtest: ccs0
[164.505469] Dynamic subtest ccs0: SUCCESS (1.055s)
[164.508953] Subtest await: SUCCESS (7.437s)
[164.703276] [050/155] (854s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[164.801619] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[165.403251] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[165.579794] [051/155] (853s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[165.674326] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[165.676704] Starting dynamic subtest: pipe-A-eDP-1
[171.545981] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.873s)
[171.557827] Starting dynamic subtest: pipe-B-eDP-1
[178.192214] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.648s)
[178.194506] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.525s)
[179.060474] [052/155] (840s left) kms_vblank (wait-idle-hang)
[179.158338] Starting subtest: wait-idle-hang
[179.160239] Starting dynamic subtest: pipe-A-eDP-1
[206.647418] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.489s)
[206.663233] Starting dynamic subtest: pipe-D-eDP-1
[221.701487] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.051s)
[221.703486] Subtest wait-idle-hang: SUCCESS (42.544s)
[222.522955] [053/155] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[222.631867] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[222.636315] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[222.737510] [054/155] (796s left) i915_pm_rpm (sysfs-read)
[224.257243] Starting subtest: sysfs-read
[225.427898] Subtest sysfs-read: SUCCESS (1.171s)
[225.824184] [055/155] (793s left) sw_sync (sync_multi_producer_single_consumer)
[225.860045] Starting subtest: sync_multi_producer_single_consumer
[226.934315] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[227.012682] [056/155] (792s left) gem_mmap_gtt (flink-race)
[227.074086] Subtest flink-race: SKIP (0.000s)
[227.145030] [057/155] (792s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[227.244973] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[227.249107] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[227.336920] [058/155] (792s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[227.439846] Starting subtest: hdr-1p-pri-indfb-multidraw
[227.443851] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[227.540118] [059/155] (792s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[227.669742] Starting subtest: cursorA-vs-flipA-legacy
[238.790554] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.118s)
[239.646878] [060/155] (780s left) gem_ctx_persistence (smoketest)
[239.704342] Starting subtest: smoketest
[279.830418] Subtest smoketest: SUCCESS (40.119s)
[279.916066] [061/155] (739s left) kms_cursor_crc (cursor-offscreen-512x512)
[280.176221] Starting subtest: cursor-offscreen-512x512
[280.180954] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[280.349732] [062/155] (739s left) gem_busy (busy)
[280.422582] Starting subtest: busy
[280.424571] Starting dynamic subtest: all-engines
[280.485875] Dynamic subtest all-engines: SUCCESS (0.066s)
[280.495951] Starting dynamic subtest: rcs0
[281.854029] Dynamic subtest rcs0: SUCCESS (1.366s)
[281.867204] Starting dynamic subtest: bcs0
[281.900755] Dynamic subtest bcs0: SUCCESS (0.047s)
[281.910493] Starting dynamic subtest: vcs0
[281.940907] Dynamic subtest vcs0: SUCCESS (0.039s)
[281.949994] Starting dynamic subtest: vcs1
[283.902259] Dynamic subtest vcs1: SUCCESS (1.958s)
[283.913397] Starting dynamic subtest: vecs0
[285.949010] Dynamic subtest vecs0: SUCCESS (2.043s)
[285.959138] Starting dynamic subtest: ccs0
[287.933392] Dynamic subtest ccs0: SUCCESS (1.984s)
[287.935521] Subtest busy: SUCCESS (7.512s)
[288.298028] [063/155] (731s left) gem_exec_params (invalid-fence-in)
[288.355124] Starting subtest: invalid-fence-in
[288.357513] Subtest invalid-fence-in: SUCCESS (0.000s)
[288.456380] [064/155] (731s left) gem_exec_whisper (basic-contexts-priority-all)
[288.520955] Starting subtest: basic-contexts-priority-all
[312.919439] Subtest basic-contexts-priority-all: SUCCESS (24.393s)
[313.115671] [065/155] (706s left) syncobj_timeline (invalid-signal-illegal-handle)
[313.177286] Starting subtest: invalid-signal-illegal-handle
[313.179113] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[313.285479] [066/155] (706s left) kms_psr (fbc-psr-no-drrs)
[313.390967] Starting subtest: fbc-psr-no-drrs
[313.393139] Starting dynamic subtest: eDP-1
[313.397102] Dynamic subtest eDP-1: SKIP (0.000s)
[313.401013] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[313.465258] [067/155] (706s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[313.570795] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[313.572813] Starting dynamic subtest: pipe-A-eDP-1
[313.720500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[313.732745] Starting dynamic subtest: pipe-B-eDP-1
[313.753261] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[313.763279] Starting dynamic subtest: pipe-C-eDP-1
[313.782459] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[313.792463] Starting dynamic subtest: pipe-D-eDP-1
[313.811776] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[313.814042] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.150s)
[316.013893] [068/155] (704s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[316.073446] Subtest tiled-to-tiled: SKIP (0.000s)
[316.166120] [069/155] (703s left) gem_exec_reloc (basic-write-wc)
[316.225028] Subtest basic-write-wc: SKIP (0.000s)
[316.288847] [070/155] (703s left) dmabuf (all-tests)
[316.321278] Starting subtest: all-tests
[316.325692] Subtest all-tests: SKIP (0.000s)
[316.380570] [071/155] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[316.483789] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[320.903057] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.426s)
[322.127721] [072/155] (698s left) gem_ctx_param (basic)
[322.179801] Starting subtest: basic
[322.182234] Subtest basic: SUCCESS (0.001s)
[322.293441] [073/155] (697s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[322.384575] Starting subtest: y-tiled-16bpp-rotate-90
[322.388432] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[322.478084] [074/155] (697s left) kms_chamelium_frames (dp-crc-fast)
[322.870865] Subtest dp-crc-fast: SKIP (0.000s)
[323.730465] [075/155] (696s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[323.836930] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[323.840887] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[323.918570] [076/155] (696s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[324.015909] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[324.019940] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[324.124936] [077/155] (696s left) i915_drm_fdinfo (virtual-busy-hang-all)
[324.164487] Starting subtest: virtual-busy-hang-all
[324.168772] Subtest virtual-busy-hang-all: SKIP (0.000s)
[324.241589] [078/155] (696s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[324.329697] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[324.333763] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[324.434101] [079/155] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[324.532875] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[324.536967] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[324.634334] [080/155] (695s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[324.742387] Starting subtest: hdr-rgb565-draw-mmap-wc
[324.746233] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[324.843195] [081/155] (695s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[324.934978] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[324.946159] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[325.019973] [082/155] (695s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[325.104758] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[325.106745] Starting dynamic subtest: pipe-A-eDP-1
[325.154946] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[325.164509] Starting dynamic subtest: pipe-B-eDP-1
[325.213025] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[325.224378] Starting dynamic subtest: pipe-C-eDP-1
[325.271230] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[325.281823] Starting dynamic subtest: pipe-D-eDP-1
[325.329211] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[325.332625] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[327.406711] [083/155] (693s left) gem_create (create-ext-placement-sanity-check)
[327.579438] Starting subtest: create-ext-placement-sanity-check
[327.585058] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[327.695130] [084/155] (693s left) kms_flip (plain-flip-fb-recreate-interruptible)
[327.795900] Starting subtest: plain-flip-fb-recreate-interruptible
[327.798184] Starting dynamic subtest: A-eDP1
[336.701719] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[336.717826] Starting dynamic subtest: B-eDP1
[345.538210] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[345.551487] Starting dynamic subtest: C-eDP1
[354.354569] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[354.365889] Starting dynamic subtest: D-eDP1
[363.186305] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[363.190502] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.394s)
[364.369545] [085/155] (656s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[364.442949] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[364.503201] [086/155] (656s left) perf (oa-exponents)
[364.622207] Starting subtest: oa-exponents
[364.624465] Starting dynamic subtest: 0-rcs0
[366.402718] Dynamic subtest 0-rcs0: SUCCESS (1.781s)
[366.414704] Starting dynamic subtest: 1-vecs0
[368.231550] Dynamic subtest 1-vecs0: SUCCESS (1.828s)
[368.234307] Subtest oa-exponents: SUCCESS (3.611s)
[368.286958] [087/155] (652s left) gem_spin_batch (spin-each)
[368.349620] Starting subtest: spin-each
[371.626567] Subtest spin-each: SUCCESS (3.272s)
[371.988070] [088/155] (648s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[372.040083] Starting subtest: yf-tiled-ccs-to-yf-tiled
[372.044531] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[372.241034] [089/155] (648s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[372.334988] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[372.339320] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[372.428487] [090/155] (648s left) kms_rotation_crc (primary-rotation-270)
[372.513903] Starting subtest: primary-rotation-270
[372.518235] Subtest primary-rotation-270: SKIP (0.001s)
[372.601850] [091/155] (648s left) kms_vblank (query-forked-busy-hang)
[372.693446] Starting subtest: query-forked-busy-hang
[372.695364] Starting dynamic subtest: pipe-A-eDP-1
[398.653218] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.960s)
[398.669966] Starting dynamic subtest: pipe-D-eDP-1
[423.694622] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.037s)
[423.697008] Subtest query-forked-busy-hang: SUCCESS (51.002s)
[424.562477] [092/155] (596s left) kms_plane_alpha_blend (alpha-transparent-fb)
[424.659484] Starting subtest: alpha-transparent-fb
[424.945760] Starting dynamic subtest: pipe-A-eDP-1
[425.536538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[425.547840] Starting dynamic subtest: pipe-D-eDP-1
[426.916417] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.381s)
[426.919068] Subtest alpha-transparent-fb: SUCCESS (2.259s)
[427.783800] [093/155] (593s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[427.885350] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[427.889906] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[427.958778] [094/155] (593s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[428.049788] Starting subtest: hdr-shrfb-scaledprimary
[428.053793] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[428.137359] [095/155] (593s left) gem_exec_balancer (full-late-pulse)
[428.198225] Starting subtest: full-late-pulse
[432.834903] Subtest full-late-pulse: SUCCESS (4.637s)
[433.165195] [096/155] (588s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[433.270839] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[433.275335] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[433.362155] [097/155] (587s left) gem_exec_schedule (timeslicing)
[433.433007] Starting subtest: timeslicing
[433.435071] Starting dynamic subtest: rcs0
[433.443875] Dynamic subtest rcs0: SUCCESS (0.021s)
[433.457278] Starting dynamic subtest: bcs0
[433.463630] Dynamic subtest bcs0: SUCCESS (0.019s)
[433.474219] Starting dynamic subtest: vcs0
[433.485279] Dynamic subtest vcs0: SUCCESS (0.021s)
[433.496374] Starting dynamic subtest: vcs1
[433.506660] Dynamic subtest vcs1: SUCCESS (0.020s)
[433.522161] Starting dynamic subtest: vecs0
[433.530051] Dynamic subtest vecs0: SUCCESS (0.021s)
[433.542208] Starting dynamic subtest: ccs0
[433.550631] Dynamic subtest ccs0: SUCCESS (0.021s)
[433.552933] Subtest timeslicing: SUCCESS (0.128s)
[434.989767] [098/155] (586s left) api_intel_allocator (reopen)
[435.046418] Starting subtest: reopen
[435.048795] Subtest reopen: SUCCESS (0.003s)
[435.167993] [099/155] (586s left) kms_psr (psr2-sprite-plane-onoff)
[435.260298] Starting subtest: psr2-sprite-plane-onoff
[435.262576] Starting dynamic subtest: eDP-1
[436.983242] Dynamic subtest eDP-1: SUCCESS (1.723s)
[436.985631] Subtest psr2-sprite-plane-onoff: SUCCESS (1.724s)
[437.862230] [100/155] (583s left) sysfs_timeslice_duration (idempotent)
[437.913947] Starting subtest: idempotent
[437.916249] Starting dynamic subtest: vecs0
[437.918636] Dynamic subtest vecs0: SUCCESS (0.000s)
[437.931283] Starting dynamic subtest: ccs0
[437.933413] Dynamic subtest ccs0: SUCCESS (0.000s)
[437.943389] Starting dynamic subtest: vcs0
[437.945708] Dynamic subtest vcs0: SUCCESS (0.000s)
[437.956405] Starting dynamic subtest: bcs0
[437.958508] Dynamic subtest bcs0: SUCCESS (0.000s)
[437.968082] Starting dynamic subtest: rcs0
[437.970241] Dynamic subtest rcs0: SUCCESS (0.000s)
[437.979726] Starting dynamic subtest: vcs1
[437.981827] Dynamic subtest vcs1: SUCCESS (0.000s)
[437.983913] Subtest idempotent: SUCCESS (0.006s)
[438.022997] [101/155] (583s left) kms_plane (plane-panning-top-left)
[438.119410] Starting subtest: plane-panning-top-left
[438.121251] Starting dynamic subtest: pipe-A
[439.812923] Dynamic subtest pipe-A: SUCCESS (1.694s)
[439.825244] Starting dynamic subtest: pipe-B
[442.204891] Dynamic subtest pipe-B: SUCCESS (2.388s)
[442.207247] Subtest plane-panning-top-left: SUCCESS (4.085s)
[443.084815] [102/155] (578s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[443.193420] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[447.476197] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.289s)
[448.623067] [103/155] (572s left) syncobj_timeline (reset-during-wait-for-submit)
[448.674690] Starting subtest: reset-during-wait-for-submit
[448.777491] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[448.868802] [104/155] (572s left) kms_atomic (plane-invalid-params-fence)
[448.957337] Starting subtest: plane-invalid-params-fence
[448.959699] Starting dynamic subtest: pipe-A-eDP-1
[449.325760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[449.328020] Subtest plane-invalid-params-fence: SUCCESS (0.370s)
[450.159193] [105/155] (571s left) syncobj_timeline (transfer-timeline-point)
[450.219903] Starting subtest: transfer-timeline-point
[450.222213] Subtest transfer-timeline-point: SUCCESS (0.001s)
[450.320573] [106/155] (571s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[450.416946] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[450.421032] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[450.511460] [107/155] (571s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[450.615368] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[450.619303] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[450.718548] [108/155] (571s left) kms_frontbuffer_tracking (psr-1p-rte)
[450.810532] Starting subtest: psr-1p-rte
[456.147895] Subtest psr-1p-rte: SUCCESS (5.344s)
[456.275093] [109/155] (565s left) syncobj_wait (wait-all-snapshot)
[456.334269] Starting subtest: wait-all-snapshot
[456.417104] Subtest wait-all-snapshot: SUCCESS (0.082s)
[456.495428] [110/155] (565s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[456.552450] Starting subtest: etime-multi-wait-available-unsubmitted
[456.659731] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[456.737603] [111/155] (565s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[456.842027] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[456.846479] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[456.948122] [112/155] (565s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[457.067884] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[464.157638] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.094s)
[464.259238] [113/155] (557s left) gem_reg_read (timestamp-monotonic)
[464.314928] Starting subtest: timestamp-monotonic
[468.723190] Subtest timestamp-monotonic: SUCCESS (4.409s)
[468.799903] [114/155] (553s left) perf_pmu (event-wait)
[468.835513] Starting subtest: event-wait
[468.837830] Starting dynamic subtest: rcs0
[468.842447] Dynamic subtest rcs0: SKIP (0.000s)
[468.846904] Subtest event-wait: SKIP (0.001s)
[468.943509] [115/155] (553s left) gem_exec_params (larger-than-life-batch)
[468.991276] Starting subtest: larger-than-life-batch
[471.369723] Subtest larger-than-life-batch: SUCCESS (2.377s)
[471.997013] [116/155] (550s left) kms_cursor_edge_walk (256x256-right-edge)
[472.139093] Starting subtest: 256x256-right-edge
[472.141479] Starting dynamic subtest: pipe-A-eDP-1
[475.593859] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[475.605213] Starting dynamic subtest: pipe-D-eDP-1
[478.729729] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[478.732383] Subtest 256x256-right-edge: SUCCESS (6.592s)
[479.555536] [117/155] (542s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[479.661586] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[479.666238] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[479.761245] [118/155] (542s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[479.854040] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[479.857962] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[479.932799] [119/155] (542s left) kms_content_protection (dp-mst-type-0-hdcp14)
[480.068763] Starting subtest: dp-mst-type-0-hdcp14
[480.073120] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[480.193533] [120/155] (542s left) kms_prop_blob (blob-prop-lifetime)
[480.251104] Starting subtest: blob-prop-lifetime
[480.253318] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[480.347478] [121/155] (541s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[480.454579] Starting subtest: flip-vs-cursor-atomic-transitions
[488.414592] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.960s)
[489.274943] [122/155] (533s left) sw_sync (sync_merge_same)
[489.317698] Starting subtest: sync_merge_same
[489.319859] Subtest sync_merge_same: SUCCESS (0.000s)
[489.372574] [123/155] (533s left) kms_force_connector_basic (force-edid)
[489.446984] Starting subtest: force-edid
[489.764990] Subtest force-edid: SUCCESS (0.318s)
[489.906797] [124/155] (532s left) perf (per-context-mode-unprivileged)
[490.007714] Starting subtest: per-context-mode-unprivileged
[490.012117] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[490.053153] [125/155] (532s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[490.158911] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[490.163425] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[490.250872] [126/155] (532s left) syncobj_wait (invalid-single-wait-unsubmitted)
[490.311624] Starting subtest: invalid-single-wait-unsubmitted
[490.313919] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[490.418458] [127/155] (532s left) kms_color (degamma)
[490.515209] Starting subtest: degamma
[490.516861] Starting dynamic subtest: pipe-A-eDP-1
[491.241256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[491.253684] Starting dynamic subtest: pipe-B-eDP-1
[492.688494] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[492.699819] Starting dynamic subtest: pipe-C-eDP-1
[494.042658] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s)
[494.053622] Starting dynamic subtest: pipe-D-eDP-1
[495.448000] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[495.450414] Subtest degamma: SUCCESS (4.935s)
[496.299966] [128/155] (526s left) gem_mmap (bad-object)
[496.350939] Subtest bad-object: SKIP (0.000s)
[496.405561] [129/155] (526s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[496.501592] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[496.505879] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[496.604596] [130/155] (526s left) gem_softpin (evict-snoop)
[496.657835] Starting subtest: evict-snoop
[496.662648] Subtest evict-snoop: SKIP (0.000s)
[496.781625] [131/155] (525s left) kms_psr (pr-primary-mmap-gtt)
[496.872743] Starting subtest: pr-primary-mmap-gtt
[496.876987] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[496.950135] [132/155] (525s left) gem_exec_suspend (basic-s3)
[497.013569] Starting subtest: basic-S3
[497.016006] Starting dynamic subtest: smem
[518.237508] Dynamic subtest smem: SUCCESS (6.910s)
[518.240295] Subtest basic-S3: SUCCESS (6.913s)
[518.437222] [133/155] (504s left) gem_mmap_gtt (fault-concurrent)
[518.491712] Subtest fault-concurrent: SKIP (0.000s)
[518.554814] [134/155] (504s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[518.659105] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[518.663171] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[518.748289] [135/155] (504s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[518.854064] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[518.858191] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[518.945916] [136/155] (504s left) kms_debugfs (display-off-read-all)
[519.035408] Starting subtest: display-off-read-all
[519.328782] Subtest display-off-read-all: SUCCESS (0.295s)
[520.194756] [137/155] (502s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[520.315375] Starting subtest: basic-busy-flip-before-cursor-legacy
[520.319573] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[520.462275] [138/155] (502s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[520.554256] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[520.556625] Starting dynamic subtest: pipe-A-eDP-1
[520.581054] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[520.605000] Starting dynamic subtest: pipe-B-eDP-1
[520.628420] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[520.644911] Starting dynamic subtest: pipe-C-eDP-1
[520.666518] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[520.676920] Starting dynamic subtest: pipe-D-eDP-1
[520.698772] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[520.703155] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[522.790802] [139/155] (500s left) gen9_exec_parse (basic-rejected)
[522.852571] Subtest basic-rejected: SKIP (0.000s)
[522.926808] [140/155] (500s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[523.025270] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[523.029219] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[523.135856] [141/155] (500s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[523.239143] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[523.243551] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[523.342445] [142/155] (499s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[523.437072] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[523.441573] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[523.515742] [143/155] (499s left) kms_psr2_su (frontbuffer-xrgb8888)
[523.569355] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[523.625523] [144/155] (499s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[523.684863] Subtest writes-after-reads-uncached: SKIP (0.000s)
[523.755926] [145/155] (499s left) prime_self_import (basic-with_two_bos)
[523.791926] Starting subtest: basic-with_two_bos
[523.803611] Subtest basic-with_two_bos: SUCCESS (0.014s)
[523.899476] [146/155] (499s left) perf_pmu (busy-idle-check-all)
[523.937590] Starting subtest: busy-idle-check-all
[523.939335] Starting dynamic subtest: rcs0
[524.598487] Dynamic subtest rcs0: SUCCESS (0.661s)
[524.612883] Starting dynamic subtest: bcs0
[525.249742] Dynamic subtest bcs0: SUCCESS (0.649s)
[525.263852] Starting dynamic subtest: vcs0
[527.198496] Dynamic subtest vcs0: SUCCESS (1.943s)
[527.213114] Starting dynamic subtest: vcs1
[529.246301] Dynamic subtest vcs1: SUCCESS (2.043s)
[529.262593] Starting dynamic subtest: vecs0
[531.231235] Dynamic subtest vecs0: SUCCESS (1.980s)
[531.245518] Starting dynamic subtest: ccs0
[531.948783] Dynamic subtest ccs0: FAIL (0.647s)
[531.951152] Subtest busy-idle-check-all: FAIL (7.940s)
[531.996671] [147/155] (491s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[532.120364] Starting subtest: flip-vs-cursor-atomic
[539.645717] Subtest flip-vs-cursor-atomic: SUCCESS (7.523s)
[540.491157] [148/155] (482s left) prime_mmap (test_invalid_sync_flags)
[540.543029] Starting subtest: test_invalid_sync_flags
[540.545167] Starting dynamic subtest: test_invalid_sync_flags-smem
[540.547247] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[540.549308] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[540.646304] [149/155] (482s left) i915_query (query-topology-garbage-items)
[540.696506] Starting subtest: query-topology-garbage-items
[540.698398] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[540.793495] [150/155] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[540.897260] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[548.479163] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.586s)
[548.603333] [151/155] (475s left) kms_invalid_mode (zero-clock)
[548.691787] Starting subtest: zero-clock
[548.694054] Starting dynamic subtest: pipe-A-eDP-1
[548.976152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[548.988954] Starting dynamic subtest: pipe-B-eDP-1
[548.990926] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[549.002123] Starting dynamic subtest: pipe-C-eDP-1
[549.004413] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[549.015199] Starting dynamic subtest: pipe-D-eDP-1
[549.017433] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[549.019539] Subtest zero-clock: SUCCESS (0.290s)
[549.797503] [152/155] (473s left) api_intel_bb (reset-bb)
[549.853473] Starting subtest: reset-bb
[549.855988] Subtest reset-bb: SUCCESS (0.004s)
[549.984850] [153/155] (473s left) gem_ctx_param (vm)
[550.029020] Starting subtest: vm
[550.078666] Subtest vm: SUCCESS (0.049s)
[550.213716] [154/155] (473s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[550.303486] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[551.347884] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[551.458544] [155/155] (472s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[551.556536] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[551.558170] Starting dynamic subtest: pipe-A-eDP-1
[567.479306] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.358s)
[567.491895] Starting dynamic subtest: pipe-B-eDP-1
[584.465403] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.435s)
[584.476173] Starting dynamic subtest: pipe-C-eDP-1
[601.462276] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.364s)
[601.474730] Starting dynamic subtest: pipe-D-eDP-1
[618.445360] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.343s)
[618.447753] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.504s)
[619.687027] Closing watchdogs
results: parsing output: 0/ for test: gem_lmem_swapping
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: i915_hangman
results: parsing output: 5/ for test: kms_pipe_b_c_ivb
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_hdr
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: kms_pipe_crc_basic
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: prime_busy
results: parsing output: 19/ for test: prime_vgem
results: parsing output: 20/ for test: kms_frontbuffer_tracking
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_async_flips
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_dsc
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_pm_backlight
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: gem_wait
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: i915_pm_rpm
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gem_busy
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_set_tiling_vs_blt
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: dmabuf
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_chamelium_frames
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_create
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: gem_spin_batch
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: kms_plane_alpha_blend
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: sysfs_timeslice_duration
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_atomic
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_reg_read
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_cursor_edge_walk
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_content_protection
results: parsing output: 119/ for test: kms_prop_blob
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_force_connector_basic
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_color
results: parsing output: 127/ for test: gem_mmap
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_exec_suspend
results: parsing output: 132/ for test: gem_mmap_gtt
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_debugfs
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_ccs
results: parsing output: 138/ for test: gen9_exec_parse
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_flip_scaled_crc
results: parsing output: 142/ for test: kms_psr2_su
results: parsing output: 143/ for test: gem_partial_pwrite_pread
results: parsing output: 144/ for test: prime_self_import
results: parsing output: 145/ for test: perf_pmu
results: parsing output: 146/ for test: kms_cursor_legacy
results: parsing output: 147/ for test: prime_mmap
results: parsing output: 148/ for test: i915_query
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_invalid_mode
results: parsing output: 151/ for test: api_intel_bb
results: parsing output: 152/ for test: gem_ctx_param
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_ccs
Done.