[60.584304] Initializing watchdogs
[60.584351]   /dev/watchdog0
[60.598993] [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]
[60.604195] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.606496] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.609779] [001/133] (960s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[60.719281] Starting subtest: multiplane-rotation-cropping-top
[78.076906] Subtest multiplane-rotation-cropping-top: SUCCESS (17.383s)
[78.195688] [002/133] (942s left) kms_plane (plane-position-hole-dpms)
[78.315346] Starting subtest: plane-position-hole-dpms
[79.640298] Starting dynamic subtest: pipe-A-plane-1
[81.537881] Dynamic subtest pipe-A-plane-1: SUCCESS (1.896s)
[81.546340] Starting dynamic subtest: pipe-A-plane-2
[83.888032] Dynamic subtest pipe-A-plane-2: SUCCESS (2.351s)
[83.896746] Starting dynamic subtest: pipe-A-plane-3
[86.253075] Dynamic subtest pipe-A-plane-3: SUCCESS (2.364s)
[86.261265] Starting dynamic subtest: pipe-A-plane-4
[88.664202] Dynamic subtest pipe-A-plane-4: SUCCESS (2.412s)
[88.673042] Starting dynamic subtest: pipe-A-plane-5
[88.690691] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[89.912139] Starting dynamic subtest: pipe-B-plane-1
[92.364486] Dynamic subtest pipe-B-plane-1: SUCCESS (2.459s)
[92.374932] Starting dynamic subtest: pipe-B-plane-2
[94.839081] Dynamic subtest pipe-B-plane-2: SUCCESS (2.474s)
[94.848373] Starting dynamic subtest: pipe-B-plane-3
[97.300310] Dynamic subtest pipe-B-plane-3: SUCCESS (2.459s)
[97.308647] Starting dynamic subtest: pipe-B-plane-4
[99.734374] Dynamic subtest pipe-B-plane-4: SUCCESS (2.433s)
[99.742554] Starting dynamic subtest: pipe-B-plane-5
[99.760052] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[99.762351] Subtest plane-position-hole-dpms: SUCCESS (21.443s)
[100.546285] [003/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[100.646639] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[104.695262] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.052s)
[105.849556] [004/133] (915s left) syncobj_timeline (wait-any-complex)
[105.902368] Starting subtest: wait-any-complex
[105.964534] Subtest wait-any-complex: SUCCESS (0.063s)
[106.040975] [005/133] (915s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[106.163755] Starting subtest: cursorA-vs-flipA-toggle
[117.318449] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.151s)
[118.170234] [006/133] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[118.263750] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[118.268029] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[118.358668] [007/133] (902s left) kms_flip (2x-flip-vs-fences-interruptible)
[118.449532] Starting subtest: 2x-flip-vs-fences-interruptible
[118.453480] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[118.551731] [008/133] (902s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[118.617404] Starting subtest: basic-batch-kernel-default-cmd
[118.621844] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[118.815991] [009/133] (902s left) gem_exec_balancer (bonded-pair)
[118.875058] Starting subtest: bonded-pair
[118.879414] Subtest bonded-pair: SKIP (0.000s)
[119.175863] [010/133] (902s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[119.262782] Starting subtest: random-ccs-data-yf-tiled-ccs
[119.265007] Starting dynamic subtest: pipe-A-eDP-1
[119.289604] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.298882] Starting dynamic subtest: pipe-B-eDP-1
[119.322631] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.330344] Starting dynamic subtest: pipe-C-eDP-1
[119.354270] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.361604] Starting dynamic subtest: pipe-D-eDP-1
[119.385144] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.389398] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[121.537772] [011/133] (899s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[121.634283] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[128.501039] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.870s)
[128.622479] [012/133] (892s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[128.729611] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[128.734074] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[128.830689] [013/133] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[128.926291] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[128.930563] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[129.019975] [014/133] (892s left) api_intel_bb (blit-noreloc-keep-cache)
[129.072843] Starting subtest: blit-noreloc-keep-cache
[129.080769] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[129.200960] [015/133] (892s left) kms_force_connector_basic (force-edid)
[129.282318] Starting subtest: force-edid
[129.647021] Subtest force-edid: SUCCESS (0.365s)
[129.779605] [016/133] (891s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[129.883538] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[129.886711] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[129.954622] [017/133] (891s left) gem_exec_params (invalid-batch-start-offset)
[130.021951] Starting subtest: invalid-batch-start-offset
[130.027038] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[130.145444] [018/133] (891s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[130.236467] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[130.238336] Starting dynamic subtest: pipe-A-eDP-1
[136.014129] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.780s)
[136.023157] Starting dynamic subtest: pipe-B-eDP-1
[142.505790] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.488s)
[142.508106] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.271s)
[143.360405] [019/133] (878s left) gem_barrier_race (remote-request)
[143.409845] Starting subtest: remote-request
[143.412152] Starting dynamic subtest: rcs0
[148.634670] Dynamic subtest rcs0: SUCCESS (5.220s)
[148.639038] Subtest remote-request: SUCCESS (5.223s)
[148.771946] [020/133] (873s left) gem_exec_schedule (pi-ringfull)
[148.946043] Starting subtest: pi-ringfull
[148.967031] Starting dynamic subtest: rcs0
[149.023266] Dynamic subtest rcs0: SUCCESS (0.080s)
[149.031057] Starting dynamic subtest: bcs0
[149.053102] Dynamic subtest bcs0: SUCCESS (0.029s)
[149.060684] Starting dynamic subtest: vcs0
[149.084792] Dynamic subtest vcs0: SUCCESS (0.031s)
[149.092267] Starting dynamic subtest: vcs1
[149.117586] Dynamic subtest vcs1: SUCCESS (0.031s)
[149.129500] Starting dynamic subtest: vecs0
[149.146431] Dynamic subtest vecs0: SUCCESS (0.029s)
[149.154104] Starting dynamic subtest: ccs0
[149.177328] Dynamic subtest ccs0: SUCCESS (0.030s)
[149.179583] Subtest pi-ringfull: SUCCESS (0.235s)
[149.401554] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[149.405216] [021/133] (872s left) syncobj_timeline (etime-single-wait-all-submitted)
[149.455048] Starting subtest: etime-single-wait-all-submitted
[149.562581] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[149.640384] [022/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[149.727324] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[149.731629] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[149.817938] [023/133] (872s left) i915_drm_fdinfo (virtual-busy)
[149.863431] Starting subtest: virtual-busy
[149.867848] Subtest virtual-busy: SKIP (0.000s)
[149.939015] [024/133] (872s left) kms_async_flips (test-cursor-atomic)
[150.029572] Starting subtest: test-cursor-atomic
[150.414766] Starting dynamic subtest: pipe-A-eDP-1
[151.218842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[151.597643] Starting dynamic subtest: pipe-B-eDP-1
[152.416802] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.825s)
[152.793860] Starting dynamic subtest: pipe-C-eDP-1
[153.617119] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.829s)
[153.985220] Starting dynamic subtest: pipe-D-eDP-1
[154.735866] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.757s)
[154.738220] Subtest test-cursor-atomic: SUCCESS (4.708s)
[155.959860] [025/133] (866s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[156.096723] Starting subtest: verify-pxp-stale-buf-optout-execution
[157.155792] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.060s)
[157.296947] [026/133] (864s left) kms_chamelium_edid (vga-edid-read)
[157.678937] Subtest vga-edid-read: SKIP (0.000s)
[158.539706] [027/133] (863s left) prime_vgem (sync)
[158.606658] Starting subtest: sync
[158.608823] Starting dynamic subtest: rcs0
[158.641165] Dynamic subtest rcs0: SUCCESS (0.034s)
[158.648674] Starting dynamic subtest: bcs0
[158.686575] Dynamic subtest bcs0: SUCCESS (0.044s)
[158.694204] Starting dynamic subtest: vcs0
[158.734222] Dynamic subtest vcs0: SUCCESS (0.046s)
[158.741746] Starting dynamic subtest: vcs1
[158.780501] Dynamic subtest vcs1: SUCCESS (0.045s)
[158.787952] Starting dynamic subtest: vecs0
[158.826170] Dynamic subtest vecs0: SUCCESS (0.045s)
[158.834334] Starting dynamic subtest: ccs0
[158.870642] Dynamic subtest ccs0: SUCCESS (0.044s)
[158.872896] Subtest sync: SUCCESS (0.265s)
[158.980474] [028/133] (863s left) gem_exec_reloc (basic-write-gtt)
[159.049296] Subtest basic-write-gtt: SKIP (0.000s)
[159.125372] [029/133] (863s left) gem_spin_batch (resubmit)
[159.185231] Starting subtest: resubmit
[159.187604] Starting dynamic subtest: rcs0
[159.192660] Dynamic subtest rcs0: SUCCESS (0.006s)
[159.201335] Starting dynamic subtest: bcs0
[159.203485] Dynamic subtest bcs0: SUCCESS (0.002s)
[159.211129] Starting dynamic subtest: vcs0
[159.213201] Dynamic subtest vcs0: SUCCESS (0.002s)
[159.220608] Starting dynamic subtest: vcs1
[159.222764] Dynamic subtest vcs1: SUCCESS (0.005s)
[159.230119] Starting dynamic subtest: vecs0
[159.232232] Dynamic subtest vecs0: SUCCESS (0.003s)
[159.239468] Starting dynamic subtest: ccs0
[159.241649] Dynamic subtest ccs0: SUCCESS (0.005s)
[159.243867] Subtest resubmit: SUCCESS (0.029s)
[159.447917] [030/133] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[159.542571] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[167.180657] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.640s)
[167.304823] [031/133] (855s left) kms_color (ctm-max)
[167.397609] Starting subtest: ctm-max
[167.399741] Starting dynamic subtest: pipe-A-eDP-1
[168.107669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[168.116512] Starting dynamic subtest: pipe-B-eDP-1
[169.528736] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.419s)
[169.536452] Starting dynamic subtest: pipe-C-eDP-1
[170.876211] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[170.883938] Starting dynamic subtest: pipe-D-eDP-1
[172.282527] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[172.284868] Subtest ctm-max: SUCCESS (4.885s)
[173.162905] [032/133] (849s left) gem_ctx_param (basic-default)
[173.236517] Starting subtest: basic-default
[173.238845] Subtest basic-default: SUCCESS (0.000s)
[173.316615] [033/133] (849s left) i915_module_load (reload)
[173.357885] Starting subtest: reload
[179.290227] Subtest reload: SUCCESS (5.930s)
[179.328971] [034/133] (843s left) perf_pmu (most-busy-check-all)
[179.383172] Starting subtest: most-busy-check-all
[179.385637] Starting dynamic subtest: rcs0
[180.888077] Dynamic subtest rcs0: SUCCESS (1.506s)
[180.898290] Starting dynamic subtest: bcs0
[182.934348] Dynamic subtest bcs0: SUCCESS (2.043s)
[182.945232] Starting dynamic subtest: vcs0
[184.918078] Dynamic subtest vcs0: SUCCESS (1.981s)
[184.929629] Starting dynamic subtest: vcs1
[186.902060] Dynamic subtest vcs1: SUCCESS (1.981s)
[186.912928] Starting dynamic subtest: vecs0
[188.886109] Dynamic subtest vecs0: SUCCESS (1.981s)
[188.897727] Starting dynamic subtest: ccs0
[190.933731] Dynamic subtest ccs0: SUCCESS (2.045s)
[190.936606] Subtest most-busy-check-all: SUCCESS (11.552s)
[191.036926] [035/133] (831s left) kms_flip (modeset-vs-vblank-race)
[191.136510] Starting subtest: modeset-vs-vblank-race
[191.138913] Starting dynamic subtest: A-eDP1
[195.866888] Dynamic subtest A-eDP1: SUCCESS (4.730s)
[195.876863] Starting dynamic subtest: B-eDP1
[200.596466] Dynamic subtest B-eDP1: SUCCESS (4.727s)
[200.610952] Starting dynamic subtest: C-eDP1
[205.289013] Dynamic subtest C-eDP1: SUCCESS (4.690s)
[205.299266] Starting dynamic subtest: D-eDP1
[209.843282] Dynamic subtest D-eDP1: SUCCESS (4.551s)
[209.848291] Subtest modeset-vs-vblank-race: SUCCESS (18.713s)
[211.013129] [036/133] (811s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[211.116782] Starting subtest: psr-1p-pri-indfb-multidraw
[233.939201] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.825s)
[234.053781] [037/133] (788s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[234.109415] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[234.218086] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[234.298419] [038/133] (788s left) kms_cursor_crc (cursor-onscreen-512x512)
[234.573894] Starting subtest: cursor-onscreen-512x512
[234.578369] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[234.726539] [039/133] (787s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[234.815406] Starting subtest: 2x-flip-vs-rmfb-interruptible
[234.827465] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[234.909426] [040/133] (787s left) gem_exec_params (invalid-bsd1-flag-on-render)
[234.971287] Starting subtest: invalid-bsd1-flag-on-render
[234.973697] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[235.069782] [041/133] (787s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[235.124368] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[235.128820] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[235.307553] [042/133] (787s left) kms_psr (pr-cursor-render)
[235.396816] Starting subtest: pr-cursor-render
[235.401268] Subtest pr-cursor-render: SKIP (0.000s)
[235.474065] [043/133] (787s left) sysfs_heartbeat_interval (invalid)
[235.531274] Starting subtest: invalid
[235.533599] Starting dynamic subtest: vecs0
[235.535758] Dynamic subtest vecs0: SUCCESS (0.000s)
[235.544075] Starting dynamic subtest: ccs0
[235.546175] Dynamic subtest ccs0: SUCCESS (0.000s)
[235.553837] Starting dynamic subtest: vcs0
[235.555950] Dynamic subtest vcs0: SUCCESS (0.000s)
[235.563658] Starting dynamic subtest: bcs0
[235.565894] Dynamic subtest bcs0: SUCCESS (0.000s)
[235.573601] Starting dynamic subtest: rcs0
[235.575680] Dynamic subtest rcs0: SUCCESS (0.000s)
[235.583099] Starting dynamic subtest: vcs1
[235.584893] Dynamic subtest vcs1: SUCCESS (0.000s)
[235.587137] Subtest invalid: SUCCESS (0.007s)
[235.624255] [044/133] (787s left) gem_mmap (short-mmap)
[235.673284] Subtest short-mmap: SKIP (0.000s)
[235.739155] [045/133] (787s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[235.830070] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[235.832291] Starting dynamic subtest: pipe-A-eDP-1
[235.951726] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[235.960990] Starting dynamic subtest: pipe-B-eDP-1
[237.141066] Dynamic subtest pipe-B-eDP-1: SKIP (1.189s)
[237.145649] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.313s)
[238.342225] [046/133] (784s left) kms_properties (crtc-properties-atomic)
[238.429107] Starting subtest: crtc-properties-atomic
[238.431047] Starting dynamic subtest: pipe-A-eDP-1
[238.878389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[238.887196] Starting dynamic subtest: pipe-B-eDP-1
[240.009941] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[240.019110] Starting dynamic subtest: pipe-C-eDP-1
[241.140667] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[241.153130] Starting dynamic subtest: pipe-D-eDP-1
[242.260058] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[242.262345] Subtest crtc-properties-atomic: SUCCESS (3.832s)
[243.078402] [047/133] (779s left) gem_workarounds (basic-read-context)
[243.142060] Starting subtest: basic-read-context
[243.155936] Subtest basic-read-context: SUCCESS (0.013s)
[243.270871] [048/133] (779s left) gem_exec_balancer (smoke)
[243.337465] Starting subtest: smoke
[265.889770] Subtest smoke: SUCCESS (22.551s)
[266.824628] [049/133] (756s left) gem_wait (invalid-buf)
[266.886211] Starting subtest: invalid-buf
[266.888624] Subtest invalid-buf: SUCCESS (0.000s)
[267.134847] [050/133] (755s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[267.234479] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[267.237063] Starting dynamic subtest: pipe-A-eDP-1
[267.299229] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[267.309158] Starting dynamic subtest: pipe-B-eDP-1
[267.367082] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[267.376860] Starting dynamic subtest: pipe-C-eDP-1
[267.434339] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[267.443990] Starting dynamic subtest: pipe-D-eDP-1
[267.501763] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[267.505860] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.012s)
[269.526732] [051/133] (753s left) kms_dsc (dsc-with-bpc)
[269.618052] Starting subtest: dsc-with-bpc
[269.649105] Subtest dsc-with-bpc: SKIP (0.001s)
[269.691993] [052/133] (753s left) kms_addfb_basic (invalid-set-prop-any)
[269.749190] Starting subtest: invalid-set-prop-any
[269.751260] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[269.882436] [053/133] (753s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[269.932175] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[269.996320] [054/133] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[270.090281] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[270.094437] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[270.202807] [055/133] (753s left) kms_rotation_crc (sprite-rotation-270)
[270.290517] Starting subtest: sprite-rotation-270
[270.294609] Subtest sprite-rotation-270: SKIP (0.001s)
[270.363119] [056/133] (752s left) i915_pm_rpm (debugfs-read)
[272.085382] Starting subtest: debugfs-read
[273.255368] Subtest debugfs-read: SUCCESS (1.168s)
[273.627222] [057/133] (749s left) gem_softpin (noreloc)
[273.682407] Starting subtest: noreloc
[279.072083] Subtest noreloc: SUCCESS (5.391s)
[279.197835] [058/133] (744s left) kms_pm_rpm (modeset-pc8-residency-stress)
[281.035269] Starting subtest: modeset-pc8-residency-stress
[281.039972] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[281.467746] [059/133] (741s left) kms_content_protection (mei-interface)
[281.602943] Starting subtest: mei-interface
[281.607126] Subtest mei-interface: SKIP (0.001s)
[281.711287] [060/133] (741s left) gem_mmap_gtt (basic-short)
[281.762065] Subtest basic-short: SKIP (0.000s)
[281.831377] [061/133] (741s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[281.932529] Starting subtest: fbcpsr-tiling-y
[281.936585] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[282.032537] [062/133] (741s left) perf_pmu (busy-check-all)
[282.076696] Starting subtest: busy-check-all
[282.078530] Starting dynamic subtest: rcs0
[282.624375] Dynamic subtest rcs0: SUCCESS (0.549s)
[282.635358] Starting dynamic subtest: bcs0
[283.174663] Dynamic subtest bcs0: SUCCESS (0.548s)
[283.185216] Starting dynamic subtest: vcs0
[284.885366] Dynamic subtest vcs0: SUCCESS (1.706s)
[284.896428] Starting dynamic subtest: vcs1
[286.869338] Dynamic subtest vcs1: SUCCESS (1.981s)
[286.882295] Starting dynamic subtest: vecs0
[288.918412] Dynamic subtest vecs0: SUCCESS (2.046s)
[288.928071] Starting dynamic subtest: ccs0
[289.475228] Dynamic subtest ccs0: SUCCESS (0.555s)
[289.477804] Subtest busy-check-all: SUCCESS (7.401s)
[289.569802] [063/133] (734s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[289.697733] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[290.683276] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.985s)
[291.485245] [064/133] (732s left) api_intel_bb (offset-control)
[291.546055] Starting subtest: offset-control
[291.551864] Subtest offset-control: SUCCESS (0.008s)
[291.673398] [065/133] (732s left) kms_pm_rpm (dpms-lpsp)
[293.189532] Starting subtest: dpms-lpsp
[293.857069] Subtest dpms-lpsp: SUCCESS (0.667s)
[293.972799] [066/133] (729s left) kms_universal_plane (cursor-fb-leak)
[294.080651] Starting subtest: cursor-fb-leak
[294.083081] Starting dynamic subtest: pipe-A-eDP-1
[294.423528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.345s)
[294.434418] Starting dynamic subtest: pipe-B-eDP-1
[295.849830] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[295.866698] Starting dynamic subtest: pipe-C-eDP-1
[297.169568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s)
[297.180920] Starting dynamic subtest: pipe-D-eDP-1
[298.483677] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[298.486053] Subtest cursor-fb-leak: SUCCESS (4.407s)
[299.641982] [067/133] (724s left) gem_workarounds (basic-read-fd)
[299.719408] Starting subtest: basic-read-fd
[299.729752] Subtest basic-read-fd: SUCCESS (0.010s)
[299.851708] [068/133] (723s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[299.937597] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[299.939800] Starting dynamic subtest: pipe-A-eDP-1
[299.960960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.969691] Starting dynamic subtest: pipe-B-eDP-1
[299.990261] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.998329] Starting dynamic subtest: pipe-C-eDP-1
[300.020516] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[300.029076] Starting dynamic subtest: pipe-D-eDP-1
[300.054521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[300.058869] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[302.202743] [069/133] (721s left) syncobj_timeline (invalid-query-bad-pad)
[302.262512] Starting subtest: invalid-query-bad-pad
[302.264795] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[302.367528] [070/133] (721s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[302.451543] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[307.280750] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.833s)
[308.394984] [071/133] (715s left) gem_ctx_isolation (dirty-switch)
[308.453380] Starting subtest: dirty-switch
[308.455772] Starting dynamic subtest: rcs0
[308.637041] Dynamic subtest rcs0: SUCCESS (0.184s)
[308.646061] Starting dynamic subtest: bcs0
[308.842961] Dynamic subtest bcs0: SUCCESS (0.205s)
[308.852457] Starting dynamic subtest: vcs0
[309.049127] Dynamic subtest vcs0: SUCCESS (0.205s)
[309.059528] Starting dynamic subtest: vcs1
[311.130654] Dynamic subtest vcs1: SUCCESS (2.080s)
[311.141190] Starting dynamic subtest: vecs0
[313.125697] Dynamic subtest vecs0: SUCCESS (1.994s)
[313.138250] Starting dynamic subtest: ccs0
[315.116977] Dynamic subtest ccs0: SUCCESS (1.990s)
[315.119343] Subtest dirty-switch: SUCCESS (6.664s)
[315.360481] [072/133] (708s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[315.466115] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[315.468475] Starting dynamic subtest: pipe-A
[315.492286] Dynamic subtest pipe-A: SKIP (0.020s)
[315.503114] Starting dynamic subtest: pipe-B
[315.533390] Dynamic subtest pipe-B: SKIP (0.039s)
[315.543058] Starting dynamic subtest: pipe-C
[315.567663] Dynamic subtest pipe-C: SKIP (0.035s)
[315.576741] Starting dynamic subtest: pipe-D
[315.599697] Dynamic subtest pipe-D: SKIP (0.032s)
[315.604071] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.129s)
[315.703086] [073/133] (708s left) gem_exec_async (forked-writes)
[315.759708] Starting subtest: forked-writes
[315.762093] Starting dynamic subtest: rcs0
[315.787033] Dynamic subtest rcs0: SUCCESS (0.027s)
[315.797605] Starting dynamic subtest: bcs0
[315.810862] Dynamic subtest bcs0: SUCCESS (0.023s)
[315.823903] Starting dynamic subtest: vcs0
[315.832979] Dynamic subtest vcs0: SUCCESS (0.021s)
[315.841965] Starting dynamic subtest: vcs1
[315.856086] Dynamic subtest vcs1: SUCCESS (0.022s)
[315.864992] Starting dynamic subtest: vecs0
[315.880870] Dynamic subtest vecs0: SUCCESS (0.023s)
[315.891821] Starting dynamic subtest: ccs0
[315.905478] Dynamic subtest ccs0: SUCCESS (0.024s)
[315.907712] Subtest forked-writes: SUCCESS (0.146s)
[316.120479] [074/133] (707s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[316.215404] Starting subtest: fbc-1p-pri-indfb-multidraw
[329.012623] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.800s)
[330.401549] [075/133] (693s left) kms_getfb (getfb-handle-not-fb)
[330.496259] Starting subtest: getfb-handle-not-fb
[330.498598] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[330.592015] [076/133] (693s left) kms_lease (lease-again)
[330.698362] Starting subtest: lease-again
[330.700730] Starting dynamic subtest: pipe-A-eDP-1
[330.703158] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[330.714668] Starting dynamic subtest: pipe-B-eDP-1
[330.716506] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[330.724448] Starting dynamic subtest: pipe-C-eDP-1
[330.726306] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[330.734097] Starting dynamic subtest: pipe-D-eDP-1
[330.735901] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[330.737697] Subtest lease-again: SUCCESS (0.013s)
[330.813872] [077/133] (693s left) kms_pipe_crc_basic (bad-source)
[330.907230] Starting subtest: bad-source
[330.909119] Subtest bad-source: SUCCESS (0.000s)
[330.992479] [078/133] (693s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[331.084077] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[331.088248] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[331.167500] [079/133] (693s left) gem_render_tiled_blits (basic)
[331.223079] Subtest basic: SKIP (0.000s)
[331.297263] [080/133] (693s left) kms_flip (2x-flip-vs-dpms-on-nop)
[331.378603] Starting subtest: 2x-flip-vs-dpms-on-nop
[331.390115] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[331.468393] [081/133] (692s left) kms_vblank (ts-continuation-idle)
[331.563348] Starting subtest: ts-continuation-idle
[331.565182] Starting dynamic subtest: pipe-A-eDP-1
[331.970227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[331.984747] Starting dynamic subtest: pipe-D-eDP-1
[333.079757] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.109s)
[333.082039] Subtest ts-continuation-idle: SUCCESS (1.518s)
[333.941940] [082/133] (690s left) gem_mmap_offset (perf)
[333.993761] Starting subtest: perf
[333.996033] Starting dynamic subtest: smem0
[334.370881] Dynamic subtest smem0: SUCCESS (0.373s)
[334.373581] Subtest perf: SUCCESS (0.375s)
[334.518862] [083/133] (689s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[334.623245] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[334.625574] Starting dynamic subtest: pipe-A-eDP-1
[334.634598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[334.647708] Starting dynamic subtest: pipe-B-eDP-1
[334.656761] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[334.667080] Starting dynamic subtest: pipe-C-eDP-1
[334.675183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[334.683325] Starting dynamic subtest: pipe-D-eDP-1
[334.691437] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[334.695316] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[336.917884] [084/133] (687s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[337.014085] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[337.018275] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[337.115018] [085/133] (687s left) gem_ccs (large-ctrl-surf-copy)
[337.178793] Starting subtest: large-ctrl-surf-copy
[337.183363] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[337.267774] [086/133] (687s left) gem_wait (await)
[337.326298] Starting subtest: await
[337.328641] Starting dynamic subtest: all-engines
[338.446974] Dynamic subtest all-engines: SUCCESS (1.120s)
[338.456715] Starting dynamic subtest: rcs0
[339.511255] Dynamic subtest rcs0: SUCCESS (1.062s)
[339.528388] Starting dynamic subtest: bcs0
[340.573751] Dynamic subtest bcs0: SUCCESS (1.060s)
[340.591519] Starting dynamic subtest: vcs0
[341.632371] Dynamic subtest vcs0: SUCCESS (1.056s)
[341.648453] Starting dynamic subtest: vcs1
[342.689777] Dynamic subtest vcs1: SUCCESS (1.055s)
[342.706078] Starting dynamic subtest: vecs0
[343.743549] Dynamic subtest vecs0: SUCCESS (1.052s)
[343.759629] Starting dynamic subtest: ccs0
[344.808081] Dynamic subtest ccs0: SUCCESS (1.062s)
[344.810951] Subtest await: SUCCESS (7.483s)
[345.029069] [087/133] (679s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[345.118301] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[345.120492] Starting dynamic subtest: pipe-A-default-mode
[347.866664] Dynamic subtest pipe-A-default-mode: SUCCESS (2.744s)
[347.868688] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.747s)
[348.701641] [088/133] (675s left) syncobj_wait (wait-all-delayed-signal)
[348.758663] Starting subtest: wait-all-delayed-signal
[348.860923] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[348.939554] [089/133] (675s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[348.998162] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[349.000483] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[349.100418] [090/133] (675s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[349.210459] Starting subtest: psr-farfromfence-mmap-gtt
[349.214773] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[349.312222] [091/133] (675s left) gen9_exec_parse (basic-rejected-ctx-param)
[349.397073] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[349.472528] [092/133] (675s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[349.563743] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[349.565870] Starting dynamic subtest: pipe-A-eDP-1
[349.585276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[349.594209] Starting dynamic subtest: pipe-B-eDP-1
[349.613099] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[349.621046] Starting dynamic subtest: pipe-C-eDP-1
[349.639293] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[349.647433] Starting dynamic subtest: pipe-D-eDP-1
[349.666400] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[349.668579] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[351.862679] [093/133] (673s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[351.972040] Starting subtest: nonblocking-crc-frame-sequence
[351.974409] Starting dynamic subtest: pipe-A-eDP-1
[352.724336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[352.733805] Starting dynamic subtest: pipe-B-eDP-1
[354.169423] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[354.178767] Starting dynamic subtest: pipe-C-eDP-1
[355.587755] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.414s)
[355.596843] Starting dynamic subtest: pipe-D-eDP-1
[356.908843] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[356.911536] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.938s)
[357.709383] [094/133] (667s left) kms_psr (fbc-psr2-no-drrs)
[357.812413] Starting subtest: fbc-psr2-no-drrs
[357.814773] Starting dynamic subtest: eDP-1
[357.819181] Dynamic subtest eDP-1: SKIP (0.000s)
[357.823646] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[357.887697] [095/133] (667s left) kms_cursor_crc (cursor-sliding-32x32)
[358.030504] Starting subtest: cursor-sliding-32x32
[358.115107] Subtest cursor-sliding-32x32: SKIP (0.080s)
[358.439604] [096/133] (666s left) gem_render_copy_redux (flink)
[358.501059] Starting subtest: flink
[359.234270] Subtest flink: SUCCESS (0.736s)
[359.339892] [097/133] (665s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[359.438543] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[359.442280] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[359.543484] [098/133] (665s left) core_getversion (all-cards)
[359.589018] Starting subtest: all-cards
[359.597603] Subtest all-cards: SUCCESS (0.012s)
[359.636699] [099/133] (665s left) i915_query (query-topology-coherent-slice-mask)
[359.698337] Starting subtest: query-topology-coherent-slice-mask
[359.701815] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[359.816123] [100/133] (665s left) prime_self_import (basic-with_fd_dup)
[359.852844] Starting subtest: basic-with_fd_dup
[359.868276] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[359.960903] [101/133] (665s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[360.063994] Starting subtest: y-tiled-64bpp-rotate-270
[360.067770] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[360.167779] [102/133] (665s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[360.261276] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[360.264689] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[360.355103] [103/133] (664s left) i915_pm_sseu (full-enable)
[360.410612] Subtest full-enable: SKIP (0.000s)
[360.525427] [104/133] (664s left) gem_lmem_swapping (massive-random)
[360.571844] Subtest massive-random: SKIP (0.000s)
[360.609429] [105/133] (664s left) kms_plane (pixel-format-linear-modifier)
[360.709381] Starting subtest: pixel-format-linear-modifier
[360.735928] Starting dynamic subtest: pipe-A-plane-0
[364.347406] Dynamic subtest pipe-A-plane-0: SUCCESS (3.611s)
[364.364460] Starting dynamic subtest: pipe-A-plane-3
[366.091203] Dynamic subtest pipe-A-plane-3: SUCCESS (1.742s)
[366.099738] Starting dynamic subtest: pipe-A-plane-5
[366.302702] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[367.402093] Starting dynamic subtest: pipe-B-plane-0
[370.944824] Dynamic subtest pipe-B-plane-0: SUCCESS (3.555s)
[370.954179] Starting dynamic subtest: pipe-B-plane-3
[372.600468] Dynamic subtest pipe-B-plane-3: SUCCESS (1.655s)
[372.608996] Starting dynamic subtest: pipe-B-plane-5
[372.811454] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[373.134888] Subtest pixel-format-linear-modifier: SUCCESS (12.423s)
[373.976995] [106/133] (651s left) kms_psr (psr2-primary-mmap-gtt)
[374.091491] Starting subtest: psr2-primary-mmap-gtt
[374.093823] Starting dynamic subtest: eDP-1
[375.594039] Dynamic subtest eDP-1: SKIP (1.496s)
[375.599180] Subtest psr2-primary-mmap-gtt: SKIP (1.500s)
[375.748450] [107/133] (649s left) kms_psr (fbc-psr-primary-render)
[375.850448] Starting subtest: fbc-psr-primary-render
[375.852578] Starting dynamic subtest: eDP-1
[375.856415] Dynamic subtest eDP-1: SKIP (0.000s)
[375.860324] Subtest fbc-psr-primary-render: SKIP (0.001s)
[375.932549] [108/133] (649s left) gem_softpin (softpin)
[375.986916] Starting subtest: softpin
[408.274077] Subtest softpin: SUCCESS (32.281s)
[408.386761] [109/133] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[408.492893] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[408.497088] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[408.575950] [110/133] (617s left) kms_big_fb (x-tiled-addfb-size-overflow)
[408.666835] Starting subtest: x-tiled-addfb-size-overflow
[408.669128] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[408.750461] [111/133] (616s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[408.836299] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[408.840512] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[408.932252] [112/133] (616s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[408.992341] Subtest no-spare-fences-busy: SKIP (0.000s)
[409.057220] [113/133] (616s left) kms_rotation_crc (sprite-rotation-180)
[409.150985] Starting subtest: sprite-rotation-180
[415.916629] Subtest sprite-rotation-180: SUCCESS (6.769s)
[417.085268] [114/133] (608s left) kms_invalid_mode (bad-vtotal)
[417.173278] Starting subtest: bad-vtotal
[417.175374] Starting dynamic subtest: pipe-A-eDP-1
[417.460667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[417.469111] Starting dynamic subtest: pipe-B-eDP-1
[417.470936] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[417.478655] Starting dynamic subtest: pipe-C-eDP-1
[417.480526] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[417.488603] Starting dynamic subtest: pipe-D-eDP-1
[417.490745] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[417.492968] Subtest bad-vtotal: SUCCESS (0.294s)
[418.308208] [115/133] (607s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[418.369861] Starting subtest: legacy-engines-hostile-preempt
[418.372180] Starting dynamic subtest: render
[418.414882] Dynamic subtest render: SUCCESS (0.045s)
[418.425024] Starting dynamic subtest: bsd1
[419.905964] Dynamic subtest bsd1: SUCCESS (1.488s)
[419.921548] Starting dynamic subtest: bsd2
[421.884489] Dynamic subtest bsd2: SUCCESS (1.976s)
[421.896170] Starting dynamic subtest: blt
[421.958454] Dynamic subtest blt: SUCCESS (0.072s)
[421.969249] Starting dynamic subtest: vebox
[423.888612] Dynamic subtest vebox: SUCCESS (1.927s)
[423.891418] Subtest legacy-engines-hostile-preempt: SUCCESS (5.518s)
[423.991413] [116/133] (601s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[424.080213] Starting subtest: flip-vs-dpms-off-vs-modeset
[424.082459] Starting dynamic subtest: A-eDP1
[427.750331] Dynamic subtest A-eDP1: SUCCESS (3.668s)
[427.759134] Starting dynamic subtest: B-eDP1
[430.965785] Dynamic subtest B-eDP1: SUCCESS (3.213s)
[430.975143] Starting dynamic subtest: C-eDP1
[434.084202] Dynamic subtest C-eDP1: SUCCESS (3.119s)
[434.095425] Starting dynamic subtest: D-eDP1
[437.271343] Dynamic subtest D-eDP1: SUCCESS (3.187s)
[437.273824] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.193s)
[438.071925] [117/133] (587s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[438.175640] Starting subtest: 4-tiled-8bpp-rotate-90
[438.197329] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[438.314525] [118/133] (587s left) gem_ctx_param (invalid-size-get)
[438.374637] Starting subtest: invalid-size-get
[438.376943] Subtest invalid-size-get: SUCCESS (0.001s)
[438.486854] [119/133] (587s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[438.580213] Starting subtest: primary-yf-tiled-reflect-x-270
[438.584278] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[438.656678] [120/133] (587s left) kms_chamelium_frames (vga-frame-dump)
[439.064717] Subtest vga-frame-dump: SKIP (0.000s)
[439.891058] [121/133] (586s left) gem_mmap_wc (write-wc-read-gtt)
[439.948644] Subtest write-wc-read-gtt: SKIP (0.000s)
[440.012722] [122/133] (586s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[440.101905] Starting subtest: fbc-dirtyfb-ioctl
[440.104118] Starting dynamic subtest: A-eDP-1
[442.702762] Dynamic subtest A-eDP-1: SUCCESS (2.601s)
[442.705092] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.603s)
[443.581522] [123/133] (582s left) kms_big_fb (linear-8bpp-rotate-0)
[443.696236] Starting subtest: linear-8bpp-rotate-0
[444.901604] Subtest linear-8bpp-rotate-0: SUCCESS (1.207s)
[445.023701] [124/133] (581s left) gem_exec_whisper (basic-contexts-forked)
[445.077420] Starting subtest: basic-contexts-forked
[468.627885] Subtest basic-contexts-forked: SUCCESS (23.545s)
[468.822395] [125/133] (557s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[468.920921] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[468.925276] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[469.026895] [126/133] (557s left) kms_busy (extended-pageflip-hang-newfb)
[469.124611] Starting subtest: extended-pageflip-hang-newfb
[469.126837] Starting dynamic subtest: pipe-A
[495.668215] Dynamic subtest pipe-A: SUCCESS (26.543s)
[495.677769] Starting dynamic subtest: pipe-D
[510.773759] Dynamic subtest pipe-D: SUCCESS (15.102s)
[510.776131] Subtest extended-pageflip-hang-newfb: SUCCESS (41.650s)
[511.662207] [127/133] (514s left) gem_exec_fence (submit-chain)
[511.835909] Starting subtest: submit-chain
[511.850353] Subtest submit-chain: SUCCESS (0.019s)
[513.964365] [128/133] (512s left) gem_exec_reloc (basic-cpu-wc)
[514.015843] Subtest basic-cpu-wc: SKIP (0.000s)
[514.093843] [129/133] (512s left) gem_exec_schedule (promotion)
[514.169659] Starting subtest: promotion
[514.172024] Starting dynamic subtest: rcs0
[514.389580] Dynamic subtest rcs0: SUCCESS (0.218s)
[514.401448] Starting dynamic subtest: vcs0
[514.521078] Dynamic subtest vcs0: SUCCESS (0.131s)
[514.532717] Starting dynamic subtest: vcs1
[514.647584] Dynamic subtest vcs1: SUCCESS (0.126s)
[514.659792] Starting dynamic subtest: vecs0
[514.768590] Dynamic subtest vecs0: SUCCESS (0.120s)
[514.780237] Starting dynamic subtest: ccs0
[514.916582] Dynamic subtest ccs0: SUCCESS (0.148s)
[514.919441] Subtest promotion: SUCCESS (0.748s)
[516.025456] [130/133] (510s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[516.123237] Starting subtest: addfb25-y-tiled-small-legacy
[516.127635] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[516.217733] [131/133] (510s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[516.314606] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[516.318932] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[516.410108] [132/133] (510s left) kms_cursor_crc (cursor-random-512x170)
[516.716709] Starting subtest: cursor-random-512x170
[516.721159] Subtest cursor-random-512x170: SKIP (0.001s)
[516.854359] [133/133] (509s left) sw_sync (alloc_merge_fence)
[516.892994] Starting subtest: alloc_merge_fence
[516.895179] Subtest alloc_merge_fence: SUCCESS (0.000s)
[516.955179] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: kms_force_connector_basic
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: gem_barrier_race
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: gem_pxp
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: prime_vgem
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: gem_spin_batch
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_color
results: parsing output: 31/ for test: gem_ctx_param
results: parsing output: 32/ for test: i915_module_load
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: sysfs_heartbeat_interval
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_properties
results: parsing output: 46/ for test: gem_workarounds
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: gem_wait
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_dsc
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: kms_universal_plane
results: parsing output: 66/ for test: gem_workarounds
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ctx_isolation
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: gem_exec_async
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_getfb
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_pipe_crc_basic
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: gem_render_tiled_blits
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_vblank
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_ccs
results: parsing output: 85/ for test: gem_wait
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_pipe_crc_basic
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: gem_render_copy_redux
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: core_getversion
results: parsing output: 98/ for test: i915_query
results: parsing output: 99/ for test: prime_self_import
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: i915_pm_sseu
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_fenced_exec_thrash
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_ctx_param
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_chamelium_frames
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_dirtyfb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_exec_whisper
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_addfb_basic
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: sw_sync
Done.