[99.083289] Initializing watchdogs
[99.083340]   /dev/watchdog0
[99.099095] [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]
[99.103576] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[99.106321] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[99.108425] [001/156] (960s left) kms_addfb_basic (bad-pitch-0)
[99.157936] Starting subtest: bad-pitch-0
[99.158838] Subtest bad-pitch-0: SUCCESS (0.000s)
[99.297591] [002/156] (960s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[99.381202] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[99.382203] Starting dynamic subtest: pipe-A-eDP-1
[99.510253] Dynamic subtest pipe-A-eDP-1: SKIP (0.129s)
[99.519416] Starting dynamic subtest: pipe-B-eDP-1
[100.654755] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s)
[100.656907] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.274s)
[101.835070] [003/156] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[101.928657] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[101.930344] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[102.013650] [004/156] (957s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[102.057969] Starting subtest: multi-wait-for-submit-submitted-signaled
[102.058936] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[102.147067] [005/156] (957s left) kms_vblank (wait-forked-busy-hang)
[102.237800] Starting subtest: wait-forked-busy-hang
[102.238932] Starting dynamic subtest: pipe-A-eDP-1
[129.067992] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.828s)
[129.076363] Starting dynamic subtest: pipe-D-eDP-1
[144.106464] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.037s)
[144.107648] Subtest wait-forked-busy-hang: SUCCESS (41.869s)
[144.908273] [006/156] (914s left) gem_readwrite (read-write)
[144.956049] Subtest read-write: SKIP (0.000s)
[145.018782] [007/156] (914s left) gem_fenced_exec_thrash (no-spare-fences)
[145.085832] Subtest no-spare-fences: SKIP (0.000s)
[145.148083] [008/156] (914s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[145.238113] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[145.239887] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[145.345600] [009/156] (914s left) kms_universal_plane (disable-primary-vs-flip)
[145.431453] Starting subtest: disable-primary-vs-flip
[145.432448] Starting dynamic subtest: pipe-A-eDP-1
[146.988407] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.557s)
[146.998818] Starting dynamic subtest: pipe-B-eDP-1
[149.157311] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.168s)
[149.166339] Starting dynamic subtest: pipe-C-eDP-1
[151.345924] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.187s)
[151.354363] Starting dynamic subtest: pipe-D-eDP-1
[153.533595] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.187s)
[153.534599] Subtest disable-primary-vs-flip: SUCCESS (8.103s)
[154.334750] [010/156] (905s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[154.429937] Starting subtest: fbcpsrhdr-modesetfrombusy
[154.431944] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[154.512284] [011/156] (905s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[154.608588] Starting subtest: yf-tiled-64bpp-rotate-90
[154.610388] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[154.700725] [012/156] (905s left) prime_vgem (sync)
[154.792081] Starting subtest: sync
[154.793233] Starting dynamic subtest: rcs0
[154.829362] Dynamic subtest rcs0: SUCCESS (0.037s)
[154.835802] Starting dynamic subtest: bcs0
[154.885569] Dynamic subtest bcs0: SUCCESS (0.055s)
[154.892602] Starting dynamic subtest: vcs0
[154.933296] Dynamic subtest vcs0: SUCCESS (0.048s)
[154.939645] Starting dynamic subtest: vcs1
[154.979104] Dynamic subtest vcs1: SUCCESS (0.045s)
[154.985475] Starting dynamic subtest: vecs0
[155.025870] Dynamic subtest vecs0: SUCCESS (0.047s)
[155.032276] Starting dynamic subtest: ccs0
[155.071133] Dynamic subtest ccs0: SUCCESS (0.045s)
[155.072151] Subtest sync: SUCCESS (0.279s)
[155.187008] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[155.189170] [013/156] (904s left) kms_flip (2x-flip-vs-panning-vs-hang)
[155.280081] Starting subtest: 2x-flip-vs-panning-vs-hang
[155.282075] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[155.389777] [014/156] (904s left) gem_softpin (32b-excludes-last-page)
[155.434154] Starting subtest: 32b-excludes-last-page
[155.438424] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[155.558327] [015/156] (904s left) gem_ctx_engines (execute-one)
[155.614372] Starting subtest: execute-one
[157.758036] Subtest execute-one: SUCCESS (2.143s)
[158.343717] [016/156] (901s left) gem_mmap_gtt (medium-copy)
[158.385078] Subtest medium-copy: SKIP (0.000s)
[158.440200] [017/156] (901s left) perf_pmu (render-node-busy)
[158.504776] Starting subtest: render-node-busy
[158.506093] Starting dynamic subtest: rcs0
[159.076811] Dynamic subtest rcs0: SUCCESS (0.571s)
[159.086876] Starting dynamic subtest: bcs0
[159.641754] Dynamic subtest bcs0: SUCCESS (0.564s)
[159.651345] Starting dynamic subtest: vcs0
[161.321787] Dynamic subtest vcs0: SUCCESS (1.670s)
[161.331403] Starting dynamic subtest: vcs1
[163.305456] Dynamic subtest vcs1: SUCCESS (1.983s)
[163.315859] Starting dynamic subtest: vecs0
[165.354514] Dynamic subtest vecs0: SUCCESS (2.048s)
[165.363564] Starting dynamic subtest: ccs0
[165.915514] Dynamic subtest ccs0: SUCCESS (0.569s)
[165.916960] Subtest render-node-busy: SUCCESS (7.410s)
[165.999047] [018/156] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[166.095086] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[166.096797] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[166.196435] [019/156] (893s left) perf (non-zero-reason)
[166.323519] Starting subtest: non-zero-reason
[166.324376] Starting dynamic subtest: 0-rcs0
[172.025413] Dynamic subtest 0-rcs0: SUCCESS (5.656s)
[172.035185] Starting dynamic subtest: 1-vcs0
[176.075320] Dynamic subtest 1-vcs0: SUCCESS (4.047s)
[176.076974] Subtest non-zero-reason: SUCCESS (9.704s)
[176.106793] [020/156] (884s left) gem_mmap_wc (write-wc-read-gtt)
[176.162340] Subtest write-wc-read-gtt: SKIP (0.000s)
[176.221876] [021/156] (884s left) gem_set_tiling_vs_gtt
[176.324645] [022/156] (883s left) perf (per-context-mode-unprivileged)
[176.412134] Starting subtest: per-context-mode-unprivileged
[176.414185] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[176.446794] [023/156] (883s left) i915_pm_rpm (system-suspend-execbuf)
[178.493205] Starting subtest: system-suspend-execbuf
[237.704748] Subtest system-suspend-execbuf: SUCCESS (43.979s)
[238.084646] [024/156] (822s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[238.175078] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[238.176778] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[238.266356] [025/156] (822s left) prime_mmap_coherency (write)
[238.321295] Starting subtest: write
[243.739594] Subtest write: SUCCESS (5.373s)
[243.833660] [026/156] (816s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[243.922532] Starting subtest: fbcpsr-modesetfrombusy
[250.257976] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.337s)
[250.384280] [027/156] (810s left) gem_exec_schedule (pi-shared-iova)
[250.558454] Starting subtest: pi-shared-iova
[250.559563] Starting dynamic subtest: rcs0
[250.629779] Dynamic subtest rcs0: SUCCESS (0.078s)
[250.640405] Starting dynamic subtest: vcs0
[250.685486] Dynamic subtest vcs0: SUCCESS (0.054s)
[250.697385] Starting dynamic subtest: vcs1
[250.747228] Dynamic subtest vcs1: SUCCESS (0.062s)
[250.760062] Starting dynamic subtest: vecs0
[250.795893] Dynamic subtest vecs0: SUCCESS (0.049s)
[250.806235] Starting dynamic subtest: ccs0
[250.851099] Dynamic subtest ccs0: SUCCESS (0.054s)
[250.852343] Subtest pi-shared-iova: SUCCESS (0.299s)
[252.672978] [028/156] (807s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[252.763478] Starting subtest: hdr-2p-pri-indfb-multidraw
[252.765351] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[252.853749] [029/156] (807s left) kms_psr (fbc-pr-primary-blt)
[252.947574] Starting subtest: fbc-pr-primary-blt
[252.949468] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[253.015328] [030/156] (807s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[253.101586] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[253.103362] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[253.187989] [031/156] (807s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[253.295049] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[263.304613] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (10.000s)
[263.416313] [032/156] (797s left) kms_rotation_crc (sprite-rotation-90)
[263.500133] Starting subtest: sprite-rotation-90
[263.502332] Subtest sprite-rotation-90: SKIP (0.001s)
[263.595412] [033/156] (797s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[263.654945] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[263.773594] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[263.834337] [034/156] (796s left) kms_cursor_crc (cursor-offscreen-32x32)
[263.982959] Starting subtest: cursor-offscreen-32x32
[264.029422] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[264.301629] [035/156] (796s left) kms_addfb_basic (too-wide)
[264.388227] Starting subtest: too-wide
[264.389250] Subtest too-wide: SUCCESS (0.000s)
[264.493632] [036/156] (796s left) syncobj_wait (single-wait-all-signaled)
[264.540919] Starting subtest: single-wait-all-signaled
[264.542049] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[264.649163] [037/156] (796s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[264.733471] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[264.735361] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[264.826366] [038/156] (796s left) i915_drm_fdinfo (busy-idle-check-all)
[264.858983] Starting subtest: busy-idle-check-all
[264.859771] Starting dynamic subtest: rcs0
[264.864123] Dynamic subtest rcs0: SKIP (0.004s)
[264.873780] Starting dynamic subtest: bcs0
[264.875613] Dynamic subtest bcs0: SKIP (0.000s)
[264.886929] Starting dynamic subtest: vcs0
[264.888611] Dynamic subtest vcs0: SKIP (0.000s)
[264.896473] Starting dynamic subtest: vcs1
[264.898226] Dynamic subtest vcs1: SKIP (0.000s)
[264.906021] Starting dynamic subtest: vecs0
[264.907567] Dynamic subtest vecs0: SKIP (0.000s)
[264.915349] Starting dynamic subtest: ccs0
[264.917176] Dynamic subtest ccs0: SKIP (0.000s)
[264.918844] Subtest busy-idle-check-all: SKIP (0.009s)
[264.949240] [039/156] (795s left) syncobj_timeline (single-wait-available-submitted)
[265.019334] Starting subtest: single-wait-available-submitted
[265.020590] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[265.100803] [040/156] (795s left) api_intel_bb (crc32)
[265.145545] Starting subtest: crc32
[265.146322] Starting dynamic subtest: rcs0-smem0
[265.460976] Dynamic subtest rcs0-smem0: SUCCESS (0.305s)
[265.471711] Starting dynamic subtest: bcs0-smem0
[265.796179] Dynamic subtest bcs0-smem0: SUCCESS (0.343s)
[265.809100] Starting dynamic subtest: vcs0-smem0
[266.182680] Dynamic subtest vcs0-smem0: SUCCESS (0.376s)
[266.194900] Starting dynamic subtest: vcs1-smem0
[266.538622] Dynamic subtest vcs1-smem0: SUCCESS (0.354s)
[266.549844] Starting dynamic subtest: vecs0-smem0
[266.886646] Dynamic subtest vecs0-smem0: SUCCESS (0.346s)
[266.897843] Starting dynamic subtest: ccs0-smem0
[267.242821] Dynamic subtest ccs0-smem0: SUCCESS (0.355s)
[267.243953] Subtest crc32: SUCCESS (2.089s)
[267.370325] [041/156] (793s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[267.421824] Starting subtest: single-wait-all-for-submit-unsubmitted
[267.542111] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.109s)
[267.619464] [042/156] (793s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[267.721518] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[267.722608] Starting dynamic subtest: pipe-A-default-mode
[268.899924] Dynamic subtest pipe-A-default-mode: SKIP (1.176s)
[268.902538] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.178s)
[269.053134] [043/156] (791s left) kms_dp_link_training (uhbr-mst)
[269.139995] Starting subtest: uhbr-mst
[269.143387] Subtest uhbr-mst: SKIP (0.000s)
[269.218250] [044/156] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[269.316431] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[269.318274] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[269.396583] [045/156] (791s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[269.492019] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[269.493904] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[269.590367] [046/156] (791s left) gem_partial_pwrite_pread (reads-snoop)
[269.634137] Subtest reads-snoop: SKIP (0.000s)
[269.702767] [047/156] (791s left) gen9_exec_parse (basic-rejected-ctx-param)
[269.758537] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[269.826976] [048/156] (791s left) kms_psr (psr-primary-render)
[269.911992] Starting subtest: psr-primary-render
[269.913610] Starting dynamic subtest: eDP-1
[271.678163] Dynamic subtest eDP-1: SUCCESS (1.765s)
[271.679085] Subtest psr-primary-render: SUCCESS (1.766s)
[272.550442] [049/156] (788s left) gem_ctx_bad_destroy (double-destroy)
[272.599884] Starting subtest: double-destroy
[272.600731] Subtest double-destroy: SUCCESS (0.000s)
[272.662233] [050/156] (788s left) gem_ctx_persistence (hang)
[272.720795] Starting subtest: hang
[272.722667] Subtest hang: SKIP (0.000s)
[272.811657] [051/156] (788s left) kms_psr (psr2-cursor-blt)
[272.909271] Starting subtest: psr2-cursor-blt
[272.910282] Starting dynamic subtest: eDP-1
[274.632580] Dynamic subtest eDP-1: SUCCESS (1.722s)
[274.633720] Subtest psr2-cursor-blt: SUCCESS (1.723s)
[275.510063] [052/156] (785s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[275.748913] Starting subtest: cursor-rapid-movement-256x85
[275.796663] Subtest cursor-rapid-movement-256x85: SKIP (0.045s)
[275.961633] [053/156] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[276.052888] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[276.054467] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[276.136887] [054/156] (785s left) gem_eio (create-ext)
[276.355408] Starting subtest: create-ext
[276.673173] Subtest create-ext: SUCCESS (0.317s)
[276.783258] [055/156] (784s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[276.875002] Starting subtest: x-tiled-8bpp-rotate-0
[278.115074] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.240s)
[278.253504] [056/156] (783s left) kms_flip (flip-vs-rmfb-interruptible)
[278.354425] Starting subtest: flip-vs-rmfb-interruptible
[278.356473] Starting dynamic subtest: A-eDP1
[287.011903] Dynamic subtest A-eDP1: SUCCESS (8.654s)
[287.022126] Starting dynamic subtest: B-eDP1
[295.642906] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[295.653358] Starting dynamic subtest: C-eDP1
[304.265270] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[304.278485] Starting dynamic subtest: D-eDP1
[312.904603] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[312.907598] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.550s)
[314.083992] [057/156] (747s left) kms_pm_backlight (brightness-with-dpms)
[314.178786] Starting subtest: brightness-with-dpms
[314.230128] Starting dynamic subtest: eDP-1
[316.695783] Dynamic subtest eDP-1: SUCCESS (2.464s)
[316.696694] Subtest brightness-with-dpms: SUCCESS (2.517s)
[317.551318] [058/156] (743s left) kms_plane_multiple (2x-tiling-4)
[317.640066] Starting subtest: 2x-tiling-4
[317.641904] Subtest 2x-tiling-4: SKIP (0.000s)
[317.708776] [059/156] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[317.814413] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[317.816121] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[317.907403] [060/156] (743s left) kms_async_flips (alternate-sync-async-flip)
[317.996843] Starting subtest: alternate-sync-async-flip
[318.366402] Starting dynamic subtest: pipe-A-eDP-1
[321.142083] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.775s)
[321.516890] Starting dynamic subtest: pipe-B-eDP-1
[324.270792] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[324.665066] Starting dynamic subtest: pipe-C-eDP-1
[327.416976] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.760s)
[327.795037] Starting dynamic subtest: pipe-D-eDP-1
[330.548255] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[330.549350] Subtest alternate-sync-async-flip: SUCCESS (12.552s)
[331.731215] [061/156] (729s left) gem_exec_store (basic)
[331.790149] Starting subtest: basic
[331.882875] Subtest basic: SUCCESS (0.092s)
[332.066460] [062/156] (729s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[332.153879] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[332.155601] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[332.240742] [063/156] (729s left) gem_unref_active_buffers
[332.425163] [064/156] (729s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[332.514853] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[332.516723] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[332.604817] [065/156] (729s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[332.699009] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[340.252544] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.554s)
[340.371327] [066/156] (721s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[340.465070] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[340.466767] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[340.577046] [067/156] (721s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[340.665354] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[344.756477] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.094s)
[345.879774] [068/156] (716s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[345.962733] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[345.964347] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[346.073020] [069/156] (715s left) kms_invalid_mode (bad-vsync-start)
[346.151928] Starting subtest: bad-vsync-start
[346.152897] Starting dynamic subtest: pipe-A-eDP-1
[346.439072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[346.449457] Starting dynamic subtest: pipe-B-eDP-1
[346.450543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[346.459063] Starting dynamic subtest: pipe-C-eDP-1
[346.459988] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[346.468515] Starting dynamic subtest: pipe-D-eDP-1
[346.469623] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[346.470507] Subtest bad-vsync-start: SUCCESS (0.293s)
[347.307899] [070/156] (714s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[347.405268] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[348.494251] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[348.615838] [071/156] (713s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[348.702365] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[348.704292] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[348.785529] [072/156] (713s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[348.877467] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[348.878329] Starting dynamic subtest: pipe-A-eDP-1
[348.956722] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[348.967992] Starting dynamic subtest: pipe-B-eDP-1
[350.090610] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[350.092572] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.214s)
[351.379060] [073/156] (710s left) gem_exec_balancer (parallel-bb-first)
[351.640609] Starting subtest: parallel-bb-first
[352.670210] Subtest parallel-bb-first: SUCCESS (1.031s)
[353.596420] [074/156] (708s left) gem_mmap_gtt (fault-concurrent-y)
[353.640589] Subtest fault-concurrent-Y: SKIP (0.000s)
[353.694338] [075/156] (708s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[354.082670] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[354.885482] [076/156] (707s left) gem_softpin (allocator-evict)
[354.943978] Starting subtest: allocator-evict
[354.944931] Starting dynamic subtest: rcs0
[379.020122] Dynamic subtest rcs0: SUCCESS (24.073s)
[379.031395] Starting dynamic subtest: bcs0
[402.883743] Dynamic subtest bcs0: SUCCESS (23.860s)
[402.893520] Starting dynamic subtest: vcs0
[426.700669] Dynamic subtest vcs0: SUCCESS (23.815s)
[426.712429] Starting dynamic subtest: vcs1
[450.785257] Dynamic subtest vcs1: SUCCESS (24.084s)
[450.795918] Starting dynamic subtest: vecs0
[474.662381] Dynamic subtest vecs0: SUCCESS (23.875s)
[474.672482] Starting dynamic subtest: ccs0
[499.212785] Dynamic subtest ccs0: SUCCESS (24.548s)
[499.214376] Subtest allocator-evict: SUCCESS (144.263s)
[499.295070] [077/156] (562s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[499.431511] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[499.433301] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[499.527835] [078/156] (562s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[499.631328] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[499.633048] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[499.727523] [079/156] (562s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[499.832882] Starting subtest: 4-tiled-32bpp-rotate-270
[499.853108] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[499.978503] [080/156] (562s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[500.067999] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[500.069602] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[500.157444] [081/156] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[500.241446] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[506.797758] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.558s)
[506.907826] [082/156] (555s left) drm_read (short-buffer-wakeup)
[507.082190] Starting subtest: short-buffer-wakeup
[539.306057] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[539.424154] [083/156] (523s left) kms_pm_dc (dc5-dpms-negative)
[540.527732] Starting subtest: dc5-dpms-negative
[540.529531] Subtest dc5-dpms-negative: SKIP (0.000s)
[540.613081] [084/156] (521s left) kms_fbcon_fbt (psr)
[540.667751] Starting subtest: psr
[548.080948] Subtest psr: SUCCESS (7.404s)
[548.147974] [085/156] (514s left) gem_render_copy (yf-tiled-ccs-to-linear)
[548.202638] Starting subtest: yf-tiled-ccs-to-linear
[548.204760] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[548.383427] [086/156] (514s left) kms_getfb (getfb-handle-protection)
[548.474350] Starting subtest: getfb-handle-protection
[548.492894] Subtest getfb-handle-protection: SUCCESS (0.019s)
[548.604717] [087/156] (513s left) gem_bad_reloc (negative-reloc-lut)
[548.662506] Subtest negative-reloc-lut: SKIP (0.000s)
[548.725951] [088/156] (513s left) syncobj_basic (test-valid-cycle)
[548.770325] Starting subtest: test-valid-cycle
[548.771259] Subtest test-valid-cycle: SUCCESS (0.000s)
[548.872398] [089/156] (513s left) kms_prop_blob (invalid-get-prop-any)
[548.920522] Starting subtest: invalid-get-prop-any
[548.921535] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[549.023965] [090/156] (513s left) kms_flip (busy-flip)
[549.122339] Starting subtest: busy-flip
[549.123340] Starting dynamic subtest: A-eDP1
[550.795284] Dynamic subtest A-eDP1: SUCCESS (1.672s)
[550.807920] Starting dynamic subtest: B-eDP1
[552.524616] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[552.536502] Starting dynamic subtest: C-eDP1
[554.246313] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[554.261885] Starting dynamic subtest: D-eDP1
[555.983811] Dynamic subtest D-eDP1: SUCCESS (1.735s)
[555.986272] Subtest busy-flip: SUCCESS (6.865s)
[557.162376] [091/156] (505s left) gem_exec_schedule (u-submit-golden-slice)
[557.230253] Starting subtest: u-submit-golden-slice
[557.231308] Starting dynamic subtest: rcs0
[557.271648] Dynamic subtest rcs0: SUCCESS (0.041s)
[557.282125] Starting dynamic subtest: bcs0
[557.313771] Dynamic subtest bcs0: SUCCESS (0.041s)
[557.326631] Starting dynamic subtest: vcs0
[557.346151] Dynamic subtest vcs0: SUCCESS (0.031s)
[557.356547] Starting dynamic subtest: vcs1
[557.382367] Dynamic subtest vcs1: SUCCESS (0.036s)
[557.391609] Starting dynamic subtest: vecs0
[557.417405] Dynamic subtest vecs0: SUCCESS (0.034s)
[557.428523] Starting dynamic subtest: ccs0
[557.454984] Dynamic subtest ccs0: SUCCESS (0.036s)
[557.455929] Subtest u-submit-golden-slice: SUCCESS (0.225s)
[558.622061] [092/156] (504s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[558.754427] Starting subtest: dp-mst-lic-type-0-hdcp14
[558.756579] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[558.875684] [093/156] (503s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[558.973092] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[558.974838] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[559.086810] [094/156] (503s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[559.173225] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[559.174999] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[559.266703] [095/156] (503s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[559.362654] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[559.364278] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[559.429451] [096/156] (503s left) kms_frontbuffer_tracking (fbc-stridechange)
[559.522193] Starting subtest: fbc-stridechange
[563.103368] Subtest fbc-stridechange: SUCCESS (3.581s)
[564.241396] [097/156] (498s left) kms_chamelium_color (ctm-0-25)
[564.326715] Subtest ctm-0-25: SKIP (0.000s)
[564.369791] [098/156] (498s left) i915_query (query-topology-known-pci-ids)
[564.413750] Starting subtest: query-topology-known-pci-ids
[564.415599] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[564.502259] [099/156] (498s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[564.588713] Starting subtest: stress-xrgb8888-yftiled
[564.590668] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[564.667159] [100/156] (498s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[564.763113] Starting subtest: y-tiled-64bpp-rotate-90
[564.765108] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[564.855419] [101/156] (498s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[564.944979] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[564.945913] Starting dynamic subtest: pipe-A-eDP-1
[564.954620] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[564.964057] Starting dynamic subtest: pipe-B-eDP-1
[564.973286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[564.983164] Starting dynamic subtest: pipe-C-eDP-1
[564.991362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[565.000484] Starting dynamic subtest: pipe-D-eDP-1
[565.009390] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[565.010970] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[567.205538] [102/156] (495s left) gem_exec_flush (basic-wb-set-default)
[567.268877] Starting subtest: basic-wb-set-default
[572.722955] Subtest basic-wb-set-default: SUCCESS (5.455s)
[572.920855] [103/156] (490s left) kms_psr (fbc-psr-sprite-render)
[573.014186] Starting subtest: fbc-psr-sprite-render
[573.015100] Starting dynamic subtest: eDP-1
[573.016819] Dynamic subtest eDP-1: SKIP (0.000s)
[573.018367] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[573.085653] [104/156] (490s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[573.178280] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[573.179990] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[574.328893] [105/156] (488s left) gem_flink_basic (double-flink)
[574.378038] Starting subtest: double-flink
[574.379211] Subtest double-flink: SUCCESS (0.000s)
[574.507764] [106/156] (488s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[574.608848] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[574.610480] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[574.715677] [107/156] (488s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[574.806241] Starting subtest: psrhdr-farfromfence-mmap-gtt
[574.808125] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[574.906998] [108/156] (488s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[575.005859] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[575.007816] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[575.097517] [109/156] (488s left) gem_exec_reloc (basic-concurrent16)
[575.143640] Subtest basic-concurrent16: SKIP (0.000s)
[575.216026] [110/156] (488s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[575.311668] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[575.313311] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[575.401008] [111/156] (488s left) kms_flip (plain-flip-fb-recreate)
[575.483937] Starting subtest: plain-flip-fb-recreate
[575.484842] Starting dynamic subtest: A-eDP1
[584.332043] Dynamic subtest A-eDP1: SUCCESS (8.847s)
[584.343427] Starting dynamic subtest: B-eDP1
[593.165678] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[593.178978] Starting dynamic subtest: C-eDP1
[601.983599] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[601.995649] Starting dynamic subtest: D-eDP1
[610.813371] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[610.816476] Subtest plain-flip-fb-recreate: SUCCESS (35.331s)
[612.004183] [112/156] (451s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[612.097036] Starting subtest: extended-pageflip-modeset-hang-oldfb
[612.098019] Starting dynamic subtest: pipe-A
[620.002311] Dynamic subtest pipe-A: SUCCESS (7.903s)
[620.012129] Starting dynamic subtest: pipe-D
[628.614902] Dynamic subtest pipe-D: SUCCESS (8.611s)
[628.615815] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.518s)
[629.454416] [113/156] (434s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[629.548387] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[629.550242] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[629.638441] [114/156] (433s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[629.734672] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[629.736360] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[629.803613] [115/156] (433s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[629.901971] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[629.903811] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[629.986627] [116/156] (433s left) kms_psr (fbc-pr-sprite-plane-move)
[630.066900] Starting subtest: fbc-pr-sprite-plane-move
[630.068551] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[630.136731] [117/156] (433s left) kms_psr (psr2-suspend)
[630.222216] Starting subtest: psr2-suspend
[630.223178] Starting dynamic subtest: eDP-1
[648.743916] Dynamic subtest eDP-1: SUCCESS (4.025s)
[648.744832] Subtest psr2-suspend: SUCCESS (4.026s)
[660.693866] [118/156] (414s left) i915_module_load (resize-bar)
[660.727519] Starting subtest: resize-bar
[660.736025] Subtest resize-bar: SKIP (0.008s)
[660.780372] [119/156] (414s left) syncobj_timeline (etime-single-wait-all-submitted)
[660.828471] Starting subtest: etime-single-wait-all-submitted
[660.932420] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[661.010363] [120/156] (413s left) kms_draw_crc (draw-method-mmap-wc)
[661.110931] Starting subtest: draw-method-mmap-wc
[661.111864] Starting dynamic subtest: xrgb8888-untiled
[661.378591] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[661.390566] Starting dynamic subtest: rgb565-untiled
[661.612026] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[661.622300] Starting dynamic subtest: xrgb2101010-untiled
[661.834542] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[661.846016] Starting dynamic subtest: xbgr16161616f-untiled
[662.057430] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[662.067724] Starting dynamic subtest: xrgb8888-xtiled
[662.190924] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[662.200975] Starting dynamic subtest: rgb565-xtiled
[662.324731] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[662.334153] Starting dynamic subtest: xrgb2101010-xtiled
[662.458178] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[662.469018] Starting dynamic subtest: xbgr16161616f-xtiled
[662.591566] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[662.600795] Starting dynamic subtest: xrgb8888-4tiled
[662.747579] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[662.757836] Starting dynamic subtest: rgb565-4tiled
[662.903637] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[662.913753] Starting dynamic subtest: xrgb2101010-4tiled
[663.059401] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[663.069213] Starting dynamic subtest: xbgr16161616f-4tiled
[663.237577] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[663.239811] Subtest draw-method-mmap-wc: SUCCESS (2.125s)
[663.338377] [121/156] (411s left) syncobj_timeline (invalid-transfer-non-existent-point)
[663.381872] Starting subtest: invalid-transfer-non-existent-point
[663.382991] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[663.482684] [122/156] (411s left) gem_exec_flush (basic-wb-ro-default)
[663.537309] Starting subtest: basic-wb-ro-default
[669.001073] Subtest basic-wb-ro-default: SUCCESS (5.458s)
[669.186853] [123/156] (405s left) gem_exec_fence (concurrent)
[669.379130] Starting subtest: concurrent
[669.381397] Subtest concurrent: SKIP (0.000s)
[671.108844] [124/156] (403s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[671.211096] Starting subtest: plane-lut1d-ctm3x4
[671.381136] Starting dynamic subtest: pipe-A-plane-0
[671.548101] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[671.558491] Starting dynamic subtest: pipe-A-plane-1
[671.736958] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[671.748348] Starting dynamic subtest: pipe-A-plane-2
[671.926058] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[673.176685] Starting dynamic subtest: pipe-B-plane-0
[673.368054] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[673.379216] Starting dynamic subtest: pipe-B-plane-1
[673.567817] Dynamic subtest pipe-B-plane-1: SUCCESS (0.199s)
[673.578070] Starting dynamic subtest: pipe-B-plane-2
[673.757002] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[674.982581] Starting dynamic subtest: pipe-C-plane-0
[675.140206] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[675.151583] Starting dynamic subtest: pipe-C-plane-1
[675.307050] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[675.317832] Starting dynamic subtest: pipe-C-plane-2
[675.474370] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[676.752398] Starting dynamic subtest: pipe-D-plane-0
[676.909879] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[676.922911] Starting dynamic subtest: pipe-D-plane-1
[677.076815] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[677.087962] Starting dynamic subtest: pipe-D-plane-2
[677.243722] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[677.533433] Subtest plane-lut1d-ctm3x4: SUCCESS (6.318s)
[678.393168] [125/156] (396s left) gem_exec_params (sol-reset-invalid)
[678.446007] Starting subtest: sol-reset-invalid
[678.451903] Subtest sol-reset-invalid: SUCCESS (0.005s)
[680.127788] [126/156] (394s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[680.217677] Starting subtest: bad-rotation-90-yf-tiled-ccs
[680.218528] Starting dynamic subtest: pipe-A-eDP-1
[680.227156] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[680.237349] Starting dynamic subtest: pipe-B-eDP-1
[680.245775] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[680.255464] Starting dynamic subtest: pipe-C-eDP-1
[680.263710] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[680.272874] Starting dynamic subtest: pipe-D-eDP-1
[680.281100] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[680.282588] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[682.495934] [127/156] (392s left) syncobj_basic (bad-destroy)
[682.547857] Starting subtest: bad-destroy
[682.548784] Subtest bad-destroy: SUCCESS (0.000s)
[682.654980] [128/156] (392s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt)
[682.748831] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt
[682.750441] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[682.854897] [129/156] (392s left) kms_cursor_edge_walk (128x128-top-edge)
[682.949553] Starting subtest: 128x128-top-edge
[682.950511] Starting dynamic subtest: pipe-A-eDP-1
[686.443296] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[686.453729] Starting dynamic subtest: pipe-D-eDP-1
[689.578019] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[689.579026] Subtest 128x128-top-edge: SUCCESS (6.626s)
[690.385668] [130/156] (384s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[690.479921] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[690.481834] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[690.569899] [131/156] (384s left) gen7_exec_parse (basic-allocation)
[690.622455] Subtest basic-allocation: SKIP (0.000s)
[690.700511] [132/156] (384s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[690.779609] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[690.780704] Starting dynamic subtest: pipe-A-eDP-1
[693.168235] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.389s)
[693.179180] Starting dynamic subtest: pipe-B-eDP-1
[695.650977] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.482s)
[695.661677] Starting dynamic subtest: pipe-C-eDP-1
[697.969076] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.317s)
[697.980401] Starting dynamic subtest: pipe-D-eDP-1
[700.247968] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.278s)
[700.248909] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.471s)
[701.505746] [133/156] (373s left) gem_exec_alignment (single)
[701.559463] Starting subtest: single
[701.563128] Subtest single: SUCCESS (0.004s)
[701.686373] [134/156] (373s left) kms_async_flips (invalid-async-flip-atomic)
[701.775675] Starting subtest: invalid-async-flip-atomic
[702.160507] Starting dynamic subtest: pipe-A-eDP-1
[703.062326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.902s)
[703.442284] Starting dynamic subtest: pipe-B-eDP-1
[704.302096] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.871s)
[704.660009] Starting dynamic subtest: pipe-C-eDP-1
[705.531194] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.880s)
[705.890776] Starting dynamic subtest: pipe-D-eDP-1
[706.667991] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.787s)
[706.670549] Subtest invalid-async-flip-atomic: SUCCESS (4.895s)
[707.822864] [135/156] (367s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[707.922151] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[707.923893] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[708.005611] [136/156] (367s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[708.117410] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[709.618130] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.500s)
[710.488649] [137/156] (365s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[711.025400] Starting subtest: syncobj-timeline-invalid-wait
[711.026719] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[712.132165] [138/156] (363s left) gem_ctx_persistence (engines-persistence)
[712.182174] Starting subtest: engines-persistence
[712.183089] Starting dynamic subtest: rcs0
[712.946464] Dynamic subtest rcs0: SUCCESS (0.764s)
[712.960370] Starting dynamic subtest: bcs0
[713.696204] Dynamic subtest bcs0: SUCCESS (0.745s)
[713.709527] Starting dynamic subtest: vcs0
[714.489734] Dynamic subtest vcs0: SUCCESS (0.794s)
[714.503067] Starting dynamic subtest: vcs1
[715.253485] Dynamic subtest vcs1: SUCCESS (0.762s)
[715.266748] Starting dynamic subtest: vecs0
[716.023434] Dynamic subtest vecs0: SUCCESS (0.767s)
[716.036910] Starting dynamic subtest: ccs0
[716.768138] Dynamic subtest ccs0: SUCCESS (0.740s)
[716.769198] Subtest engines-persistence: SUCCESS (4.584s)
[716.886182] [139/156] (358s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[716.988346] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[720.735665] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.747s)
[721.896142] [140/156] (353s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[721.989839] Starting subtest: fbchdr-tiling-y
[721.991720] Subtest fbchdr-tiling-y: SKIP (0.000s)
[722.107321] [141/156] (353s left) gem_exec_whisper (basic-queues-priority-all)
[722.164115] Starting subtest: basic-queues-priority-all
[744.401793] Subtest basic-queues-priority-all: SUCCESS (22.223s)
[744.576345] [142/156] (331s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[744.669969] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[744.670866] Starting dynamic subtest: pipe-A
[744.690460] Dynamic subtest pipe-A: SKIP (0.018s)
[744.702783] Starting dynamic subtest: pipe-B
[744.725085] Dynamic subtest pipe-B: SKIP (0.035s)
[744.734628] Starting dynamic subtest: pipe-C
[744.762516] Dynamic subtest pipe-C: SKIP (0.036s)
[744.772134] Starting dynamic subtest: pipe-D
[744.797691] Dynamic subtest pipe-D: SKIP (0.035s)
[744.799325] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.127s)
[744.907713] [143/156] (330s left) gem_mmap_gtt (coherency)
[744.955007] Subtest coherency: SKIP (0.000s)
[745.014069] [144/156] (330s left) kms_chamelium_edid (dp-edid-read)
[745.398000] Subtest dp-edid-read: SKIP (0.000s)
[746.201566] [145/156] (329s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[746.290363] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[746.292075] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[746.391071] [146/156] (329s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[746.482129] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[751.249336] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.766s)
[752.455704] [147/156] (323s left) gem_exec_reloc (basic-cpu)
[752.507022] Subtest basic-cpu: SKIP (0.000s)
[752.569843] [148/156] (323s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[752.658326] Starting subtest: psr-rgb565-draw-render
[759.773232] Subtest psr-rgb565-draw-render: SUCCESS (7.115s)
[759.884652] [149/156] (316s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[760.003887] Starting subtest: flip-vs-cursor-atomic-transitions
[768.095773] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (8.093s)
[768.958517] [150/156] (307s left) sysfs_timeslice_duration (invalid)
[769.018005] Starting subtest: invalid
[769.019041] Starting dynamic subtest: vecs0
[769.019995] Dynamic subtest vecs0: SUCCESS (0.000s)
[769.032574] Starting dynamic subtest: ccs0
[769.033421] Dynamic subtest ccs0: SUCCESS (0.000s)
[769.043925] Starting dynamic subtest: vcs0
[769.044785] Dynamic subtest vcs0: SUCCESS (0.000s)
[769.054045] Starting dynamic subtest: bcs0
[769.054912] Dynamic subtest bcs0: SUCCESS (0.000s)
[769.064334] Starting dynamic subtest: rcs0
[769.065241] Dynamic subtest rcs0: SUCCESS (0.000s)
[769.074673] Starting dynamic subtest: vcs1
[769.075563] Dynamic subtest vcs1: SUCCESS (0.000s)
[769.076457] Subtest invalid: SUCCESS (0.006s)
[769.126724] [151/156] (306s left) gem_mmap_offset (pf-nonblock)
[769.180041] Starting subtest: pf-nonblock
[769.190188] Subtest pf-nonblock: SUCCESS (0.010s)
[769.301218] [152/156] (306s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[769.388984] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[776.830147] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.444s)
[776.959171] [153/156] (299s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[777.045985] Starting subtest: compare-crc-sanitycheck-nv12
[777.046954] Starting dynamic subtest: pipe-A-eDP-1
[777.778700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[777.788610] Starting dynamic subtest: pipe-B-eDP-1
[779.114845] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.334s)
[779.127810] Starting dynamic subtest: pipe-C-eDP-1
[780.390998] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.275s)
[780.400977] Starting dynamic subtest: pipe-D-eDP-1
[781.621206] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[781.622118] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.576s)
[782.438001] [154/156] (293s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[782.533350] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[783.413964] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: FAIL (0.676s)
[783.453609] [155/156] (292s left) api_intel_bb (reset-flags)
[783.505303] Starting subtest: reset-flags
[783.512739] Subtest reset-flags: SUCCESS (0.008s)
[783.637599] [156/156] (292s left) i915_query (query-regions-unallocated)
[783.686881] Starting subtest: query-regions-unallocated
[783.687758] Subtest query-regions-unallocated: SUCCESS (0.000s)
[783.788286] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: gem_readwrite
results: parsing output: 6/ for test: gem_fenced_exec_thrash
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_universal_plane
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: prime_vgem
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: gem_ctx_engines
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: gem_set_tiling_vs_gtt
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: i915_pm_rpm
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: prime_mmap_coherency
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_dp_link_training
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_ctx_bad_destroy
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_pm_backlight
results: parsing output: 57/ for test: kms_plane_multiple
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_exec_store
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_unref_active_buffers
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_invalid_mode
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: kms_chamelium_hpd
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: drm_read
results: parsing output: 82/ for test: kms_pm_dc
results: parsing output: 83/ for test: kms_fbcon_fbt
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_getfb
results: parsing output: 86/ for test: gem_bad_reloc
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: kms_prop_blob
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_content_protection
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_chamelium_color
results: parsing output: 97/ for test: i915_query
results: parsing output: 98/ for test: kms_pipe_stress
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: gem_flink_basic
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: gem_exec_reloc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: i915_module_load
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_draw_crc
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_color_pipeline
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_edge_walk
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gen7_exec_parse
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: gem_exec_alignment
results: parsing output: 133/ for test: kms_async_flips
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: gem_exec_fence
results: parsing output: 137/ for test: gem_ctx_persistence
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_exec_whisper
results: parsing output: 141/ for test: kms_plane_scaling
results: parsing output: 142/ for test: gem_mmap_gtt
results: parsing output: 143/ for test: kms_chamelium_edid
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_exec_reloc
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: sysfs_timeslice_duration
results: parsing output: 150/ for test: gem_mmap_offset
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_pipe_crc_basic
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: api_intel_bb
results: parsing output: 155/ for test: i915_query
Done.