[56.198326] Initializing watchdogs
[56.198435]   /dev/watchdog0
[56.211315] [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.215168] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.217379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.220776] [001/131] (960s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[56.385148] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[56.387562] Starting dynamic subtest: pipe-A-eDP-1
[56.411410] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[56.420078] Starting dynamic subtest: pipe-B-eDP-1
[56.441840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[56.450111] Starting dynamic subtest: pipe-C-eDP-1
[56.471827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[56.478880] Starting dynamic subtest: pipe-D-eDP-1
[56.500790] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[56.508251] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[58.568415] [002/131] (958s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[58.680448] Starting subtest: psr-rgb101010-draw-mmap-gtt
[58.684574] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[58.782496] [003/131] (958s left) kms_selftest (drm_plane_helper)
[58.820253] Starting subtest: drm_plane_helper
[58.827620] Starting dynamic subtest: drm_test_check_plane_state
[58.967241] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.139s)
[58.974898] Starting dynamic subtest: drm_test_check_invalid_plane_state
[59.116448] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.148s)
[59.118435] Subtest drm_plane_helper: SUCCESS (0.294s)
[59.292971] [004/131] (957s left) dumb_buffer (create-clear)
[59.352922] Starting subtest: create-clear
[99.904267] Subtest create-clear: SUCCESS (40.554s)
[100.010141] [005/131] (916s left) gem_eio (execbuf)
[100.186906] Starting subtest: execbuf
[100.407757] Subtest execbuf: SUCCESS (0.222s)
[100.582862] [006/131] (916s left) kms_plane (pixel-format-source-clamping)
[100.692872] Starting subtest: pixel-format-source-clamping
[100.734322] Starting dynamic subtest: pipe-A-plane-0
[105.389853] Dynamic subtest pipe-A-plane-0: SUCCESS (4.656s)
[105.398168] Starting dynamic subtest: pipe-A-plane-3
[107.611913] Dynamic subtest pipe-A-plane-3: SUCCESS (2.222s)
[107.618619] Starting dynamic subtest: pipe-A-plane-5
[107.620270] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[108.744049] Starting dynamic subtest: pipe-B-plane-0
[113.503871] Dynamic subtest pipe-B-plane-0: SUCCESS (4.767s)
[113.511156] Starting dynamic subtest: pipe-B-plane-3
[115.748314] Dynamic subtest pipe-B-plane-3: SUCCESS (2.244s)
[115.756473] Starting dynamic subtest: pipe-B-plane-5
[115.758413] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[116.059427] Subtest pixel-format-source-clamping: SUCCESS (15.364s)
[116.901109] [007/131] (900s left) kms_pm_rpm (modeset-non-lpsp)
[119.068531] Starting subtest: modeset-non-lpsp
[120.228077] Subtest modeset-non-lpsp: SKIP (1.156s)
[120.582502] [008/131] (896s left) i915_pm_rc6_residency (rc6-accuracy)
[120.649315] Starting subtest: rc6-accuracy
[120.651738] Starting dynamic subtest: gt0
[123.820582] Dynamic subtest gt0: SUCCESS (3.169s)
[123.829962] Starting dynamic subtest: gt1
[126.989097] Dynamic subtest gt1: SUCCESS (3.169s)
[126.991395] Subtest rc6-accuracy: SUCCESS (6.339s)
[127.053986] [009/131] (889s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[127.167551] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[130.224804] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (3.062s)
[130.370732] [010/131] (886s left) gem_exec_balancer (hang)
[130.626664] Starting subtest: hang
[132.134770] Subtest hang: SUCCESS (1.512s)
[132.275091] [011/131] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[132.383615] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[132.387998] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[132.493294] [012/131] (884s left) gen7_exec_parse (basic-allocation)
[132.559482] Subtest basic-allocation: SKIP (0.000s)
[132.638031] [013/131] (884s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[137.681789] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[137.686593] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[138.521830] [014/131] (878s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[138.586736] Starting subtest: invalid-bsd2-flag-on-blt
[138.589100] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[138.675041] [015/131] (878s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[138.736205] Starting subtest: multi-wait-all-for-submit-signaled
[138.738459] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[138.817482] [016/131] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[138.917229] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[138.921235] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[139.003807] [017/131] (878s left) gem_ctx_shared (create-shared-gtt)
[139.068805] Starting subtest: create-shared-gtt
[141.221695] Subtest create-shared-gtt: SUCCESS (2.151s)
[141.941843] [018/131] (875s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[142.053098] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[142.057457] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[142.165218] [019/131] (875s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[142.217098] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[142.219336] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[142.314433] [020/131] (875s left) kms_psr (psr2-sprite-plane-move)
[142.416216] Starting subtest: psr2-sprite-plane-move
[142.418656] Starting dynamic subtest: eDP-1
[144.132439] Dynamic subtest eDP-1: SUCCESS (1.715s)
[144.134771] Subtest psr2-sprite-plane-move: SUCCESS (1.716s)
[144.961444] [021/131] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[145.071689] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[145.075901] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[145.167032] [022/131] (872s left) kms_joiner (basic-ultra-joiner)
[145.276044] Starting subtest: basic-ultra-joiner
[145.280446] Subtest basic-ultra-joiner: SKIP (0.000s)
[145.334692] [023/131] (872s left) kms_prop_blob (invalid-set-prop-any)
[145.396303] Starting subtest: invalid-set-prop-any
[145.398208] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[145.500630] [024/131] (871s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[145.619308] Starting subtest: verify-pxp-key-change-after-suspend-resume
[152.679912] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.061s)
[152.799714] [025/131] (864s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[152.899345] Starting subtest: fbc-psr2-primary-mmap-gtt
[152.901710] Starting dynamic subtest: eDP-1
[152.905988] Dynamic subtest eDP-1: SKIP (0.000s)
[152.910271] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[152.967193] [026/131] (864s left) kms_plane_cursor (primary)
[153.057787] Starting subtest: primary
[153.062291] Starting dynamic subtest: pipe-A-eDP-1-size-64
[155.827647] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.769s)
[155.851588] Starting dynamic subtest: pipe-A-eDP-1-size-128
[158.673102] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.826s)
[158.697075] Starting dynamic subtest: pipe-A-eDP-1-size-256
[161.440234] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.749s)
[161.756566] Starting dynamic subtest: pipe-B-eDP-1-size-64
[165.242570] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.496s)
[165.267690] Starting dynamic subtest: pipe-B-eDP-1-size-128
[168.068053] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.804s)
[168.097450] Starting dynamic subtest: pipe-B-eDP-1-size-256
[170.900643] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.815s)
[171.212629] Starting dynamic subtest: pipe-C-eDP-1-size-64
[174.280087] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.074s)
[174.304818] Starting dynamic subtest: pipe-C-eDP-1-size-128
[176.713448] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.413s)
[176.738605] Starting dynamic subtest: pipe-C-eDP-1-size-256
[179.124256] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.390s)
[179.442055] Starting dynamic subtest: pipe-D-eDP-1-size-64
[182.505477] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.077s)
[182.530441] Starting dynamic subtest: pipe-D-eDP-1-size-128
[184.927167] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.402s)
[184.953374] Starting dynamic subtest: pipe-D-eDP-1-size-256
[187.339224] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.390s)
[187.645414] Subtest primary: SUCCESS (34.584s)
[188.446710] [027/131] (829s left) gem_exec_schedule (preempt-queue)
[188.521642] Subtest preempt-queue: SKIP (0.000s)
[188.809488] [028/131] (828s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[188.920192] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[188.922827] Starting dynamic subtest: pipe-A-eDP-1
[188.949089] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.959124] Starting dynamic subtest: pipe-B-eDP-1
[188.983329] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[188.991073] Starting dynamic subtest: pipe-C-eDP-1
[189.015245] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[189.022980] Starting dynamic subtest: pipe-D-eDP-1
[189.047709] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[189.051800] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[191.086662] [029/131] (826s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[191.149391] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[191.151698] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[191.237148] [030/131] (826s left) testdisplay
[191.610040] [031/131] (826s left) gem_eio (in-flight-internal-1us)
[191.848583] Starting subtest: in-flight-internal-1us
[193.012496] Subtest in-flight-internal-1us: SUCCESS (1.164s)
[193.166238] [032/131] (824s left) gen3_render_tiledy_blits
[193.293043] [033/131] (824s left) syncobj_basic (bad-pad-fd-to-handle)
[193.356765] Starting subtest: bad-pad-fd-to-handle
[193.358828] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[193.472831] [034/131] (824s left) gem_mmap_gtt (isolation)
[193.534120] Subtest isolation: SKIP (0.000s)
[193.600403] [035/131] (824s left) gem_userptr_blits (sync-unmap)
[193.673371] Starting subtest: sync-unmap
[193.687474] Subtest sync-unmap: SUCCESS (0.014s)
[193.829412] [036/131] (824s left) i915_selftest (mock)
[197.351528] Starting subtest: mock
[197.354094] Starting dynamic subtest: sanitycheck
[197.928754] Dynamic subtest sanitycheck: SUCCESS (0.577s)
[197.937772] Starting dynamic subtest: shmem
[198.533357] Dynamic subtest shmem: SUCCESS (0.603s)
[198.542457] Starting dynamic subtest: fence
[206.124076] Dynamic subtest fence: SUCCESS (7.588s)
[206.132472] Starting dynamic subtest: scatterlist
[207.721382] Dynamic subtest scatterlist: SUCCESS (1.595s)
[207.730533] Starting dynamic subtest: syncmap
[211.121609] Dynamic subtest syncmap: SUCCESS (3.398s)
[211.130779] Starting dynamic subtest: uncore
[211.730817] Dynamic subtest uncore: SUCCESS (0.608s)
[211.740307] Starting dynamic subtest: ring
[212.323245] Dynamic subtest ring: SUCCESS (0.591s)
[212.331962] Starting dynamic subtest: engine
[212.901053] Dynamic subtest engine: SUCCESS (0.576s)
[212.907627] Starting dynamic subtest: timelines
[216.455812] Dynamic subtest timelines: SUCCESS (3.552s)
[216.464724] Starting dynamic subtest: requests
[219.802047] Dynamic subtest requests: SUCCESS (3.345s)
[219.811061] Starting dynamic subtest: objects
[220.493531] Dynamic subtest objects: SUCCESS (0.689s)
[220.505939] Starting dynamic subtest: phys
[221.199950] Dynamic subtest phys: SUCCESS (0.704s)
[221.207548] Starting dynamic subtest: dmabuf
[221.866413] Dynamic subtest dmabuf: SUCCESS (0.664s)
[221.874749] Starting dynamic subtest: vma
[226.969978] Dynamic subtest vma: SUCCESS (5.102s)
[226.977568] Starting dynamic subtest: evict
[228.278093] Dynamic subtest evict: SUCCESS (1.306s)
[228.286071] Starting dynamic subtest: gtt
[231.371980] Dynamic subtest gtt: SUCCESS (3.092s)
[231.381031] Starting dynamic subtest: hugepages
[232.152419] Dynamic subtest hugepages: SUCCESS (0.778s)
[232.160666] Starting dynamic subtest: memory_region
[235.761227] Dynamic subtest memory_region: SUCCESS (3.607s)
[235.764143] Subtest mock: SUCCESS (38.410s)
[235.787949] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[235.791260] [037/131] (782s left) syncobj_timeline (signal-point-0)
[239.337500] Starting subtest: signal-point-0
[239.339616] Subtest signal-point-0: SUCCESS (0.000s)
[239.420422] [FACT syncobj_timeline (signal-point-0)] new: kernel.kmod_is_loaded.amdgpu: true
[239.420527] [FACT syncobj_timeline (signal-point-0)] new: kernel.kmod_is_loaded.i915: true
[239.421141] [FACT syncobj_timeline (signal-point-0)] new: kernel.kmod_is_loaded.xe: true
[239.424428] [038/131] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[239.542249] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[239.546181] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[239.647524] [039/131] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[239.756792] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[239.761066] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[239.838363] [040/131] (778s left) kms_addfb_basic (clobberred-modifier)
[239.894753] Starting subtest: clobberred-modifier
[239.899270] Subtest clobberred-modifier: SKIP (0.000s)
[240.011454] [041/131] (778s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[240.106560] Starting subtest: primary-yf-tiled-reflect-x-0
[240.174158] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.067s)
[240.267950] [042/131] (777s left) gem_userptr_blits (mmap-offset-banned)
[240.342817] Starting subtest: mmap-offset-banned
[240.344883] Starting dynamic subtest: wb
[240.346760] Dynamic subtest wb: SUCCESS (0.000s)
[240.353220] Starting dynamic subtest: wc
[240.354811] Dynamic subtest wc: SUCCESS (0.000s)
[240.361390] Starting dynamic subtest: uc
[240.363210] Dynamic subtest uc: SUCCESS (0.000s)
[240.365022] Subtest mmap-offset-banned: SUCCESS (0.002s)
[240.474961] [043/131] (777s left) kms_hdr (static-toggle-suspend)
[240.577915] Starting subtest: static-toggle-suspend
[240.583814] Subtest static-toggle-suspend: SKIP (0.000s)
[240.645180] [044/131] (777s left) gem_exec_create (basic)
[240.710054] Starting subtest: basic
[240.712093] Starting dynamic subtest: smem
[243.950862] Dynamic subtest smem: SUCCESS (3.238s)
[243.953978] Subtest basic: SUCCESS (3.239s)
[244.127478] [045/131] (774s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[244.233455] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[244.235737] Starting dynamic subtest: A-eDP1
[253.214506] Dynamic subtest A-eDP1: SUCCESS (8.979s)
[253.223474] Starting dynamic subtest: B-eDP1
[262.138618] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[262.149348] Starting dynamic subtest: C-eDP1
[271.049801] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[271.058837] Starting dynamic subtest: D-eDP1
[279.971403] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[279.973835] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.740s)
[281.185512] [046/131] (737s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[281.283190] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[281.285547] Starting dynamic subtest: pipe-A
[281.295088] Dynamic subtest pipe-A: SKIP (0.004s)
[281.303226] Starting dynamic subtest: pipe-B
[281.312834] Dynamic subtest pipe-B: SKIP (0.016s)
[281.322433] Starting dynamic subtest: pipe-C
[281.331940] Dynamic subtest pipe-C: SKIP (0.017s)
[281.339439] Starting dynamic subtest: pipe-D
[281.347883] Dynamic subtest pipe-D: SKIP (0.016s)
[281.351853] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.056s)
[281.448099] [047/131] (736s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[281.545852] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[281.548215] Starting dynamic subtest: pipe-A-eDP-1
[281.568277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[281.578612] Starting dynamic subtest: pipe-B-eDP-1
[281.598245] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[281.607189] Starting dynamic subtest: pipe-C-eDP-1
[281.626382] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[281.634428] Starting dynamic subtest: pipe-D-eDP-1
[281.654341] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[281.656564] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[283.750930] [048/131] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[283.857506] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[288.168862] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.315s)
[288.286897] [049/131] (730s left) gem_exec_whisper (basic-forked-all)
[288.354838] Starting subtest: basic-forked-all
[301.937979] Subtest basic-forked-all: SUCCESS (13.578s)
[302.115164] [050/131] (716s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[302.214330] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[302.216666] Starting dynamic subtest: pipe-A-eDP-1
[318.460109] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.421s)
[318.468943] Starting dynamic subtest: pipe-B-eDP-1
[335.343830] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.321s)
[335.352767] Starting dynamic subtest: pipe-C-eDP-1
[352.337529] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.312s)
[352.346194] Starting dynamic subtest: pipe-D-eDP-1
[369.324636] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.204s)
[369.326861] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.262s)
[370.533532] [051/131] (706s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[370.603403] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[370.678700] [052/131] (706s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[370.782131] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[370.794313] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[370.862692] [053/131] (706s left) gem_exec_flush (basic-wb-pro-default)
[370.921133] Starting subtest: basic-wb-pro-default
[376.425085] Subtest basic-wb-pro-default: SUCCESS (5.503s)
[376.603541] [054/131] (700s left) kms_chamelium_hpd (vga-hpd-fast)
[376.989103] Subtest vga-hpd-fast: SKIP (0.000s)
[377.836373] [055/131] (699s left) kms_cursor_crc (cursor-sliding-128x42)
[378.060015] Starting subtest: cursor-sliding-128x42
[378.100138] Subtest cursor-sliding-128x42: SKIP (0.033s)
[378.322764] [056/131] (699s left) gem_ccs (block-copy-compressed)
[378.389015] Starting subtest: block-copy-compressed
[378.394145] Subtest block-copy-compressed: SKIP (0.000s)
[378.495092] [057/131] (698s left) kms_lease (lease-get)
[378.586136] Starting subtest: lease-get
[378.588848] Starting dynamic subtest: pipe-A-eDP-1
[378.591367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[378.600180] Starting dynamic subtest: pipe-B-eDP-1
[378.603155] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[378.611988] Starting dynamic subtest: pipe-C-eDP-1
[378.614406] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[378.623009] Starting dynamic subtest: pipe-D-eDP-1
[378.625660] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[378.628235] Subtest lease-get: SUCCESS (0.009s)
[378.702890] [058/131] (698s left) api_intel_bb (object-reloc-purge-cache)
[378.766296] Starting subtest: object-reloc-purge-cache
[378.772154] Subtest object-reloc-purge-cache: SKIP (0.003s)
[378.858769] [059/131] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[378.971281] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[378.975870] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[379.079622] [060/131] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[379.189098] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[379.193080] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[379.299737] [061/131] (698s left) gem_exec_fence (basic-busy)
[379.483932] Starting subtest: basic-busy
[379.486695] Starting dynamic subtest: rcs0
[379.575608] Dynamic subtest rcs0: SUCCESS (0.091s)
[379.586297] Starting dynamic subtest: bcs0
[379.642410] Dynamic subtest bcs0: SUCCESS (0.065s)
[379.651777] Starting dynamic subtest: vcs0
[379.700360] Dynamic subtest vcs0: SUCCESS (0.056s)
[379.709273] Starting dynamic subtest: vcs1
[379.766219] Dynamic subtest vcs1: SUCCESS (0.064s)
[379.776211] Starting dynamic subtest: vecs0
[379.833631] Dynamic subtest vecs0: SUCCESS (0.066s)
[379.844770] Starting dynamic subtest: ccs0
[379.896696] Dynamic subtest ccs0: SUCCESS (0.061s)
[379.899710] Subtest basic-busy: SUCCESS (0.414s)
[381.854711] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[381.858736] [062/131] (695s left) drm_fdinfo (busy-check-all)
[381.900161] Starting subtest: busy-check-all
[381.903007] Starting dynamic subtest: rcs0
[381.910718] Dynamic subtest rcs0: SKIP (0.007s)
[381.919409] Starting dynamic subtest: bcs0
[381.924404] Dynamic subtest bcs0: SKIP (0.000s)
[381.932896] Starting dynamic subtest: vcs0
[381.937614] Dynamic subtest vcs0: SKIP (0.000s)
[381.945909] Starting dynamic subtest: vcs1
[381.950384] Dynamic subtest vcs1: SKIP (0.000s)
[381.958414] Starting dynamic subtest: vecs0
[381.963332] Dynamic subtest vecs0: SKIP (0.000s)
[381.971640] Starting dynamic subtest: ccs0
[381.976637] Dynamic subtest ccs0: SKIP (0.000s)
[381.981884] Subtest busy-check-all: SKIP (0.011s)
[382.013643] [063/131] (695s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[387.223412] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[387.225839] Starting dynamic subtest: pipe-A-eDP-1
[388.019549] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s)
[388.028215] Starting dynamic subtest: pipe-B-eDP-1
[389.243543] Dynamic subtest pipe-B-eDP-1: SKIP (1.220s)
[389.249104] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (2.017s)
[390.419546] [064/131] (687s left) kms_big_fb (linear-64bpp-rotate-180)
[390.543176] Starting subtest: linear-64bpp-rotate-180
[392.938723] Subtest linear-64bpp-rotate-180: SUCCESS (2.401s)
[393.202138] [065/131] (684s left) kms_psr (pr-primary-blt)
[393.296566] Starting subtest: pr-primary-blt
[393.302162] Subtest pr-primary-blt: SKIP (0.000s)
[393.365054] [066/131] (684s left) gem_ctx_exec (basic-norecovery)
[393.428441] Starting subtest: basic-norecovery
[393.777945] Subtest basic-norecovery: SUCCESS (0.348s)
[393.915641] [067/131] (683s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[393.976184] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[393.981310] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[394.155599] [068/131] (683s left) gem_exec_reloc (basic-gtt-active)
[394.217330] Subtest basic-gtt-active: SKIP (0.000s)
[394.270645] [069/131] (683s left) perf_pmu (invalid-open)
[394.318395] Starting subtest: invalid-open
[394.321279] Subtest invalid-open: SUCCESS (0.000s)
[394.437771] [070/131] (683s left) drm_read (fault-buffer)
[394.608273] Starting subtest: fault-buffer
[394.610783] Subtest fault-buffer: SUCCESS (0.000s)
[394.749221] [071/131] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[394.856649] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[399.159170] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.307s)
[399.266754] [072/131] (678s left) sysfs_timeslice_duration (timeout)
[399.334236] Starting subtest: timeout
[399.337209] Starting dynamic subtest: vecs0
[408.800404] Dynamic subtest vecs0: SUCCESS (9.463s)
[408.812002] Starting dynamic subtest: ccs0
[410.149092] Dynamic subtest ccs0: SUCCESS (1.350s)
[410.161256] Starting dynamic subtest: vcs0
[419.778709] Dynamic subtest vcs0: SUCCESS (9.625s)
[419.796169] Starting dynamic subtest: bcs0
[420.489962] Dynamic subtest bcs0: SUCCESS (0.710s)
[420.502060] Starting dynamic subtest: rcs0
[421.784404] Dynamic subtest rcs0: SUCCESS (1.295s)
[421.793224] Starting dynamic subtest: vcs1
[431.747247] Dynamic subtest vcs1: SUCCESS (9.962s)
[431.750365] Subtest timeout: SUCCESS (32.417s)
[431.823025] [073/131] (646s left) gem_exec_schedule (implicit-boths)
[431.894084] Starting subtest: implicit-boths
[431.896305] Starting dynamic subtest: rcs0
[432.081702] Dynamic subtest rcs0: SUCCESS (0.195s)
[432.093448] Starting dynamic subtest: vcs0
[432.242892] Dynamic subtest vcs0: SUCCESS (0.161s)
[432.254857] Starting dynamic subtest: vcs1
[432.358680] Dynamic subtest vcs1: SUCCESS (0.115s)
[432.368008] Starting dynamic subtest: vecs0
[432.472105] Dynamic subtest vecs0: SUCCESS (0.112s)
[432.483444] Starting dynamic subtest: ccs0
[432.609281] Dynamic subtest ccs0: SUCCESS (0.137s)
[432.612424] Subtest implicit-boths: SUCCESS (0.724s)
[433.821214] [074/131] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[433.933645] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[433.938250] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[434.022641] [075/131] (644s left) gem_exec_schedule (submit-early-slice)
[434.102904] Starting subtest: submit-early-slice
[434.105376] Starting dynamic subtest: rcs0
[434.134784] Dynamic subtest rcs0: SUCCESS (0.043s)
[434.144394] Starting dynamic subtest: bcs0
[434.175682] Dynamic subtest bcs0: SUCCESS (0.041s)
[434.186249] Starting dynamic subtest: vcs0
[434.215289] Dynamic subtest vcs0: SUCCESS (0.039s)
[434.224892] Starting dynamic subtest: vcs1
[434.255404] Dynamic subtest vcs1: SUCCESS (0.040s)
[434.265412] Starting dynamic subtest: vecs0
[434.290549] Dynamic subtest vecs0: SUCCESS (0.034s)
[434.301367] Starting dynamic subtest: ccs0
[434.330762] Dynamic subtest ccs0: SUCCESS (0.040s)
[434.333899] Subtest submit-early-slice: SUCCESS (0.240s)
[435.890090] [076/131] (642s left) kms_flip (2x-flip-vs-expired-vblank)
[435.990123] Starting subtest: 2x-flip-vs-expired-vblank
[436.001186] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[436.075432] [077/131] (642s left) kms_pm_backlight (brightness-with-dpms)
[436.176260] Starting subtest: brightness-with-dpms
[436.238196] Starting dynamic subtest: eDP-1
[438.652100] Dynamic subtest eDP-1: SUCCESS (2.411s)
[438.655107] Subtest brightness-with-dpms: SUCCESS (2.477s)
[439.511155] [078/131] (638s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[439.614063] Starting subtest: bad-pixel-format-y-tiled-ccs
[439.616509] Starting dynamic subtest: pipe-A-eDP-1
[439.645137] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[439.662166] Starting dynamic subtest: pipe-B-eDP-1
[439.688392] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[439.698404] Starting dynamic subtest: pipe-C-eDP-1
[439.724757] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[439.733767] Starting dynamic subtest: pipe-D-eDP-1
[439.759779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[439.764524] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[441.760132] [079/131] (636s left) syncobj_timeline (wait-all-delayed-signal)
[441.820220] Starting subtest: wait-all-delayed-signal
[441.922277] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[442.002217] [080/131] (636s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[442.110376] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[442.115195] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[442.208928] [081/131] (636s left) kms_cursor_crc (cursor-random-128x42)
[442.434392] Starting subtest: cursor-random-128x42
[442.476042] Subtest cursor-random-128x42: SKIP (0.034s)
[442.684015] [082/131] (635s left) perf_pmu (invalid-init)
[442.728412] Starting subtest: invalid-init
[442.791693] Subtest invalid-init: FAIL (0.011s)
[442.861880] [083/131] (635s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[442.966892] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[442.969010] Starting dynamic subtest: pipe-A-default-mode
[444.111384] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[444.117171] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.140s)
[444.248942] [084/131] (634s left) gem_flink_basic (bad-flink)
[444.311829] Starting subtest: bad-flink
[444.314393] Subtest bad-flink: SUCCESS (0.000s)
[444.416366] [085/131] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[444.531915] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[448.797425] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.268s)
[448.909942] [086/131] (629s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[449.023572] Starting subtest: 4-tiled-64bpp-rotate-90
[449.042447] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.018s)
[449.149608] [087/131] (629s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-different-formats)
[449.209660] Subtest fbc-dirty-rectangle-different-formats: SKIP (0.000s)
[449.261038] [088/131] (629s left) kms_pipe_crc_basic (bad-source)
[449.364377] Starting subtest: bad-source
[449.366786] Subtest bad-source: SUCCESS (0.000s)
[449.431657] [089/131] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[449.546725] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[454.856460] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.313s)
[454.998464] [090/131] (623s left) syncobj_wait (reset-signaled)
[455.062578] Starting subtest: reset-signaled
[455.065411] Subtest reset-signaled: SUCCESS (0.000s)
[455.174674] [091/131] (623s left) gem_mmap_offset (partial-remap)
[455.236023] Starting subtest: partial-remap
[455.238230] Starting dynamic subtest: smem0
[455.248874] Dynamic subtest smem0: SUCCESS (0.005s)
[455.251182] Subtest partial-remap: SUCCESS (0.005s)
[455.365553] [092/131] (623s left) gem_exec_params (invalid-bsd1-flag-on-render)
[455.421559] Starting subtest: invalid-bsd1-flag-on-render
[455.424797] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[455.535713] [093/131] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[455.649310] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[460.336636] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.692s)
[460.446894] [094/131] (618s left) gem_exec_params (invalid-flag)
[460.505105] Starting subtest: invalid-flag
[460.507958] Subtest invalid-flag: SUCCESS (0.000s)
[460.597752] [095/131] (618s left) kms_busy (extended-modeset-hang-oldfb)
[460.700807] Starting subtest: extended-modeset-hang-oldfb
[460.703205] Starting dynamic subtest: pipe-A
[472.542356] Dynamic subtest pipe-A: SUCCESS (11.837s)
[472.551949] Starting dynamic subtest: pipe-D
[484.798961] Dynamic subtest pipe-D: SUCCESS (12.255s)
[484.801868] Subtest extended-modeset-hang-oldfb: SUCCESS (24.096s)
[485.583576] [096/131] (593s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[485.680233] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[485.686209] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[485.759797] [097/131] (593s left) api_intel_allocator (two-level-inception-interruptible)
[485.815003] Starting subtest: two-level-inception-interruptible
[491.234511] Subtest two-level-inception-interruptible: SUCCESS (5.420s)
[491.310291] [098/131] (587s left) gem_madvise (dontneed-before-mmap)
[491.352029] Starting subtest: dontneed-before-mmap
[491.381416] Subtest dontneed-before-mmap: SUCCESS (0.034s)
[491.503145] [099/131] (587s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[491.630634] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[493.020838] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.673s)
[493.061309] [100/131] (585s left) gem_lmem_swapping (parallel-multi)
[493.112990] Subtest parallel-multi: SKIP (0.000s)
[493.153643] [101/131] (585s left) vgem_basic (mmap)
[493.200110] Starting subtest: mmap
[493.229227] Subtest mmap: SUCCESS (0.031s)
[493.290905] [102/131] (585s left) gem_ctx_persistence (heartbeat-close)
[493.359183] Starting subtest: heartbeat-close
[493.363875] Subtest heartbeat-close: SKIP (0.000s)
[493.473900] [103/131] (585s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[493.603198] Starting subtest: cursorA-vs-flipA-toggle
[504.762148] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.159s)
[505.605865] [104/131] (573s left) kms_psr (fbc-psr2-basic)
[505.702211] Starting subtest: fbc-psr2-basic
[505.704641] Starting dynamic subtest: eDP-1
[505.709377] Dynamic subtest eDP-1: SKIP (0.000s)
[505.714196] Subtest fbc-psr2-basic: SKIP (0.001s)
[505.768174] [105/131] (573s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[505.870604] Starting subtest: fbc-rgb565-draw-mmap-wc
[508.857018] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.991s)
[508.980440] [106/131] (570s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[509.076526] Starting subtest: fb-8bpc-vs-panel-6bpc
[509.078713] Starting dynamic subtest: pipe-A-eDP-1
[510.498104] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.419s)
[510.500657] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.420s)
[511.286348] [107/131] (567s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[511.836685] Starting subtest: syncobj-backward-timeline-chain-engines
[511.956137] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.119s)
[512.839722] [108/131] (566s left) kms_psr (psr2-primary-page-flip)
[512.931154] Starting subtest: psr2-primary-page-flip
[512.933986] Starting dynamic subtest: eDP-1
[514.665888] Dynamic subtest eDP-1: SUCCESS (1.733s)
[514.668375] Subtest psr2-primary-page-flip: SUCCESS (1.734s)
[515.538906] [109/131] (563s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[515.664000] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[515.795052] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.134s)
[515.928766] [110/131] (563s left) syncobj_wait (single-wait-all-signaled)
[515.994365] Starting subtest: single-wait-all-signaled
[515.997009] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[516.097884] [111/131] (563s left) gem_eio (create-ext)
[516.331257] Starting subtest: create-ext
[516.662049] Subtest create-ext: SUCCESS (0.331s)
[516.811742] [112/131] (562s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[516.912409] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[516.916990] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[517.007566] [113/131] (562s left) gem_set_tiling_vs_pwrite
[517.126764] [114/131] (562s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[517.238955] Starting subtest: x-tiled-8bpp-rotate-180
[518.430949] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.191s)
[518.585669] [115/131] (560s left) gen9_exec_parse (batch-zero-length)
[518.661217] Subtest batch-zero-length: SKIP (0.000s)
[518.743301] [116/131] (560s left) syncobj_timeline (etime-single-wait-submitted)
[518.805305] Starting subtest: etime-single-wait-submitted
[518.905462] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[518.977410] [117/131] (560s left) kms_vblank (wait-busy)
[519.081409] Starting subtest: wait-busy
[519.083731] Starting dynamic subtest: pipe-A-eDP-1
[520.967441] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[520.984625] Starting dynamic subtest: pipe-D-eDP-1
[523.491418] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[523.494148] Subtest wait-busy: SUCCESS (4.411s)
[524.285628] [118/131] (555s left) i915_pm_rpm (gem-mmap-type)
[525.938792] Starting subtest: gem-mmap-type
[525.941383] Starting dynamic subtest: wb-smem0
[529.913811] Dynamic subtest wb-smem0: SUCCESS (3.972s)
[529.923390] Starting dynamic subtest: wc-smem0
[533.052888] Dynamic subtest wc-smem0: SUCCESS (3.137s)
[533.062360] Starting dynamic subtest: uc-smem0
[536.137155] Dynamic subtest uc-smem0: SUCCESS (3.085s)
[536.139897] Subtest gem-mmap-type: SUCCESS (10.198s)
[536.231246] [119/131] (543s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[536.353245] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[536.358418] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[536.486704] [120/131] (543s left) kms_atomic_interruptible (universal-setplane-primary)
[536.586122] Starting subtest: universal-setplane-primary
[536.588760] Starting dynamic subtest: pipe-A-eDP-1
[544.018385] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.431s)
[544.021259] Subtest universal-setplane-primary: SUCCESS (7.432s)
[544.842778] [121/131] (534s left) kms_chamelium_edid (dp-edid-read)
[545.233885] Subtest dp-edid-read: SKIP (0.000s)
[546.045733] [122/131] (533s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[546.100386] Starting subtest: etime-multi-wait-available-unsubmitted
[546.201427] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.101s)
[546.273774] [123/131] (533s left) kms_async_flips (test-time-stamp)
[546.370218] Starting subtest: test-time-stamp
[546.741318] Starting dynamic subtest: pipe-A-eDP-1
[547.567228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[547.932612] Starting dynamic subtest: pipe-B-eDP-1
[548.692362] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[549.052994] Starting dynamic subtest: pipe-C-eDP-1
[549.812625] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[550.172025] Starting dynamic subtest: pipe-D-eDP-1
[550.940319] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[550.943140] Subtest test-time-stamp: SUCCESS (4.567s)
[552.091932] [124/131] (527s left) kms_vrr (flip-basic)
[552.198750] Starting subtest: flip-basic
[552.206255] Subtest flip-basic: SKIP (0.000s)
[552.267229] [125/131] (527s left) kms_chamelium_frames (hdmi-crc-multiple)
[552.643421] Subtest hdmi-crc-multiple: SKIP (0.000s)
[553.495689] [126/131] (526s left) kms_content_protection (atomic)
[553.675433] Starting subtest: atomic
[557.049028] Subtest atomic: SKIP (3.371s)
[558.225868] [127/131] (521s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[558.355138] Starting subtest: cursorA-vs-flipA-legacy
[569.511157] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.155s)
[570.349744] [128/131] (509s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[570.465329] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[570.470980] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[570.584716] [129/131] (509s left) kms_frontbuffer_tracking (basic)
[570.686722] Starting subtest: basic
[573.891423] Subtest basic: SUCCESS (3.209s)
[574.013412] [130/131] (506s left) perf_pmu (busy-accuracy-98)
[574.051646] Starting subtest: busy-accuracy-98
[574.053954] Starting dynamic subtest: rcs0
[577.100286] Dynamic subtest rcs0: SUCCESS (3.046s)
[577.110393] Starting dynamic subtest: bcs0
[580.166392] Dynamic subtest bcs0: SUCCESS (3.063s)
[580.183227] Starting dynamic subtest: vcs0
[583.217066] Dynamic subtest vcs0: SUCCESS (3.049s)
[583.227281] Starting dynamic subtest: vcs1
[586.265829] Dynamic subtest vcs1: SUCCESS (3.046s)
[586.277222] Starting dynamic subtest: vecs0
[589.310667] Dynamic subtest vecs0: SUCCESS (3.043s)
[589.320240] Starting dynamic subtest: ccs0
[592.374254] Dynamic subtest ccs0: SUCCESS (3.061s)
[592.376847] Subtest busy-accuracy-98: SUCCESS (18.321s)
[592.504836] [131/131] (487s left) prime_vgem (coherency-blt)
[592.569927] Starting subtest: coherency-blt
[594.819902] Subtest coherency-blt: SUCCESS (2.248s)
[594.950259] Closing watchdogs
Done.