[62.314034] Initializing watchdogs
[62.314081]   /dev/watchdog0
[62.329142] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[62.333342] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.335315] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.338838] [001/156] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[62.455811] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[62.458105] Starting dynamic subtest: pipe-A-eDP-1
[69.233810] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.794s)
[69.241585] Starting dynamic subtest: pipe-B-eDP-1
[76.170388] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.941s)
[76.172231] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.736s)
[77.045489] [002/156] (945s left) i915_suspend (fence-restore-tiled2untiled)
[77.102906] Starting subtest: fence-restore-tiled2untiled
[77.107580] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[77.203977] [003/156] (945s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[77.297126] Starting subtest: fbcpsr-rgb565-draw-render
[84.312786] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.023s)
[84.446411] [004/156] (938s left) syncobj_timeline (wait-any-snapshot)
[84.503037] Starting subtest: wait-any-snapshot
[84.583954] Subtest wait-any-snapshot: SUCCESS (0.082s)
[84.664885] [005/156] (938s left) perf (gen8-unprivileged-single-ctx-counters)
[84.798859] Starting subtest: gen8-unprivileged-single-ctx-counters
[84.803163] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[84.840343] [006/156] (938s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[84.910050] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[84.914746] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[86.009550] [007/156] (937s left) api_intel_bb (object-noreloc-keep-cache-simple)
[86.062547] Starting subtest: object-noreloc-keep-cache-simple
[86.066330] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[86.201217] [008/156] (936s left) gem_ctx_isolation (clean)
[86.261977] Starting subtest: clean
[86.264361] Starting dynamic subtest: rcs0
[86.307848] Dynamic subtest rcs0: SUCCESS (0.045s)
[86.315808] Starting dynamic subtest: bcs0
[86.371601] Dynamic subtest bcs0: SUCCESS (0.063s)
[86.380777] Starting dynamic subtest: vcs0
[86.410975] Dynamic subtest vcs0: SUCCESS (0.039s)
[86.419450] Starting dynamic subtest: vcs1
[88.250525] Dynamic subtest vcs1: SUCCESS (1.839s)
[88.258311] Starting dynamic subtest: vecs0
[90.256902] Dynamic subtest vecs0: SUCCESS (2.005s)
[90.267709] Starting dynamic subtest: ccs0
[92.248762] Dynamic subtest ccs0: SUCCESS (1.992s)
[92.251298] Subtest clean: SUCCESS (5.986s)
[92.464808] [009/156] (930s left) gem_eio (kms)
[92.666266] Starting subtest: kms
[109.290315] Subtest kms: SUCCESS (16.624s)
[110.462883] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[110.466269] [010/156] (912s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[110.550329] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[110.555039] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[110.651688] [011/156] (912s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff)
[110.726837] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff
[110.731150] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[110.812458] [012/156] (912s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[110.864989] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[110.867420] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[110.981220] [013/156] (912s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[111.037911] Starting subtest: multi-wait-for-submit-available-signaled
[111.040159] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[111.135099] [014/156] (912s left) syncobj_wait (wait-for-submit-snapshot)
[111.192077] Starting subtest: wait-for-submit-snapshot
[111.272218] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[111.347186] [015/156] (912s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[111.392041] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[111.497554] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[111.580857] [016/156] (911s left) kms_pm_rpm (cursor-dpms)
[113.384404] Starting subtest: cursor-dpms
[113.389845] Subtest cursor-dpms: SKIP (0.000s)
[113.822056] [017/156] (909s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[113.914685] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[113.918824] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[114.013593] [018/156] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[114.088605] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[114.093084] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[114.194694] [019/156] (909s left) kms_flip (plain-flip-fb-recreate)
[114.266233] Starting subtest: plain-flip-fb-recreate
[114.268600] Starting dynamic subtest: A-eDP1
[123.191364] Dynamic subtest A-eDP1: SUCCESS (8.926s)
[123.202596] Starting dynamic subtest: B-eDP1
[132.120281] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[132.129311] Starting dynamic subtest: C-eDP1
[140.966353] Dynamic subtest C-eDP1: SUCCESS (8.845s)
[140.976661] Starting dynamic subtest: D-eDP1
[149.793253] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[149.797639] Subtest plain-flip-fb-recreate: SUCCESS (35.531s)
[150.980083] [020/156] (872s left) gem_lmem_swapping (basic)
[151.023833] Subtest basic: SKIP (0.000s)
[151.067786] [021/156] (872s left) gem_pxp (reject-modify-context-protection-off-1)
[151.187049] Starting subtest: reject-modify-context-protection-off-1
[151.189572] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[151.288256] [022/156] (872s left) i915_hangman (engine-engine-error)
[151.352204] Starting subtest: engine-engine-error
[151.353963] Starting dynamic subtest: rcs0
[153.181277] Dynamic subtest rcs0: SUCCESS (1.827s)
[153.191688] Starting dynamic subtest: bcs0
[155.228399] Dynamic subtest bcs0: SUCCESS (2.044s)
[155.240378] Starting dynamic subtest: vcs0
[157.211826] Dynamic subtest vcs0: SUCCESS (1.982s)
[157.222486] Starting dynamic subtest: vcs1
[159.195593] Dynamic subtest vcs1: SUCCESS (1.981s)
[159.206372] Starting dynamic subtest: vecs0
[161.179402] Dynamic subtest vecs0: SUCCESS (1.980s)
[161.190747] Starting dynamic subtest: ccs0
[163.163700] Dynamic subtest ccs0: SUCCESS (1.982s)
[163.166670] Subtest engine-engine-error: SUCCESS (11.808s)
[163.292963] [023/156] (860s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[163.337967] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[163.441725] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[163.519664] [024/156] (860s left) gen9_exec_parse (bb-secure)
[163.573141] Subtest bb-secure: SKIP (0.000s)
[163.645841] [025/156] (860s left) kms_dsc (dsc-with-output-formats-with-bpc)
[163.726496] Starting subtest: dsc-with-output-formats-with-bpc
[163.787037] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[163.827685] [026/156] (859s left) kms_cursor_legacy (single-bo)
[163.932942] Starting subtest: single-bo
[163.935047] Starting dynamic subtest: pipe-A
[169.315414] Dynamic subtest pipe-A: SUCCESS (5.378s)
[169.326783] Starting dynamic subtest: pipe-B
[174.697493] Dynamic subtest pipe-B: SUCCESS (5.379s)
[174.710283] Starting dynamic subtest: pipe-C
[180.079498] Dynamic subtest pipe-C: SUCCESS (5.379s)
[180.089425] Starting dynamic subtest: pipe-D
[185.461347] Dynamic subtest pipe-D: SUCCESS (5.379s)
[185.471487] Starting dynamic subtest: all-pipes
[190.848779] Dynamic subtest all-pipes: SUCCESS (5.386s)
[190.851535] Subtest single-bo: SUCCESS (26.909s)
[190.995086] [027/156] (832s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[191.082529] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[191.086875] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[191.188274] [028/156] (832s left) gem_exec_balancer (nop)
[191.242648] Starting subtest: nop
[237.983551] Subtest nop: SUCCESS (46.736s)
[238.267194] [029/156] (785s left) sw_sync (sync_merge)
[238.300382] Starting subtest: sync_merge
[238.302286] Subtest sync_merge: SUCCESS (0.000s)
[238.351974] [030/156] (785s left) gem_exec_fence (basic-busy)
[238.532896] Starting subtest: basic-busy
[238.535396] Starting dynamic subtest: rcs0
[238.619302] Dynamic subtest rcs0: SUCCESS (0.086s)
[238.628680] Starting dynamic subtest: bcs0
[238.673930] Dynamic subtest bcs0: SUCCESS (0.053s)
[238.685388] Starting dynamic subtest: vcs0
[238.727931] Dynamic subtest vcs0: SUCCESS (0.053s)
[238.737716] Starting dynamic subtest: vcs1
[238.782646] Dynamic subtest vcs1: SUCCESS (0.054s)
[238.792685] Starting dynamic subtest: vecs0
[238.837557] Dynamic subtest vecs0: SUCCESS (0.053s)
[238.849118] Starting dynamic subtest: ccs0
[238.892082] Dynamic subtest ccs0: SUCCESS (0.055s)
[238.895138] Subtest basic-busy: SUCCESS (0.360s)
[240.349775] [031/156] (783s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[240.442299] Starting subtest: fbcpsrhdr-modesetfrombusy
[240.446886] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[240.535343] [032/156] (783s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[240.653918] Starting subtest: dp-mst-lic-type-0-hdcp14
[240.658572] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[240.776810] [033/156] (783s left) kms_chamelium_hpd (hdmi-hpd-fast)
[241.154210] Subtest hdmi-hpd-fast: SKIP (0.000s)
[241.999891] [034/156] (782s left) kms_psr (psr-sprite-mmap-gtt)
[242.080066] Starting subtest: psr-sprite-mmap-gtt
[242.082208] Starting dynamic subtest: eDP-1
[243.520498] Dynamic subtest eDP-1: SKIP (1.436s)
[243.525797] Subtest psr-sprite-mmap-gtt: SKIP (1.437s)
[243.662299] [035/156] (780s left) gem_render_copy_redux (flink-interruptible)
[243.736505] Starting subtest: flink-interruptible
[244.497441] Subtest flink-interruptible: SUCCESS (0.761s)
[244.610544] [036/156] (779s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[244.682787] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[244.686184] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[244.768567] [037/156] (779s left) core_getversion (basic)
[244.805250] Starting subtest: basic
[244.808766] Subtest basic: SUCCESS (0.000s)
[244.879508] [038/156] (779s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[244.954888] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[244.958378] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[245.050029] [039/156] (779s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt)
[245.136329] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt
[245.139970] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[245.241145] [040/156] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[245.318567] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[245.322354] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[245.426445] [041/156] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[245.506664] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[254.178345] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.678s)
[254.304636] [042/156] (770s left) gem_tiled_blits (interruptible)
[254.353639] Subtest interruptible: SKIP (0.000s)
[254.415151] [043/156] (770s left) kms_vblank (ts-continuation-suspend)
[254.484190] Starting subtest: ts-continuation-suspend
[254.486073] Starting dynamic subtest: pipe-A-eDP-1
[271.418315] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.700s)
[271.433280] Starting dynamic subtest: pipe-D-eDP-1
[288.405926] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.242s)
[288.408763] Subtest ts-continuation-suspend: SUCCESS (3.945s)
[289.225791] [044/156] (735s left) perf_pmu (gt-awake)
[289.271553] Starting subtest: gt-awake
[298.217003] Subtest gt-awake: SUCCESS (8.985s)
[298.322399] [045/156] (726s left) kms_async_flips (async-flip-hang)
[298.408884] Starting subtest: async-flip-hang
[298.773639] Starting dynamic subtest: pipe-A-eDP-1
[313.726594] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.972s)
[314.118302] Starting dynamic subtest: pipe-B-eDP-1
[329.729652] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.617s)
[330.108834] Starting dynamic subtest: pipe-C-eDP-1
[345.730957] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.628s)
[346.097359] Starting dynamic subtest: pipe-D-eDP-1
[361.725386] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.637s)
[361.727653] Subtest async-flip-hang: SUCCESS (63.341s)
[362.901329] [046/156] (661s left) gem_mmap_wc (bad-size)
[362.968345] Subtest bad-size: SKIP (0.000s)
[363.027408] [047/156] (661s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[363.101273] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[363.105874] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[363.194561] [048/156] (661s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[363.270649] Starting subtest: primary-y-tiled-reflect-x-180
[363.331012] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[363.433589] [049/156] (661s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[363.507733] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[363.510495] Starting dynamic subtest: pipe-A-eDP-1
[363.535308] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.545667] Starting dynamic subtest: pipe-B-eDP-1
[363.570878] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.580816] Starting dynamic subtest: pipe-C-eDP-1
[363.605706] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.615136] Starting dynamic subtest: pipe-D-eDP-1
[363.640830] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.646791] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[365.759525] [050/156] (659s left) kms_psr (pr-sprite-plane-onoff)
[365.829899] Starting subtest: pr-sprite-plane-onoff
[365.834937] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[365.899679] [051/156] (658s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[365.973593] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[365.975751] Starting dynamic subtest: pipe-A-eDP-1
[366.674726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.694s)
[366.684879] Starting dynamic subtest: pipe-B-eDP-1
[368.471331] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.794s)
[368.482841] Starting dynamic subtest: pipe-C-eDP-1
[370.194365] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.722s)
[370.205145] Starting dynamic subtest: pipe-D-eDP-1
[371.929758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.735s)
[371.932394] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.949s)
[373.097449] [052/156] (651s left) gem_ctx_persistence (heartbeat-hostile)
[373.152901] Starting subtest: heartbeat-hostile
[373.158832] Subtest heartbeat-hostile: SKIP (0.000s)
[373.253607] [053/156] (651s left) kms_getfb (getfb-handle-valid)
[373.327286] Starting subtest: getfb-handle-valid
[373.329800] Subtest getfb-handle-valid: SUCCESS (0.000s)
[373.420574] [054/156] (651s left) gem_flink_race (flink_close)
[373.457706] Starting subtest: flink_close
[378.542891] Subtest flink_close: SUCCESS (5.086s)
[378.617538] [055/156] (646s left) gem_workarounds (reset)
[378.695066] Starting subtest: reset
[378.836441] Subtest reset: SUCCESS (0.141s)
[378.981094] [056/156] (646s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move)
[379.074240] Starting subtest: hdr-2p-primscrn-cur-indfb-move
[379.079160] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[379.180954] [057/156] (645s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[379.289428] Starting subtest: flip-vs-cursor-atomic-transitions
[387.096730] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.808s)
[387.920094] [058/156] (637s left) api_intel_allocator (simple-allocator)
[387.973782] Starting subtest: simple-allocator
[387.976333] Starting dynamic subtest: basic
[387.978790] Dynamic subtest basic: SUCCESS (0.004s)
[387.989052] Starting dynamic subtest: parallel-one
[388.168590] Dynamic subtest parallel-one: SUCCESS (0.190s)
[388.178350] Starting dynamic subtest: print
[388.180462] Dynamic subtest print: SUCCESS (0.000s)
[388.190283] Starting dynamic subtest: reuse
[388.192827] Dynamic subtest reuse: SUCCESS (0.000s)
[388.202579] Starting dynamic subtest: reserve
[388.205388] Dynamic subtest reserve: SUCCESS (0.000s)
[388.214788] Starting dynamic subtest: fork-reopen-allocator
[388.217789] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[388.220814] Subtest simple-allocator: SUCCESS (0.213s)
[388.295662] [059/156] (636s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[388.377564] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[388.382768] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[388.472258] [060/156] (636s left) vgem_basic (dmabuf-export)
[388.511912] Starting subtest: dmabuf-export
[388.532054] Subtest dmabuf-export: SUCCESS (0.021s)
[388.649255] [061/156] (636s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[388.731826] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[388.736950] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[388.819183] [062/156] (636s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[388.898421] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[388.903407] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[388.992868] [063/156] (636s left) kms_force_connector_basic (force-load-detect)
[389.048153] Subtest force-load-detect: SKIP (0.000s)
[389.122664] [064/156] (636s left) kms_psr (fbc-psr-cursor-plane-onoff)
[389.193150] Starting subtest: fbc-psr-cursor-plane-onoff
[389.195396] Starting dynamic subtest: eDP-1
[389.199662] Dynamic subtest eDP-1: SKIP (0.000s)
[389.203791] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[389.271701] [065/156] (636s left) kms_pipe_crc_basic (hang-read-crc)
[389.344441] Starting subtest: hang-read-crc
[389.346647] Starting dynamic subtest: pipe-A-eDP-1
[391.406041] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[391.417223] Starting dynamic subtest: pipe-B-eDP-1
[394.209382] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.800s)
[394.219731] Starting dynamic subtest: pipe-C-eDP-1
[396.899884] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.688s)
[396.911560] Starting dynamic subtest: pipe-D-eDP-1
[399.593490] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.690s)
[399.596128] Subtest hang-read-crc: SUCCESS (10.244s)
[400.418783] [066/156] (625s left) kms_cursor_edge_walk (128x128-right-edge)
[400.492683] Starting subtest: 128x128-right-edge
[400.495386] Starting dynamic subtest: pipe-A-eDP-1
[403.975441] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[403.985903] Starting dynamic subtest: pipe-D-eDP-1
[407.109922] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[407.112767] Subtest 128x128-right-edge: SUCCESS (6.617s)
[407.915420] [067/156] (617s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[408.005112] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[408.010446] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[408.100690] [068/156] (617s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[408.170605] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[408.173048] Starting dynamic subtest: pipe-A-eDP-1
[408.196042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[408.206979] Starting dynamic subtest: pipe-B-eDP-1
[408.229542] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[408.239423] Starting dynamic subtest: pipe-C-eDP-1
[408.262469] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[408.271600] Starting dynamic subtest: pipe-D-eDP-1
[408.294748] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[408.297098] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[410.474290] [069/156] (615s left) kms_psr (fbc-psr2-sprite-render)
[410.549430] Starting subtest: fbc-psr2-sprite-render
[410.551902] Starting dynamic subtest: eDP-1
[410.557035] Dynamic subtest eDP-1: SKIP (0.000s)
[410.562167] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[410.623305] [070/156] (614s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)
[410.703711] Starting subtest: hdr-rgb565-draw-mmap-cpu
[410.708908] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[410.789770] [071/156] (614s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[410.887293] Starting subtest: 2x-cursor-vs-flip-atomic
[410.892710] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[411.031894] [072/156] (614s left) syncobj_basic (bad-pad-fd-to-handle)
[411.081619] Starting subtest: bad-pad-fd-to-handle
[411.084434] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[411.175336] [073/156] (614s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[411.255390] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[411.258193] Starting dynamic subtest: pipe-A-eDP-1
[427.754590] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.505s)
[427.764887] Starting dynamic subtest: pipe-B-eDP-1
[444.965417] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.212s)
[444.967936] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.720s)
[445.829064] [074/156] (579s left) kms_pipe_crc_basic (suspend-read-crc)
[445.898707] Starting subtest: suspend-read-crc
[445.901527] Starting dynamic subtest: pipe-A-eDP-1
[464.037650] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.576s)
[464.052705] Starting dynamic subtest: pipe-B-eDP-1
[482.030958] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.240s)
[482.041564] Starting dynamic subtest: pipe-C-eDP-1
[499.970703] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.107s)
[499.984973] Starting dynamic subtest: pipe-D-eDP-1
[517.976364] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.098s)
[517.978687] Subtest suspend-read-crc: SUCCESS (12.026s)
[518.794368] [075/156] (507s left) syncobj_wait (wait-zero-handles)
[518.853556] Starting subtest: wait-zero-handles
[518.855531] Subtest wait-zero-handles: SUCCESS (0.000s)
[518.976337] [076/156] (506s left) kms_cursor_crc (cursor-random-64x21)
[519.142332] Starting subtest: cursor-random-64x21
[519.185876] Subtest cursor-random-64x21: SKIP (0.040s)
[519.408521] [077/156] (506s left) gem_tiled_partial_pwrite_pread (reads)
[519.456368] Subtest reads: SKIP (0.000s)
[519.531236] [078/156] (506s left) gem_exec_params (rel-constants-invalid-ring)
[519.578485] Starting subtest: rel-constants-invalid-ring
[519.580443] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[519.677377] [079/156] (506s left) i915_pm_rpm (gem-execbuf-stress)
[521.473304] Starting subtest: gem-execbuf-stress
[521.476245] Starting dynamic subtest: smem0
[534.077120] Dynamic subtest smem0: SUCCESS (12.634s)
[534.091394] Starting dynamic subtest: extra-wait-smem0
[595.924395] Dynamic subtest extra-wait-smem0: SUCCESS (61.858s)
[595.927203] Subtest gem-execbuf-stress: SUCCESS (74.498s)
[596.327027] [080/156] (429s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[596.407709] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[596.412452] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[596.502996] [081/156] (429s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[596.579322] Starting subtest: 4-tiled-16bpp-rotate-90
[596.597839] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.018s)
[596.694391] [082/156] (429s left) gem_exec_schedule (deep)
[596.875663] Starting subtest: deep
[596.877672] Starting dynamic subtest: rcs0
[601.558602] Dynamic subtest rcs0: SKIP (4.682s)
[601.571403] Starting dynamic subtest: vcs0
[611.214735] Dynamic subtest vcs0: SUCCESS (9.661s)
[611.228856] Starting dynamic subtest: vcs1
[621.199461] Dynamic subtest vcs1: SUCCESS (9.977s)
[621.213681] Starting dynamic subtest: vecs0
[631.189472] Dynamic subtest vecs0: SUCCESS (9.985s)
[631.201223] Starting dynamic subtest: ccs0
[642.497030] Dynamic subtest ccs0: SUCCESS (11.306s)
[642.500349] Subtest deep: SUCCESS (45.617s)
[643.921181] [083/156] (382s left) kms_pm_rpm (system-suspend-modeset)
[645.512278] Starting subtest: system-suspend-modeset
[665.343829] Subtest system-suspend-modeset: SUCCESS (4.306s)
[665.741906] [084/156] (360s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[665.825423] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[665.830702] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[665.895459] [085/156] (360s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[665.971249] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[665.976192] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[666.065797] [086/156] (360s left) kms_psr (psr2-primary-blt)
[666.135384] Starting subtest: psr2-primary-blt
[666.137920] Starting dynamic subtest: eDP-1
[667.914365] Dynamic subtest eDP-1: SUCCESS (1.790s)
[667.917290] Subtest psr2-primary-blt: SUCCESS (1.791s)
[668.776957] [087/156] (357s left) gem_mmap_gtt (basic-wc)
[668.830954] Subtest basic-wc: SKIP (0.000s)
[668.889645] [088/156] (357s left) gem_sync (basic-store-all)
[668.972846] Starting subtest: basic-store-all
[671.893138] Subtest basic-store-all: SUCCESS (2.944s)
[672.080110] [089/156] (354s left) gem_mmap_gtt (big-copy-xy)
[672.137945] Subtest big-copy-XY: SKIP (0.000s)
[672.196480] [090/156] (354s left) gem_softpin (32b-excludes-last-page)
[672.255170] Starting subtest: 32b-excludes-last-page
[672.257850] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[672.386596] [091/156] (354s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[672.467272] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[672.472043] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[672.572609] [092/156] (353s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[672.645268] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[672.651176] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[672.725219] [093/156] (353s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[672.794278] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[672.796883] Starting dynamic subtest: pipe-A-eDP-1
[672.807167] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[672.818103] Starting dynamic subtest: pipe-B-eDP-1
[672.829215] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[672.839621] Starting dynamic subtest: pipe-C-eDP-1
[672.850188] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[672.860373] Starting dynamic subtest: pipe-D-eDP-1
[672.871289] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[672.876919] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[675.122627] [094/156] (351s left) prime_vgem (basic-fence-flip)
[675.180586] Starting subtest: basic-fence-flip
[675.548265] Subtest basic-fence-flip: SUCCESS (0.368s)
[675.654876] [095/156] (351s left) gem_exec_whisper (basic-fds-priority-all)
[675.715086] Starting subtest: basic-fds-priority-all
[698.979165] Subtest basic-fds-priority-all: SUCCESS (23.278s)
[699.160548] [096/156] (327s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[699.255884] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[707.904353] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.655s)
[708.027552] [097/156] (318s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[708.108363] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[708.113649] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[708.205891] [098/156] (318s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[708.284275] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[708.289027] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[708.377449] [099/156] (318s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[708.456729] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[715.315033] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.867s)
[715.466969] [100/156] (311s left) gem_exec_reloc (basic-wc-noreloc)
[715.526363] Subtest basic-wc-noreloc: SKIP (0.000s)
[715.590263] [101/156] (311s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[715.670595] Starting subtest: modeset-transition-nonblocking-fencing
[715.673058] Starting dynamic subtest: 1x-outputs
[727.274003] Dynamic subtest 1x-outputs: SUCCESS (11.607s)
[727.277036] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.609s)
[728.126735] [102/156] (298s left) kms_big_fb (y-tiled-addfb-size-overflow)
[728.210159] Starting subtest: y-tiled-addfb-size-overflow
[728.215121] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[728.302607] [103/156] (298s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[728.401932] Starting subtest: cursorB-vs-flipA-atomic
[728.406707] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[728.551163] [104/156] (298s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[728.629884] Starting subtest: plane-downscale-factor-0-5-with-rotation
[728.632341] Starting dynamic subtest: pipe-A
[728.650920] Dynamic subtest pipe-A: SKIP (0.016s)
[728.662644] Starting dynamic subtest: pipe-B
[728.682734] Dynamic subtest pipe-B: SKIP (0.029s)
[728.697134] Starting dynamic subtest: pipe-C
[728.707695] Dynamic subtest pipe-C: SKIP (0.028s)
[728.718745] Starting dynamic subtest: pipe-D
[728.740254] Dynamic subtest pipe-D: SKIP (0.032s)
[728.745169] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.108s)
[728.835587] [105/156] (298s left) kms_hdr (bpc-switch)
[728.901797] Starting subtest: bpc-switch
[728.904432] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[733.496022] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.593s)
[733.508119] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[738.122398] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.626s)
[738.125360] Subtest bpc-switch: SUCCESS (9.223s)
[738.222194] [106/156] (288s left) gem_userptr_blits (unsync-overlap)
[738.287058] Subtest unsync-overlap: SKIP (0.000s)
[738.395561] [107/156] (288s left) gem_exec_fence (syncobj-import)
[738.888886] Starting subtest: syncobj-import
[738.895102] Subtest syncobj-import: SUCCESS (0.005s)
[739.963978] [108/156] (287s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[740.031332] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[740.033896] Starting dynamic subtest: pipe-A
[740.096143] Dynamic subtest pipe-A: SUCCESS (0.067s)
[740.107814] Starting dynamic subtest: pipe-B
[741.306526] Dynamic subtest pipe-B: SUCCESS (1.209s)
[741.320349] Starting dynamic subtest: pipe-C
[742.416240] Dynamic subtest pipe-C: SUCCESS (1.109s)
[742.427806] Starting dynamic subtest: pipe-D
[743.545526] Dynamic subtest pipe-D: SUCCESS (1.129s)
[743.548362] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.519s)
[744.696748] [109/156] (282s left) perf_pmu (busy-accuracy-50)
[744.740293] Starting subtest: busy-accuracy-50
[744.742647] Starting dynamic subtest: rcs0
[746.268083] Dynamic subtest rcs0: SUCCESS (1.529s)
[746.278261] Starting dynamic subtest: bcs0
[747.810308] Dynamic subtest bcs0: SUCCESS (1.539s)
[747.821143] Starting dynamic subtest: vcs0
[749.352394] Dynamic subtest vcs0: SUCCESS (1.540s)
[749.363941] Starting dynamic subtest: vcs1
[750.888404] Dynamic subtest vcs1: SUCCESS (1.535s)
[750.900971] Starting dynamic subtest: vecs0
[752.425677] Dynamic subtest vecs0: SUCCESS (1.535s)
[752.439530] Starting dynamic subtest: ccs0
[753.969669] Dynamic subtest ccs0: SUCCESS (1.543s)
[753.971966] Subtest busy-accuracy-50: SUCCESS (9.234s)
[754.081649] [110/156] (273s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[754.164346] Starting subtest: x-tiled-64bpp-rotate-270
[754.184285] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[754.296736] [111/156] (273s left) kms_cursor_crc (cursor-offscreen-256x256)
[754.497876] Starting subtest: cursor-offscreen-256x256
[754.500401] Starting dynamic subtest: pipe-A-eDP-1
[756.422690] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[756.451968] Starting dynamic subtest: pipe-D-eDP-1
[759.012100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[759.014809] Subtest cursor-offscreen-256x256: SUCCESS (4.518s)
[759.856883] [112/156] (267s left) gem_busy (semaphore)
[760.052371] Subtest semaphore: SKIP (0.000s)
[760.297965] [113/156] (267s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[760.381169] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-wc
[760.387641] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[760.486068] [114/156] (266s left) gem_tiled_wc
[760.597235] [115/156] (266s left) gem_exec_schedule (u-semaphore-user)
[760.676156] Starting subtest: u-semaphore-user
[760.723013] Subtest u-semaphore-user: SUCCESS (0.059s)
[761.941694] [116/156] (265s left) gem_mmap_offset (partial-unmap)
[761.993866] Starting subtest: partial-unmap
[761.995861] Starting dynamic subtest: smem0
[762.495289] Dynamic subtest smem0: SUCCESS (0.502s)
[762.498278] Subtest partial-unmap: SUCCESS (0.503s)
[762.620925] [117/156] (264s left) gem_exec_fence (basic-wait-all)
[762.674736] Starting subtest: basic-wait-all
[762.760678] Subtest basic-wait-all: SUCCESS (0.086s)
[764.929180] [118/156] (262s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[765.002162] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[765.028111] Starting dynamic subtest: pipe-A-plane-0
[765.418322] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s)
[765.430742] Starting dynamic subtest: pipe-A-plane-3
[765.739403] Dynamic subtest pipe-A-plane-3: SUCCESS (0.322s)
[766.859681] Starting dynamic subtest: pipe-B-plane-0
[767.285706] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[767.299856] Starting dynamic subtest: pipe-B-plane-3
[767.606356] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s)
[767.925306] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.920s)
[768.730789] [119/156] (258s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[768.808769] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[768.813714] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[768.901906] [120/156] (258s left) kms_big_fb (linear-8bpp-rotate-0)
[768.979778] Starting subtest: linear-8bpp-rotate-0
[770.272210] Subtest linear-8bpp-rotate-0: SUCCESS (1.293s)
[770.409775] [121/156] (257s left) gem_mmap_gtt (cpuset-basic-small-copy)
[770.471989] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[770.531354] [122/156] (257s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[770.614195] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[770.618067] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[770.702293] [123/156] (257s left) kms_chamelium_frames (hdmi-crc-fast)
[771.071925] Subtest hdmi-crc-fast: SKIP (0.000s)
[771.950844] [124/156] (255s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[772.034360] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[773.014156] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.979s)
[773.134502] [125/156] (254s left) gem_eio (execbuf)
[773.344759] Starting subtest: execbuf
[773.653622] Subtest execbuf: SUCCESS (0.308s)
[773.785406] [126/156] (254s left) gem_create (create-ext-set-pat)
[773.948547] Starting subtest: create-ext-set-pat
[773.951430] Subtest create-ext-set-pat: SUCCESS (0.001s)
[774.057810] [127/156] (253s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[774.138091] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[774.143259] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[774.223504] [128/156] (253s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[774.293058] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[774.302515] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.008s)
[774.377670] [129/156] (253s left) perf (sysctl-defaults)
[774.436522] Starting subtest: sysctl-defaults
[774.439378] Subtest sysctl-defaults: SUCCESS (0.000s)
[774.510405] [130/156] (253s left) gem_softpin (evict-single-offset)
[774.561161] Starting subtest: evict-single-offset
[800.844507] Subtest evict-single-offset: SUCCESS (26.280s)
[800.946657] [131/156] (227s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[801.116982] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[801.122090] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[801.233906] [132/156] (227s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt)
[801.331859] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt
[801.337015] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[801.451447] [133/156] (226s left) gem_vm_create (execbuf)
[801.509927] Starting subtest: execbuf
[801.517414] Subtest execbuf: SUCCESS (0.007s)
[801.636815] [134/156] (226s left) kms_force_connector_basic (force-connector-state)
[801.683253] Subtest force-connector-state: SKIP (0.000s)
[801.744036] [135/156] (226s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[801.816356] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[801.821578] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[801.909310] [136/156] (226s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render)
[801.990550] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render
[801.993983] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[802.081999] [137/156] (226s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[802.165045] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[802.169343] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[802.259133] [138/156] (226s left) gem_ctx_param (root-set)
[802.309166] Starting subtest: root-set
[802.311440] Subtest root-set: SUCCESS (0.001s)
[802.399663] [139/156] (226s left) gem_exec_params (no-vebox)
[802.454647] Starting subtest: no-vebox
[802.456835] Subtest no-vebox: SUCCESS (0.002s)
[803.954805] [140/156] (224s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[804.037486] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[808.149123] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.120s)
[809.376871] [141/156] (219s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[809.452599] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[816.531641] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.089s)
[816.649556] [142/156] (212s left) kms_sequence (queue-busy)
[816.730231] Starting subtest: queue-busy
[816.733042] Starting dynamic subtest: pipe-A-eDP-1
[818.663361] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[818.674802] Starting dynamic subtest: pipe-B-eDP-1
[821.301213] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.637s)
[821.313257] Starting dynamic subtest: pipe-C-eDP-1
[823.894610] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.591s)
[823.906048] Starting dynamic subtest: pipe-D-eDP-1
[826.538663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.645s)
[826.541179] Subtest queue-busy: SUCCESS (9.811s)
[827.427449] [143/156] (201s left) prime_mmap (test_userptr)
[827.471256] Starting subtest: test_userptr
[827.473908] Starting dynamic subtest: test_userptr-smem
[827.476140] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[827.478165] Subtest test_userptr: SUCCESS (0.001s)
[827.568084] [144/156] (201s left) gem_exec_schedule (pi-shared-iova)
[827.751094] Starting subtest: pi-shared-iova
[827.753795] Starting dynamic subtest: rcs0
[827.821170] Dynamic subtest rcs0: SUCCESS (0.073s)
[827.832396] Starting dynamic subtest: vcs0
[827.874137] Dynamic subtest vcs0: SUCCESS (0.051s)
[827.885124] Starting dynamic subtest: vcs1
[827.928051] Dynamic subtest vcs1: SUCCESS (0.053s)
[827.939750] Starting dynamic subtest: vecs0
[827.977516] Dynamic subtest vecs0: SUCCESS (0.048s)
[827.988621] Starting dynamic subtest: ccs0
[828.044155] Dynamic subtest ccs0: SUCCESS (0.066s)
[828.047099] Subtest pi-shared-iova: SUCCESS (0.298s)
[829.952163] [145/156] (198s left) kms_invalid_mode (bad-vtotal)
[830.038453] Starting subtest: bad-vtotal
[830.041102] Starting dynamic subtest: pipe-A-eDP-1
[830.321291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[830.332429] Starting dynamic subtest: pipe-B-eDP-1
[830.335233] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[830.346269] Starting dynamic subtest: pipe-C-eDP-1
[830.348795] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[830.359007] Starting dynamic subtest: pipe-D-eDP-1
[830.361354] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[830.363744] Subtest bad-vtotal: SUCCESS (0.291s)
[831.175908] [146/156] (197s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[831.253732] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[831.259195] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[831.354897] [147/156] (197s left) gem_set_tiling_vs_gtt
[831.476210] [148/156] (197s left) kms_plane_multiple (tiling-yf)
[831.549804] Starting subtest: tiling-yf
[831.555183] Subtest tiling-yf: SKIP (0.000s)
[831.618513] [149/156] (197s left) prime_vgem (shrink)
[831.684214] Starting subtest: shrink
[831.713731] Subtest shrink: SUCCESS (0.030s)
[831.822752] [150/156] (197s left) gen9_exec_parse (unaligned-access)
[831.874194] Subtest unaligned-access: SKIP (0.000s)
[831.938728] [151/156] (197s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[832.013196] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[832.018206] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[832.108948] [152/156] (196s left) kms_color (invalid-degamma-lut-sizes)
[832.174871] Starting subtest: invalid-degamma-lut-sizes
[832.176869] Starting dynamic subtest: pipe-A
[832.468915] Dynamic subtest pipe-A: SUCCESS (0.294s)
[832.480768] Starting dynamic subtest: pipe-B
[832.483000] Dynamic subtest pipe-B: SUCCESS (0.000s)
[832.493592] Starting dynamic subtest: pipe-C
[832.496008] Dynamic subtest pipe-C: SUCCESS (0.000s)
[832.506883] Starting dynamic subtest: pipe-D
[832.509095] Dynamic subtest pipe-D: SUCCESS (0.000s)
[832.511255] Subtest invalid-degamma-lut-sizes: SUCCESS (0.298s)
[833.290129] [153/156] (195s left) vgem_basic (unload)
[833.322346] Starting subtest: unload
[862.327161] Subtest unload: SUCCESS (29.013s)
[862.425858] [154/156] (166s left) gem_eio (hibernate)
[862.669169] Starting subtest: hibernate
[877.250616] Subtest hibernate: SUCCESS (14.584s)
[884.398649] [155/156] (151s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[884.543526] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[889.021221] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.485s)
[890.165999] [156/156] (146s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[890.244370] Starting subtest: fbc-rgb101010-draw-render
[892.754718] Subtest fbc-rgb101010-draw-render: SUCCESS (2.517s)
[893.936571] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: i915_suspend
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: gem_ctx_isolation
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: i915_hangman
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: kms_dsc
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: sw_sync
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: core_getversion
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_tiled_blits
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_rotation_crc
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: gem_flink_race
results: parsing output: 54/ for test: gem_workarounds
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: api_intel_allocator
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_force_connector_basic
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: kms_cursor_edge_walk
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: syncobj_basic
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_pipe_crc_basic
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: gem_sync
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: gem_softpin
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: prime_vgem
results: parsing output: 94/ for test: gem_exec_whisper
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_atomic_transition
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_hdr
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_busy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_tiled_wc
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_frames
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: gem_create
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_vm_create
results: parsing output: 133/ for test: kms_force_connector_basic
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: gem_ctx_param
results: parsing output: 138/ for test: gem_exec_params
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_sequence
results: parsing output: 142/ for test: prime_mmap
results: parsing output: 143/ for test: gem_exec_schedule
results: parsing output: 144/ for test: kms_invalid_mode
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: gem_set_tiling_vs_gtt
results: parsing output: 147/ for test: kms_plane_multiple
results: parsing output: 148/ for test: prime_vgem
results: parsing output: 149/ for test: gen9_exec_parse
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_color
results: parsing output: 152/ for test: vgem_basic
results: parsing output: 153/ for test: gem_eio
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.