[58.497663] Initializing watchdogs
[58.497710]   /dev/watchdog0
[58.513128] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.518006] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.520733] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.524060] [001/156] (960s left) gem_ctx_persistence (legacy-engines-hostile)
[58.602426] Starting subtest: legacy-engines-hostile
[58.604686] Starting dynamic subtest: render
[58.732137] Dynamic subtest render: SUCCESS (0.129s)
[58.740851] Starting dynamic subtest: bsd1
[58.823897] Dynamic subtest bsd1: SUCCESS (0.089s)
[58.834787] Starting dynamic subtest: bsd2
[58.923815] Dynamic subtest bsd2: SUCCESS (0.098s)
[58.934688] Starting dynamic subtest: blt
[59.022695] Dynamic subtest blt: SUCCESS (0.097s)
[59.032860] Starting dynamic subtest: vebox
[59.118717] Dynamic subtest vebox: SUCCESS (0.094s)
[59.121769] Subtest legacy-engines-hostile: SUCCESS (0.515s)
[59.209311] [002/156] (959s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[59.317531] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[59.321972] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[59.409253] [003/156] (959s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[59.509159] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[59.511114] Starting dynamic subtest: pipe-A-eDP-1
[59.530964] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.539916] Starting dynamic subtest: pipe-B-eDP-1
[59.558062] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.565048] Starting dynamic subtest: pipe-C-eDP-1
[59.582998] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.589853] Starting dynamic subtest: pipe-D-eDP-1
[59.607914] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.611550] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[62.068444] [004/156] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[62.183909] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[68.834629] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.641s)
[68.968253] [005/156] (950s left) kms_properties (colorop-properties-legacy)
[69.061677] Starting subtest: colorop-properties-legacy
[69.064090] Starting dynamic subtest: pipe-A-eDP-1
[69.456068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.392s)
[69.466712] Starting dynamic subtest: pipe-B-eDP-1
[70.523963] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.068s)
[70.532636] Starting dynamic subtest: pipe-C-eDP-1
[71.641474] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[71.649633] Starting dynamic subtest: pipe-D-eDP-1
[72.770491] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[72.772875] Subtest colorop-properties-legacy: SUCCESS (3.707s)
[73.576123] [006/156] (945s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[73.701534] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[73.703765] Starting dynamic subtest: pipe-A-eDP-1
[73.725459] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.735158] Starting dynamic subtest: pipe-B-eDP-1
[73.755611] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.762629] Starting dynamic subtest: pipe-C-eDP-1
[73.783233] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.790233] Starting dynamic subtest: pipe-D-eDP-1
[73.810788] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.815046] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[76.046707] [007/156] (943s left) api_intel_allocator (fork-simple-stress)
[76.105175] Starting subtest: fork-simple-stress
[81.505220] Subtest fork-simple-stress: SUCCESS (5.397s)
[81.624427] [008/156] (937s left) gem_mmap (short-mmap)
[81.683188] Subtest short-mmap: SKIP (0.000s)
[81.747280] [009/156] (937s left) sw_sync (sync_expired_merge)
[81.779593] Starting subtest: sync_expired_merge
[82.855587] Subtest sync_expired_merge: SUCCESS (1.074s)
[82.916352] [010/156] (936s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[83.043201] Starting subtest: 2x-cursor-vs-flip-atomic
[83.047861] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[83.186240] [011/156] (936s left) gem_bad_reloc (negative-reloc)
[83.251436] Subtest negative-reloc: SKIP (0.000s)
[83.333988] [012/156] (936s left) perf_pmu (render-node-busy)
[83.421561] Starting subtest: render-node-busy
[83.424165] Starting dynamic subtest: rcs0
[84.023501] Dynamic subtest rcs0: SUCCESS (0.604s)
[84.033245] Starting dynamic subtest: bcs0
[84.587833] Dynamic subtest bcs0: SUCCESS (0.563s)
[84.597032] Starting dynamic subtest: vcs0
[86.309624] Dynamic subtest vcs0: SUCCESS (1.719s)
[86.319256] Starting dynamic subtest: vcs1
[88.293830] Dynamic subtest vcs1: SUCCESS (1.983s)
[88.303608] Starting dynamic subtest: vecs0
[90.342856] Dynamic subtest vecs0: SUCCESS (2.047s)
[90.353773] Starting dynamic subtest: ccs0
[90.913510] Dynamic subtest ccs0: SUCCESS (0.570s)
[90.915958] Subtest render-node-busy: SUCCESS (7.494s)
[90.986857] [013/156] (928s left) i915_fb_tiling (basic-x-tiling)
[91.047418] Subtest basic-x-tiling: SKIP (0.000s)
[91.103619] [014/156] (928s left) kms_cursor_crc (cursor-offscreen-32x10)
[91.270714] Starting subtest: cursor-offscreen-32x10
[91.319009] Subtest cursor-offscreen-32x10: SKIP (0.044s)
[91.592997] [015/156] (927s left) gem_mmap_gtt (basic-write-read-distinct)
[91.650273] Subtest basic-write-read-distinct: SKIP (0.000s)
[91.706892] [016/156] (927s left) kms_chamelium_color (ctm-0-50)
[91.801364] Subtest ctm-0-50: SKIP (0.000s)
[91.844264] [017/156] (927s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[91.940059] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[91.943875] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[92.017273] [018/156] (927s left) kms_big_fb (linear-32bpp-rotate-0)
[92.115748] Starting subtest: linear-32bpp-rotate-0
[93.649396] Subtest linear-32bpp-rotate-0: SUCCESS (1.534s)
[93.791205] [019/156] (925s left) gem_tiled_partial_pwrite_pread (reads)
[93.861825] Subtest reads: SKIP (0.000s)
[93.924821] [020/156] (925s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[94.035039] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[94.038467] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[94.132129] [021/156] (925s left) gem_exec_schedule (u-fairslice)
[94.208941] Starting subtest: u-fairslice
[94.210798] Starting dynamic subtest: rcs0
[96.235814] Dynamic subtest rcs0: SUCCESS (2.027s)
[96.248303] Starting dynamic subtest: bcs0
[98.254955] Dynamic subtest bcs0: SUCCESS (2.019s)
[98.266323] Starting dynamic subtest: vcs0
[100.284706] Dynamic subtest vcs0: SUCCESS (2.015s)
[100.296619] Starting dynamic subtest: vcs1
[102.287911] Dynamic subtest vcs1: SUCCESS (2.015s)
[102.300456] Starting dynamic subtest: vecs0
[104.307273] Dynamic subtest vecs0: SUCCESS (2.019s)
[104.316119] Starting dynamic subtest: ccs0
[106.328047] Dynamic subtest ccs0: SUCCESS (2.019s)
[106.330398] Subtest u-fairslice: SUCCESS (12.118s)
[106.619196] [022/156] (913s left) gem_mmap_gtt (fault-concurrent-y)
[106.681825] Subtest fault-concurrent-Y: SKIP (0.000s)
[106.739119] [023/156] (913s left) kms_chamelium_frames (hdmi-crc-multiple)
[107.123281] Subtest hdmi-crc-multiple: SKIP (0.000s)
[107.960607] [024/156] (911s left) kms_cursor_crc (cursor-sliding-max-size)
[108.264980] Starting subtest: cursor-sliding-max-size
[108.271721] Subtest cursor-sliding-max-size: SKIP (0.000s)
[108.383891] [025/156] (911s left) gem_softpin (evict-active)
[108.439056] Starting subtest: evict-active
[108.443932] Subtest evict-active: SUCCESS (0.005s)
[108.554701] [026/156] (911s left) gem_exec_balancer (bonded-chain)
[108.610568] Starting subtest: bonded-chain
[115.652704] Subtest bonded-chain: SUCCESS (7.040s)
[115.968413] [027/156] (904s left) kms_atomic (atomic-invalid-params)
[116.066159] Starting subtest: atomic-invalid-params
[116.068550] Starting dynamic subtest: pipe-A-eDP-1
[116.456075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[116.458016] Subtest atomic-invalid-params: SUCCESS (0.391s)
[117.309609] [028/156] (902s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[117.422530] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[117.426716] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[117.522730] [029/156] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[117.613402] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[125.035659] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.429s)
[125.182561] [030/156] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[125.280438] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[125.284693] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[125.384481] [031/156] (894s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[125.482606] Starting subtest: fbc-rgb101010-draw-pwrite
[128.764546] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.287s)
[129.963411] [032/156] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[130.068455] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[130.072605] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[130.162990] [033/156] (890s left) gem_ctx_engines (invalid-engines)
[130.227774] Starting subtest: invalid-engines
[130.235107] Subtest invalid-engines: SUCCESS (0.010s)
[130.458945] [034/156] (889s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[130.548764] Starting subtest: fbchdr-modesetfrombusy
[130.553171] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[130.653240] [035/156] (889s left) kms_cursor_crc (cursor-random-32x10)
[130.810516] Starting subtest: cursor-random-32x10
[130.860225] Subtest cursor-random-32x10: SKIP (0.045s)
[131.108216] [036/156] (889s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[131.203814] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[131.208155] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[131.270627] [037/156] (889s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[131.366683] Starting subtest: yf-tiled-8bpp-rotate-0
[131.370552] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[131.470278] [038/156] (888s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[131.520998] Starting subtest: invalid-multi-wait-unsubmitted
[131.523074] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[131.628221] [039/156] (888s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move)
[131.715894] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move
[131.719692] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[131.808896] [040/156] (888s left) kms_color (ctm-0-25)
[131.891240] Starting subtest: ctm-0-25
[131.892872] Starting dynamic subtest: pipe-A-eDP-1
[135.471077] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.580s)
[135.484896] Starting dynamic subtest: pipe-B-eDP-1
[139.777724] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.305s)
[139.786876] Starting dynamic subtest: pipe-C-eDP-1
[143.846056] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.069s)
[143.855481] Starting dynamic subtest: pipe-D-eDP-1
[147.839050] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.990s)
[147.841019] Subtest ctm-0-25: SUCCESS (15.946s)
[148.673916] [041/156] (871s left) gem_pread (exhaustion)
[148.735804] Subtest exhaustion: SKIP (0.000s)
[148.791553] [042/156] (871s left) perf (blocking)
[148.933758] Starting subtest: blocking
[148.936073] Starting dynamic subtest: 0-rcs0
[158.946380] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[158.956365] Starting dynamic subtest: 1-vcs0
[168.971143] Dynamic subtest 1-vcs0: SUCCESS (10.024s)
[168.973790] Subtest blocking: SUCCESS (20.036s)
[169.018875] [043/156] (851s left) i915_suspend (forcewake)
[169.077141] Starting subtest: forcewake
[202.764168] Subtest forcewake: SUCCESS (3.191s)
[213.850525] [044/156] (817s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[213.948920] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[213.951216] Starting dynamic subtest: pipe-A
[213.970387] Dynamic subtest pipe-A: SKIP (0.019s)
[213.980773] Starting dynamic subtest: pipe-B
[214.004340] Dynamic subtest pipe-B: SKIP (0.034s)
[214.013679] Starting dynamic subtest: pipe-C
[214.039756] Dynamic subtest pipe-C: SKIP (0.033s)
[214.048872] Starting dynamic subtest: pipe-D
[214.073758] Dynamic subtest pipe-D: SKIP (0.033s)
[214.077925] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.121s)
[214.182116] [045/156] (817s left) kms_frontbuffer_tracking (psr-suspend)
[214.291260] Starting subtest: psr-suspend
[253.303910] Subtest psr-suspend: SUCCESS (9.033s)
[259.433771] [046/156] (778s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[259.491731] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[259.494522] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[259.604415] [047/156] (778s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[259.709522] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[259.713551] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[259.807336] [048/156] (778s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[259.900445] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[259.904559] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[259.994677] [049/156] (777s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[260.095713] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[265.245951] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.147s)
[265.346064] [050/156] (772s left) kms_psr (fbc-psr-cursor-blt)
[265.437781] Starting subtest: fbc-psr-cursor-blt
[265.440022] Starting dynamic subtest: eDP-1
[265.444030] Dynamic subtest eDP-1: SKIP (0.000s)
[265.448063] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[265.509271] [051/156] (772s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[265.608761] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[265.611150] Starting dynamic subtest: pipe-A-default-mode
[268.413579] Dynamic subtest pipe-A-default-mode: SUCCESS (2.802s)
[268.415794] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.803s)
[269.248775] [052/156] (768s left) gem_workarounds (basic-read-context)
[269.308937] Starting subtest: basic-read-context
[269.320800] Subtest basic-read-context: SUCCESS (0.011s)
[269.437006] [053/156] (768s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[269.487768] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[269.593158] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[269.669623] [054/156] (768s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[269.768897] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[269.773016] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[269.846855] [055/156] (768s left) gem_readwrite (new-obj)
[269.909023] Subtest new-obj: SKIP (0.000s)
[269.973400] [056/156] (768s left) gem_ctx_persistence (engines-persistence)
[270.026519] Starting subtest: engines-persistence
[270.028911] Starting dynamic subtest: rcs0
[270.809739] Dynamic subtest rcs0: SUCCESS (0.782s)
[270.821660] Starting dynamic subtest: bcs0
[271.580602] Dynamic subtest bcs0: SUCCESS (0.768s)
[271.592448] Starting dynamic subtest: vcs0
[272.340701] Dynamic subtest vcs0: SUCCESS (0.757s)
[272.352314] Starting dynamic subtest: vcs1
[273.105800] Dynamic subtest vcs1: SUCCESS (0.762s)
[273.118094] Starting dynamic subtest: vecs0
[273.886788] Dynamic subtest vecs0: SUCCESS (0.778s)
[273.901784] Starting dynamic subtest: ccs0
[274.640732] Dynamic subtest ccs0: SUCCESS (0.750s)
[274.643739] Subtest engines-persistence: SUCCESS (4.611s)
[274.721878] [057/156] (763s left) kms_busy (extended-pageflip-hang-newfb)
[274.820690] Starting subtest: extended-pageflip-hang-newfb
[274.822989] Starting dynamic subtest: pipe-A
[301.571184] Dynamic subtest pipe-A: SUCCESS (26.705s)
[301.581704] Starting dynamic subtest: pipe-D
[316.602831] Dynamic subtest pipe-D: SUCCESS (15.014s)
[316.605148] Subtest extended-pageflip-hang-newfb: SUCCESS (41.724s)
[317.469723] [058/156] (720s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[317.565937] Starting subtest: 4-tiled-64bpp-rotate-270
[317.585682] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[317.688781] [059/156] (720s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render)
[317.787902] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render
[317.791998] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[317.887135] [060/156] (720s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[317.978845] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[317.982959] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[318.088659] [061/156] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[318.191527] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[325.519000] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.332s)
[325.642788] [062/156] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[325.739275] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[325.743674] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[325.839015] [063/156] (712s left) sysfs_heartbeat_interval (mixed)
[325.890486] Starting subtest: mixed
[325.892629] Starting dynamic subtest: vecs0
[331.150830] Dynamic subtest vecs0: SUCCESS (5.260s)
[331.163385] Starting dynamic subtest: ccs0
[336.330006] Dynamic subtest ccs0: SUCCESS (5.177s)
[336.340781] Starting dynamic subtest: vcs0
[341.517875] Dynamic subtest vcs0: SUCCESS (5.187s)
[341.528571] Starting dynamic subtest: bcs0
[346.725762] Dynamic subtest bcs0: SUCCESS (5.205s)
[346.737769] Starting dynamic subtest: rcs0
[351.912064] Dynamic subtest rcs0: SUCCESS (5.183s)
[351.924624] Starting dynamic subtest: vcs1
[357.140015] Dynamic subtest vcs1: SUCCESS (5.225s)
[357.142470] Subtest mixed: SUCCESS (31.246s)
[357.229200] [064/156] (681s left) gem_softpin (allocator-basic-reserve)
[357.295427] Starting subtest: allocator-basic-reserve
[357.377778] Subtest allocator-basic-reserve: SUCCESS (0.082s)
[357.512506] [065/156] (681s left) kms_pm_dc (dc5-dpms)
[358.626507] Starting subtest: dc5-dpms
[360.676730] Subtest dc5-dpms: SUCCESS (2.049s)
[360.752569] [066/156] (677s left) gen7_exec_parse (load-register-reg)
[360.803007] Subtest load-register-reg: SKIP (0.000s)
[360.868173] [067/156] (677s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[360.965023] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[360.969128] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[361.048358] [068/156] (677s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[361.148106] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[361.152454] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[361.245027] [069/156] (677s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[361.359159] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[362.309470] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.947s)
[363.156853] [070/156] (675s left) gem_exec_params (dr4-dirt)
[363.210759] Starting subtest: DR4-dirt
[363.212671] Subtest DR4-dirt: SUCCESS (0.000s)
[363.318448] [071/156] (675s left) gem_workarounds (suspend-resume-context)
[363.384288] Starting subtest: suspend-resume-context
[379.731325] Subtest suspend-resume-context: SUCCESS (1.546s)
[386.877830] [072/156] (658s left) kms_addfb_basic (bad-pitch-65536)
[386.939327] Starting subtest: bad-pitch-65536
[386.941438] Subtest bad-pitch-65536: SUCCESS (0.000s)
[387.098107] [073/156] (658s left) gem_userptr_blits (access-control)
[387.168868] Starting subtest: access-control
[387.173642] Subtest access-control: SKIP (0.000s)
[387.297781] [074/156] (658s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[387.349904] Starting subtest: multi-wait-for-submit-submitted-signaled
[387.351844] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[387.434840] [075/156] (658s left) gem_exec_whisper (basic-queues-forked)
[387.495547] Starting subtest: basic-queues-forked
[410.744302] Subtest basic-queues-forked: SUCCESS (23.155s)
[410.928080] [076/156] (635s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[411.033306] Starting subtest: fbcpsrhdr-stridechange
[411.037468] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[411.129418] [077/156] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[411.231163] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[411.235081] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[411.329177] [078/156] (634s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[411.431172] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[411.435556] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[411.523396] [079/156] (634s left) syncobj_wait (wait-all-complex)
[411.586499] Starting subtest: wait-all-complex
[411.801534] Subtest wait-all-complex: SUCCESS (0.215s)
[411.876924] [080/156] (634s left) gem_fenced_exec_thrash (no-spare-fences)
[411.932901] Subtest no-spare-fences: SKIP (0.000s)
[411.995267] [081/156] (634s left) kms_plane_multiple (2x-tiling-4)
[412.086566] Starting subtest: 2x-tiling-4
[412.091056] Subtest 2x-tiling-4: SKIP (0.000s)
[412.156860] [082/156] (634s left) kms_vrr (flipline)
[412.266612] Starting subtest: flipline
[412.273216] Subtest flipline: SKIP (0.000s)
[412.338192] [083/156] (633s left) gem_wait (await)
[412.396517] Starting subtest: await
[412.398876] Starting dynamic subtest: all-engines
[413.550622] Dynamic subtest all-engines: SUCCESS (1.152s)
[413.568676] Starting dynamic subtest: rcs0
[414.605188] Dynamic subtest rcs0: SUCCESS (1.051s)
[414.624478] Starting dynamic subtest: bcs0
[415.662248] Dynamic subtest bcs0: SUCCESS (1.055s)
[415.683143] Starting dynamic subtest: vcs0
[416.717704] Dynamic subtest vcs0: SUCCESS (1.053s)
[416.735649] Starting dynamic subtest: vcs1
[417.771309] Dynamic subtest vcs1: SUCCESS (1.050s)
[417.787440] Starting dynamic subtest: vecs0
[418.825078] Dynamic subtest vecs0: SUCCESS (1.051s)
[418.842928] Starting dynamic subtest: ccs0
[419.881654] Dynamic subtest ccs0: SUCCESS (1.054s)
[419.884137] Subtest await: SUCCESS (7.482s)
[420.094951] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[420.098909] [084/156] (626s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[420.205281] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[420.209378] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[420.301228] [085/156] (626s left) kms_psr (fbc-pr-sprite-plane-move)
[420.401613] Starting subtest: fbc-pr-sprite-plane-move
[420.405709] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[420.489297] [086/156] (625s left) gem_exec_whisper (basic-fds-priority-all)
[420.548469] Starting subtest: basic-fds-priority-all
[442.860948] Subtest basic-fds-priority-all: SUCCESS (22.299s)
[443.049539] [087/156] (603s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[443.155512] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[443.159912] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[443.255578] [088/156] (603s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[443.359740] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[443.363869] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[443.473814] [089/156] (603s left) gem_exec_fence (syncobj-timeline-unused-fence)
[444.092148] Starting subtest: syncobj-timeline-unused-fence
[444.097706] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[445.630765] [090/156] (600s left) kms_psr (psr2-cursor-plane-onoff)
[445.724239] Starting subtest: psr2-cursor-plane-onoff
[445.726328] Starting dynamic subtest: eDP-1
[447.405510] Dynamic subtest eDP-1: SUCCESS (1.679s)
[447.407477] Subtest psr2-cursor-plane-onoff: SUCCESS (1.680s)
[448.310457] [091/156] (598s left) kms_flip (flip-vs-fences-interruptible)
[448.413151] Starting subtest: flip-vs-fences-interruptible
[448.417722] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[448.524161] [092/156] (598s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[448.612426] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[448.616897] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[448.690231] [093/156] (598s left) kms_draw_crc (draw-method-blt)
[448.779794] Starting subtest: draw-method-blt
[448.781728] Starting dynamic subtest: xrgb8888-untiled
[449.049039] Dynamic subtest xrgb8888-untiled: SUCCESS (0.271s)
[449.060017] Starting dynamic subtest: rgb565-untiled
[449.293409] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[449.305630] Starting dynamic subtest: xrgb2101010-untiled
[449.515787] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[449.527322] Starting dynamic subtest: xbgr16161616f-untiled
[449.738082] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[449.748819] Starting dynamic subtest: xrgb8888-xtiled
[449.860222] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[449.870062] Starting dynamic subtest: rgb565-xtiled
[449.982814] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[449.992748] Starting dynamic subtest: xrgb2101010-xtiled
[450.093686] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[450.107874] Starting dynamic subtest: xbgr16161616f-xtiled
[450.216121] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[450.228875] Starting dynamic subtest: xrgb8888-4tiled
[450.339365] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[450.349543] Starting dynamic subtest: rgb565-4tiled
[450.460511] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[450.470429] Starting dynamic subtest: xrgb2101010-4tiled
[450.571433] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[450.581611] Starting dynamic subtest: xbgr16161616f-4tiled
[450.694842] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[450.696933] Subtest draw-method-blt: SUCCESS (1.916s)
[450.843478] [094/156] (595s left) gem_exec_balancer (bonded-sync)
[450.903762] Starting subtest: bonded-sync
[450.907283] Subtest bonded-sync: SKIP (0.000s)
[451.215304] [095/156] (595s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[451.269898] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[451.272128] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[451.373011] [096/156] (595s left) gem_ppgtt (blt-vs-render-ctx0)
[451.429416] Starting subtest: blt-vs-render-ctx0
[484.303694] Subtest blt-vs-render-ctx0: SUCCESS (32.863s)
[484.452420] [097/156] (562s left) gem_exec_schedule (preempt)
[484.578017] Starting subtest: preempt
[484.580001] Starting dynamic subtest: rcs0
[484.610227] Dynamic subtest rcs0: SUCCESS (0.034s)
[484.623287] Starting dynamic subtest: bcs0
[484.642316] Dynamic subtest bcs0: SUCCESS (0.030s)
[484.652480] Starting dynamic subtest: vcs0
[484.668655] Dynamic subtest vcs0: SUCCESS (0.027s)
[484.680216] Starting dynamic subtest: vcs1
[484.697342] Dynamic subtest vcs1: SUCCESS (0.028s)
[484.708173] Starting dynamic subtest: vecs0
[484.728501] Dynamic subtest vecs0: SUCCESS (0.030s)
[484.741192] Starting dynamic subtest: ccs0
[484.761694] Dynamic subtest ccs0: SUCCESS (0.032s)
[484.763933] Subtest preempt: SUCCESS (0.187s)
[486.652927] [098/156] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[486.763408] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[486.767322] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[486.865843] [099/156] (560s left) gem_exec_fence (submit67)
[487.044512] Starting subtest: submit67
[487.049426] Subtest submit67: SKIP (0.000s)
[488.604404] [100/156] (558s left) i915_pm_rc6_residency (rc6-idle)
[488.659509] Starting subtest: rc6-idle
[488.687422] Starting dynamic subtest: gt0-rcs0
[512.983832] Dynamic subtest gt0-rcs0: SUCCESS (24.298s)
[512.996561] Starting dynamic subtest: gt0-bcs0
[537.264037] Dynamic subtest gt0-bcs0: SUCCESS (24.275s)
[537.274769] Starting dynamic subtest: gt0-ccs0
[561.567809] Dynamic subtest gt0-ccs0: SUCCESS (24.294s)
[561.579644] Starting dynamic subtest: gt1-vcs0
[567.743155] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[567.756642] Starting dynamic subtest: gt1-vecs0
[573.917446] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[573.920248] Subtest rc6-idle: SUCCESS (85.248s)
[573.996046] [101/156] (473s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[574.097959] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[574.107539] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[574.190498] [102/156] (472s left) gem_exec_parallel (fds)
[574.253183] Starting subtest: fds
[574.255572] Starting dynamic subtest: rcs0
[576.970918] Dynamic subtest rcs0: SUCCESS (2.715s)
[576.982751] Starting dynamic subtest: bcs0
[580.409546] Dynamic subtest bcs0: SUCCESS (3.436s)
[580.422965] Starting dynamic subtest: vcs0
[584.757901] Dynamic subtest vcs0: SUCCESS (4.344s)
[584.770452] Starting dynamic subtest: vcs1
[588.776339] Dynamic subtest vcs1: SUCCESS (4.016s)
[588.792667] Starting dynamic subtest: vecs0
[592.758385] Dynamic subtest vecs0: SUCCESS (3.979s)
[592.769636] Starting dynamic subtest: ccs0
[596.652086] Dynamic subtest ccs0: SUCCESS (3.890s)
[596.655071] Subtest fds: SUCCESS (22.390s)
[596.874678] [103/156] (450s left) gem_exec_suspend (basic-s3-devices)
[596.937980] Starting subtest: basic-S3-devices
[596.940203] Starting dynamic subtest: smem
[608.484314] Dynamic subtest smem: SUCCESS (11.540s)
[608.487243] Subtest basic-S3-devices: SUCCESS (11.542s)
[616.687394] [104/156] (438s left) kms_lease (invalid-create-leases)
[616.782484] Starting subtest: invalid-create-leases
[616.787295] Subtest invalid-create-leases: SUCCESS (0.005s)
[616.903920] [105/156] (438s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[617.004857] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[623.849612] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.851s)
[623.995312] [106/156] (431s left) syncobj_wait (wait-for-submit-snapshot)
[624.048001] Starting subtest: wait-for-submit-snapshot
[624.128422] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[624.207662] [107/156] (431s left) dumb_buffer (map-uaf)
[624.253642] Starting subtest: map-uaf
[624.256045] Subtest map-uaf: SUCCESS (0.005s)
[624.369549] [108/156] (431s left) kms_invalid_mode (uint-max-clock)
[624.457679] Starting subtest: uint-max-clock
[624.459974] Starting dynamic subtest: pipe-A-eDP-1
[624.744588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[624.756089] Starting dynamic subtest: pipe-B-eDP-1
[624.757985] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[624.768533] Starting dynamic subtest: pipe-C-eDP-1
[624.770804] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[624.780948] Starting dynamic subtest: pipe-D-eDP-1
[624.783286] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[624.785508] Subtest uint-max-clock: SUCCESS (0.293s)
[625.598569] [109/156] (429s left) kms_vblank (ts-continuation-idle)
[625.692716] Starting subtest: ts-continuation-idle
[625.694631] Starting dynamic subtest: pipe-A-eDP-1
[626.090514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[626.107959] Starting dynamic subtest: pipe-D-eDP-1
[627.183431] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.092s)
[627.185731] Subtest ts-continuation-idle: SUCCESS (1.493s)
[628.054363] [110/156] (427s left) kms_dp_link_training (uhbr-sst)
[628.151743] Starting subtest: uhbr-sst
[628.160259] Subtest uhbr-sst: SKIP (0.000s)
[628.242023] [111/156] (427s left) gem_partial_pwrite_pread (reads-snoop)
[628.294160] Subtest reads-snoop: SKIP (0.000s)
[628.383062] [112/156] (427s left) perf_pmu (enable-race)
[628.420397] Starting subtest: enable-race
[628.422694] Starting dynamic subtest: rcs0
[641.189258] Dynamic subtest rcs0: SUCCESS (12.769s)
[641.202344] Starting dynamic subtest: bcs0
[653.933156] Dynamic subtest bcs0: SUCCESS (12.741s)
[653.944642] Starting dynamic subtest: vcs0
[669.477194] Dynamic subtest vcs0: SUCCESS (15.539s)
[669.498992] Starting dynamic subtest: vcs1
[685.540304] Dynamic subtest vcs1: SUCCESS (16.058s)
[685.552679] Starting dynamic subtest: vecs0
[701.476881] Dynamic subtest vecs0: SUCCESS (15.931s)
[701.488077] Starting dynamic subtest: ccs0
[714.225318] Dynamic subtest ccs0: SUCCESS (12.745s)
[714.228026] Subtest enable-race: SUCCESS (85.798s)
[714.343994] [113/156] (341s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[714.441840] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[714.446054] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[714.550189] [114/156] (341s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[714.657094] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[714.661464] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[714.757074] [115/156] (341s left) kms_psr (pr-no-drrs)
[714.851554] Starting subtest: pr-no-drrs
[714.855831] Subtest pr-no-drrs: SKIP (0.000s)
[714.928640] [116/156] (340s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[715.036427] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[715.040902] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[715.114826] [117/156] (340s left) kms_psr (psr2-sprite-plane-onoff)
[715.208921] Starting subtest: psr2-sprite-plane-onoff
[715.210871] Starting dynamic subtest: eDP-1
[716.973915] Dynamic subtest eDP-1: SUCCESS (1.763s)
[716.975805] Subtest psr2-sprite-plane-onoff: SUCCESS (1.764s)
[717.813490] [118/156] (338s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[717.873246] Starting subtest: x-tiled-to-vebox-y-tiled
[717.877514] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[718.059881] [119/156] (337s left) tools_test (tools_test)
[718.104872] Starting subtest: tools_test
[718.150726] Subtest tools_test: SUCCESS (0.062s)
[718.232732] [120/156] (337s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[718.329246] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[722.324651] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.000s)
[723.524773] [121/156] (332s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[723.622738] Starting subtest: addfb25-y-tiled-legacy
[723.624977] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[723.730343] [122/156] (332s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[723.821953] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[723.826315] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[723.913313] [123/156] (332s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[724.016695] Starting subtest: psrhdr-indfb-scaledprimary
[724.020746] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[724.113867] [124/156] (332s left) kms_dsc (dsc-with-output-formats-with-bpc-bigjoiner)
[724.216197] Starting subtest: dsc-with-output-formats-with-bpc-bigjoiner
[724.220793] Subtest dsc-with-output-formats-with-bpc-bigjoiner: SKIP (0.000s)
[724.295035] [125/156] (331s left) gem_mmap_offset (clear-via-pagefault)
[724.353114] Starting subtest: clear-via-pagefault
[724.356149] Starting dynamic subtest: smem0
[759.370166] Dynamic subtest smem0: SUCCESS (35.011s)
[759.372275] Subtest clear-via-pagefault: SUCCESS (35.013s)
[759.463584] [126/156] (296s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[759.570626] Starting subtest: plane-lut1d-ctm3x4
[759.717979] Starting dynamic subtest: pipe-A-plane-0
[759.894645] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[759.905742] Starting dynamic subtest: pipe-A-plane-1
[760.085520] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[760.096560] Starting dynamic subtest: pipe-A-plane-2
[760.262031] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[761.512618] Starting dynamic subtest: pipe-B-plane-0
[761.681318] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[761.692474] Starting dynamic subtest: pipe-B-plane-1
[761.848910] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[761.859796] Starting dynamic subtest: pipe-B-plane-2
[762.013970] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s)
[763.245721] Starting dynamic subtest: pipe-C-plane-0
[763.391905] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[763.403378] Starting dynamic subtest: pipe-C-plane-1
[763.558581] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[763.569643] Starting dynamic subtest: pipe-C-plane-2
[763.725013] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[764.984772] Starting dynamic subtest: pipe-D-plane-0
[765.131645] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[765.143336] Starting dynamic subtest: pipe-D-plane-1
[765.297763] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[765.309041] Starting dynamic subtest: pipe-D-plane-2
[765.464648] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[765.751271] Subtest plane-lut1d-ctm3x4: SUCCESS (6.179s)
[766.661783] [127/156] (289s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[766.773081] Starting subtest: x-tiled-8bpp-rotate-90
[766.795397] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[766.899825] [128/156] (289s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[767.001369] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[767.005761] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[767.084455] [129/156] (289s left) kms_content_protection (content-type-change)
[767.233196] Starting subtest: content-type-change
[767.238174] Subtest content-type-change: SKIP (0.000s)
[767.368491] [130/156] (289s left) vgem_basic (setversion)
[767.413413] Starting subtest: setversion
[767.417730] Subtest setversion: SUCCESS (0.000s)
[767.477551] [131/156] (289s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[767.545299] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[767.549923] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[767.746002] [132/156] (288s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[767.848827] Starting subtest: primary-4-tiled-reflect-x-0
[774.989951] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.143s)
[776.211984] [133/156] (280s left) i915_drm_fdinfo (busy-idle-check-all)
[776.254293] Starting subtest: busy-idle-check-all
[776.256647] Starting dynamic subtest: rcs0
[776.264699] Dynamic subtest rcs0: SKIP (0.006s)
[776.277675] Starting dynamic subtest: bcs0
[776.282069] Dynamic subtest bcs0: SKIP (0.000s)
[776.292375] Starting dynamic subtest: vcs0
[776.296310] Dynamic subtest vcs0: SKIP (0.000s)
[776.306350] Starting dynamic subtest: vcs1
[776.310266] Dynamic subtest vcs1: SKIP (0.000s)
[776.320339] Starting dynamic subtest: vecs0
[776.324299] Dynamic subtest vecs0: SKIP (0.000s)
[776.334175] Starting dynamic subtest: ccs0
[776.338186] Dynamic subtest ccs0: SKIP (0.000s)
[776.342222] Subtest busy-idle-check-all: SKIP (0.012s)
[776.382318] [134/156] (280s left) kms_frontbuffer_tracking (fbc-1p-rte)
[776.503773] Starting subtest: fbc-1p-rte
[781.968919] Subtest fbc-1p-rte: SUCCESS (5.473s)
[783.137885] [135/156] (273s left) kms_lease (lease-unleased-crtc)
[783.227573] Starting subtest: lease-unleased-crtc
[783.229933] Starting dynamic subtest: pipe-A-eDP-1
[783.517303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[783.528271] Starting dynamic subtest: pipe-B-eDP-1
[784.246533] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.728s)
[784.259679] Starting dynamic subtest: pipe-C-eDP-1
[784.261714] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[784.273249] Starting dynamic subtest: pipe-D-eDP-1
[784.275077] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[784.276907] Subtest lease-unleased-crtc: SUCCESS (1.031s)
[784.630781] [136/156] (272s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[784.730279] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[784.734196] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[784.816780] [137/156] (271s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[784.906270] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[784.908477] Starting dynamic subtest: pipe-A-eDP-1
[785.862907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.949s)
[785.874441] Starting dynamic subtest: pipe-B-eDP-1
[787.656385] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.789s)
[787.667627] Starting dynamic subtest: pipe-C-eDP-1
[789.194557] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.538s)
[789.206578] Starting dynamic subtest: pipe-D-eDP-1
[790.723302] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s)
[790.725645] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.808s)
[791.949962] [138/156] (264s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[792.009653] Starting subtest: single-wait-for-submit-available-signaled
[792.011832] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[792.099320] [139/156] (264s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[792.190293] Starting subtest: pr-overlay-plane-move-continuous-sf
[792.194447] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[792.260622] [140/156] (264s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[792.356441] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[792.360611] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[792.467204] [141/156] (264s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[792.519342] Starting subtest: invalid-multi-wait-all-unsubmitted
[792.521665] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[792.627980] [142/156] (264s left) drm_read (invalid-buffer)
[792.791086] Starting subtest: invalid-buffer
[792.793555] Subtest invalid-buffer: SUCCESS (0.000s)
[792.906392] [143/156] (264s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[792.997499] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[797.743891] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.749s)
[798.975147] [144/156] (258s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[799.074805] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[799.079114] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[799.174123] [145/156] (257s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[799.269605] Starting subtest: yf-tiled-32bpp-rotate-180
[799.274075] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[799.383644] [146/156] (257s left) gem_exec_endless (dispatch)
[799.455159] Starting subtest: dispatch
[799.457793] Starting dynamic subtest: rcs0
[799.462857] Dynamic subtest rcs0: SUCCESS (0.005s)
[799.478168] Starting dynamic subtest: bcs0
[799.482430] Dynamic subtest bcs0: SUCCESS (0.004s)
[799.494374] Starting dynamic subtest: vcs0
[799.498521] Dynamic subtest vcs0: SUCCESS (0.004s)
[799.508552] Starting dynamic subtest: vcs1
[799.512762] Dynamic subtest vcs1: SUCCESS (0.004s)
[799.522637] Starting dynamic subtest: vecs0
[799.526776] Dynamic subtest vecs0: SUCCESS (0.004s)
[799.536661] Starting dynamic subtest: ccs0
[799.540701] Dynamic subtest ccs0: SUCCESS (0.004s)
[799.542578] Subtest dispatch: SUCCESS (0.031s)
[800.593332] [147/156] (256s left) api_intel_bb (object-noreloc-purge-cache-simple)
[800.649677] Starting subtest: object-noreloc-purge-cache-simple
[800.654461] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[800.763967] [148/156] (256s left) gem_render_copy (y-tiled)
[800.825928] Starting subtest: y-tiled
[800.830094] Subtest y-tiled: SKIP (0.000s)
[801.019896] [149/156] (256s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[801.129203] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[801.133518] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[801.222055] [150/156] (256s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[801.330218] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[801.334215] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[801.437739] [151/156] (255s left) kms_pm_rpm (basic-pci-d3-state)
[803.661361] Starting subtest: basic-pci-d3-state
[805.152087] Subtest basic-pci-d3-state: SUCCESS (1.488s)
[805.241298] [152/156] (252s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[805.350723] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[805.352947] Starting dynamic subtest: pipe-A-eDP-1
[805.378746] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[805.396518] Starting dynamic subtest: pipe-B-eDP-1
[805.420135] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[805.432768] Starting dynamic subtest: pipe-C-eDP-1
[805.456662] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[805.469863] Starting dynamic subtest: pipe-D-eDP-1
[805.492775] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[805.496881] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[807.674119] [153/156] (249s left) syncobj_eventfd (binary-wait-signaled)
[807.721277] Starting subtest: binary-wait-signaled
[807.723516] Subtest binary-wait-signaled: SUCCESS (0.000s)
[807.816457] [154/156] (249s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[807.899365] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[807.903335] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[807.977130] [155/156] (249s left) kms_rotation_crc (bad-pixel-format)
[808.064155] Starting subtest: bad-pixel-format
[808.068654] Subtest bad-pixel-format: SKIP (0.002s)
[808.151085] [156/156] (249s left) syncobj_wait (invalid-single-wait-unsubmitted)
[808.199240] Starting subtest: invalid-single-wait-unsubmitted
[808.201241] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[808.295427] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_properties
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_mmap
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: gem_bad_reloc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: i915_fb_tiling
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_chamelium_color
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_atomic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
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_frontbuffer_tracking
results: parsing output: 32/ for test: gem_ctx_engines
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: gem_pread
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: i915_suspend
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: gem_workarounds
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_readwrite
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_busy
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: sysfs_heartbeat_interval
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: kms_pm_dc
results: parsing output: 65/ for test: gen7_exec_parse
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_cursor_legacy
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: gem_workarounds
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_fenced_exec_thrash
results: parsing output: 80/ for test: kms_plane_multiple
results: parsing output: 81/ for test: kms_vrr
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_draw_crc
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_ppgtt
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: i915_pm_rc6_residency
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_exec_parallel
results: parsing output: 102/ for test: gem_exec_suspend
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: dumb_buffer
results: parsing output: 107/ for test: kms_invalid_mode
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_dp_link_training
results: parsing output: 110/ for test: gem_partial_pwrite_pread
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: tools_test
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_dsc
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: kms_color_pipeline
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: kms_rotation_crc
results: parsing output: 132/ for test: i915_drm_fdinfo
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_lease
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_ccs
results: parsing output: 137/ for test: syncobj_timeline
results: parsing output: 138/ for test: kms_psr2_sf
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: drm_read
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: gem_exec_endless
results: parsing output: 146/ for test: api_intel_bb
results: parsing output: 147/ for test: gem_render_copy
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_pm_rpm
results: parsing output: 151/ for test: kms_ccs
results: parsing output: 152/ for test: syncobj_eventfd
results: parsing output: 153/ for test: kms_plane
results: parsing output: 154/ for test: kms_rotation_crc
results: parsing output: 155/ for test: syncobj_wait
Done.