[42.789883] Initializing watchdogs
[42.789932]   /dev/watchdog0
[42.795760] [001/130] (960s left) gem_ctx_persistence (heartbeat-hostile)
[42.840455] Starting subtest: heartbeat-hostile
[42.842035] Subtest heartbeat-hostile: SKIP (0.000s)
[42.904869] [002/130] (960s left) i915_fb_tiling
[43.025708] [003/130] (960s left) kms_flip (2x-dpms-vs-vblank-race)
[43.084887] Starting subtest: 2x-dpms-vs-vblank-race
[43.087742] Subtest 2x-dpms-vs-vblank-race: SKIP (0.004s)
[43.157265] [004/130] (960s left) perf (invalid-open-flags)
[43.324757] Starting subtest: invalid-open-flags
[43.325917] Subtest invalid-open-flags: SUCCESS (0.000s)
[43.344551] [005/130] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[43.402464] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[50.192163] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (6.789s)
[50.321060] [006/130] (953s left) gem_userptr_blits (usage-restrictions)
[50.363586] Starting subtest: usage-restrictions
[50.364363] Subtest usage-restrictions: SUCCESS (0.000s)
[50.487806] [007/130] (952s left) kms_psr (fbc-pr-primary-mmap-gtt)
[50.544870] Starting subtest: fbc-pr-primary-mmap-gtt
[50.546700] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[50.620688] [008/130] (952s left) kms_pm_rpm (modeset-non-lpsp)
[52.136280] Starting subtest: modeset-non-lpsp
[53.286635] Subtest modeset-non-lpsp: SKIP (1.149s)
[53.741765] [009/130] (949s left) gem_exec_suspend (basic-s4-devices)
[53.788125] Starting subtest: basic-S4-devices
[53.789112] Starting dynamic subtest: smem
[62.781643] Dynamic subtest smem: SUCCESS (8.993s)
[62.783086] Subtest basic-S4-devices: SUCCESS (8.993s)
[70.990153] [010/130] (940s left) kms_chamelium_edid (dp-edid-read)
[71.366809] Subtest dp-edid-read: SKIP (0.000s)
[72.287378] [011/130] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[72.353767] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[81.027893] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (8.673s)
[81.152970] [012/130] (930s left) gem_softpin (noreloc-s3)
[81.191557] Starting subtest: noreloc-S3
[101.472382] Subtest noreloc-S3: SUCCESS (5.427s)
[101.566629] [013/130] (924s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[101.633634] Starting subtest: cursor-rapid-movement-128x42
[101.637367] Starting dynamic subtest: pipe-A-eDP-1
[102.239195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[102.294198] Starting dynamic subtest: pipe-C-eDP-1
[103.567403] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s)
[103.568200] Subtest cursor-rapid-movement-128x42: SUCCESS (1.934s)
[104.513973] [014/130] (921s left) kms_flip (2x-busy-flip)
[104.579193] Starting subtest: 2x-busy-flip
[104.582979] Subtest 2x-busy-flip: SKIP (0.004s)
[104.659260] [015/130] (921s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[104.718452] Starting subtest: read-crc-frame-sequence
[104.720979] Starting dynamic subtest: pipe-A-eDP-1
[105.499377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s)
[105.509826] Starting dynamic subtest: pipe-B-eDP-1
[107.092321] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s)
[107.103553] Starting dynamic subtest: pipe-C-eDP-1
[108.655995] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.563s)
[108.656764] Subtest read-crc-frame-sequence: SUCCESS (3.938s)
[109.569537] [016/130] (916s left) kms_fb_coherency (memset-crc)
[109.631354] Starting subtest: memset-crc
[109.632292] Starting dynamic subtest: mmap-gtt
[110.075140] Dynamic subtest mmap-gtt: SUCCESS (0.443s)
[110.388008] Starting dynamic subtest: mmap-offset-wc
[111.570866] Dynamic subtest mmap-offset-wc: SUCCESS (1.193s)
[111.884959] Starting dynamic subtest: mmap-offset-uc
[114.820129] Dynamic subtest mmap-offset-uc: SUCCESS (2.955s)
[115.146637] Starting dynamic subtest: mmap-legacy-wc
[116.339407] Dynamic subtest mmap-legacy-wc: SUCCESS (1.201s)
[116.654287] Subtest memset-crc: SUCCESS (7.022s)
[117.555828] [017/130] (908s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[117.620476] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[118.383307] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.763s)
[118.561452] [018/130] (907s left) perf (polling-parameterized)
[118.643466] Starting subtest: polling-parameterized
[138.696212] Subtest polling-parameterized: SUCCESS (20.075s)
[138.719588] [019/130] (887s left) kms_vblank (ts-continuation-dpms-rpm)
[138.791512] Starting subtest: ts-continuation-dpms-rpm
[138.793499] Starting dynamic subtest: pipe-A-eDP-1
[141.439739] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.652s)
[141.453923] Starting dynamic subtest: pipe-C-eDP-1
[143.888697] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.452s)
[143.889561] Subtest ts-continuation-dpms-rpm: SUCCESS (5.107s)
[144.814136] [020/130] (881s left) prime_self_import (export-vs-gem_close-race)
[144.849764] Starting subtest: export-vs-gem_close-race
[149.868121] Subtest export-vs-gem_close-race: SUCCESS (5.020s)
[149.972890] [021/130] (876s left) gem_exec_balancer (bonded-false-hang)
[151.407838] Starting subtest: bonded-false-hang
[151.409730] Subtest bonded-false-hang: SKIP (0.000s)
[151.482913] [022/130] (874s left) kms_addfb_basic (bad-pitch-32)
[151.523994] Starting subtest: bad-pitch-32
[151.524826] Subtest bad-pitch-32: SUCCESS (0.000s)
[151.632746] [023/130] (874s left) gem_exec_fence (syncobj-export)
[151.973330] Starting subtest: syncobj-export
[151.976472] Subtest syncobj-export: SUCCESS (0.003s)
[152.311003] [024/130] (874s left) debugfs_test (sysfs)
[152.345027] Starting subtest: sysfs
[152.398673] Subtest sysfs: SUCCESS (0.053s)
[152.498019] [025/130] (873s left) kms_pipe_crc_basic (bad-source)
[152.551471] Starting subtest: bad-source
[152.552451] Subtest bad-source: SUCCESS (0.000s)
[152.618119] [026/130] (873s left) syncobj_wait (invalid-reset-illegal-handle)
[152.655784] Starting subtest: invalid-reset-illegal-handle
[152.656555] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[152.734314] [027/130] (873s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[152.793323] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[152.795526] Starting dynamic subtest: pipe-A-eDP-1
[152.802952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[152.820082] Starting dynamic subtest: pipe-B-eDP-1
[152.827415] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[152.836862] Starting dynamic subtest: pipe-C-eDP-1
[152.843648] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[152.844381] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SUCCESS (0.009s)
[155.273535] [028/130] (871s left) kms_hdmi_inject (inject-audio)
[155.625567] Starting subtest: inject-audio
[155.778010] Subtest inject-audio: SUCCESS (0.154s)
[156.557107] [029/130] (870s left) kms_addfb_basic (bad-pitch-65536)
[156.590223] Starting subtest: bad-pitch-65536
[156.591086] Subtest bad-pitch-65536: SUCCESS (0.000s)
[156.719299] [030/130] (869s left) kms_invalid_mode (bad-vsync-start)
[156.776005] Starting subtest: bad-vsync-start
[156.776956] Starting dynamic subtest: pipe-A-eDP-1
[157.095333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.318s)
[157.108140] Starting dynamic subtest: pipe-B-eDP-1
[157.109114] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[157.121125] Starting dynamic subtest: pipe-C-eDP-1
[157.122174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[157.123206] Subtest bad-vsync-start: SUCCESS (0.322s)
[158.021065] [031/130] (868s left) kms_cursor_crc (cursor-offscreen-64x21)
[158.084069] Starting subtest: cursor-offscreen-64x21
[158.090086] Starting dynamic subtest: pipe-A-eDP-1
[160.778442] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.690s)
[160.832324] Starting dynamic subtest: pipe-C-eDP-1
[164.170845] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.345s)
[164.171669] Subtest cursor-offscreen-64x21: SUCCESS (6.088s)
[165.125533] [032/130] (861s left) kms_plane_multiple (tiling-x)
[165.190907] Starting subtest: tiling-x
[165.192036] Starting dynamic subtest: pipe-A-eDP-1
[169.620356] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.319s)
[169.637040] Starting dynamic subtest: pipe-B-eDP-1
[174.599328] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.088s)
[174.619825] Starting dynamic subtest: pipe-C-eDP-1
[179.699961] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.098s)
[179.700935] Subtest tiling-x: SUCCESS (14.510s)
[180.614306] [033/130] (846s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[180.682413] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[180.683856] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[180.762592] [034/130] (845s left) gem_exec_capture (pi)
[180.802611] Starting subtest: pi
[180.803361] Starting dynamic subtest: rcs0
[193.180067] Dynamic subtest rcs0: SUCCESS (12.377s)
[193.193923] Starting dynamic subtest: bcs0
[207.121353] Dynamic subtest bcs0: SUCCESS (13.940s)
[207.137121] Starting dynamic subtest: vcs0
[220.916858] Dynamic subtest vcs0: SUCCESS (13.795s)
[220.930359] Starting dynamic subtest: vecs0
[234.913288] Dynamic subtest vecs0: SUCCESS (13.998s)
[234.914342] Subtest pi: SUCCESS (54.112s)
[235.002462] [035/130] (791s left) gem_exec_reloc (basic-write-wc-noreloc)
[235.093557] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[235.149277] [036/130] (791s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[235.189661] Starting subtest: invalid-smem-bo-on-discrete
[235.191438] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[235.314268] [037/130] (791s left) gem_softpin (allocator-fork)
[235.360265] Starting subtest: allocator-fork
[237.609358] Subtest allocator-fork: SUCCESS (2.241s)
[237.707266] [038/130] (789s left) kms_vrr (flip-basic)
[237.773927] Starting subtest: flip-basic
[237.776341] Subtest flip-basic: SKIP (0.000s)
[237.856133] [039/130] (788s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[240.429467] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[240.501927] [040/130] (786s left) gem_exec_reloc (basic-write-gtt)
[240.536347] Subtest basic-write-gtt: SKIP (0.000s)
[240.604902] [041/130] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[240.665277] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[240.666783] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[240.750376] [042/130] (786s left) gem_exec_schedule (submit-golden-slice)
[240.802701] Starting subtest: submit-golden-slice
[240.803677] Starting dynamic subtest: rcs0
[240.819436] Dynamic subtest rcs0: SUCCESS (0.017s)
[240.830015] Starting dynamic subtest: bcs0
[240.836216] Dynamic subtest bcs0: SUCCESS (0.016s)
[240.846052] Starting dynamic subtest: vcs0
[240.851896] Dynamic subtest vcs0: SUCCESS (0.015s)
[240.861602] Starting dynamic subtest: vecs0
[240.866527] Dynamic subtest vecs0: SUCCESS (0.014s)
[240.867359] Subtest submit-golden-slice: SUCCESS (0.064s)
[241.205946] [043/130] (785s left) kms_psr (pr-cursor-blt)
[241.258390] Starting subtest: pr-cursor-blt
[241.260284] Subtest pr-cursor-blt: SKIP (0.000s)
[241.336571] [044/130] (785s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[241.395235] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[241.396947] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[241.469790] [045/130] (785s left) i915_pm_rpm (debugfs-forcewake-user)
[243.005743] Starting subtest: debugfs-forcewake-user
[254.389037] Subtest debugfs-forcewake-user: SUCCESS (11.384s)
[254.848087] [046/130] (772s left) gem_media_vme
[254.914887] [047/130] (771s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[254.967480] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[254.969778] Starting dynamic subtest: pipe-A-default-mode
[255.286176] Dynamic subtest pipe-A-default-mode: SKIP (0.316s)
[255.287695] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.318s)
[256.196428] [048/130] (770s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[256.257857] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[256.258928] Starting dynamic subtest: pipe-A-eDP-1
[256.268326] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[256.285801] Starting dynamic subtest: pipe-B-eDP-1
[256.294116] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[256.304383] Starting dynamic subtest: pipe-C-eDP-1
[256.311994] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[256.313445] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[258.756244] [049/130] (768s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[258.821235] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[264.925070] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (6.096s)
[265.057451] [050/130] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[265.120146] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[265.121714] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[265.207149] [051/130] (761s left) kms_chamelium_audio (dp-audio-edid)
[265.579572] Subtest dp-audio-edid: SKIP (0.000s)
[266.460160] [052/130] (760s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[266.555991] Starting subtest: basic-flip-after-cursor-varying-size
[267.752606] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.197s)
[268.678719] [053/130] (758s left) gem_render_copy (x-tiled)
[268.721986] Starting subtest: x-tiled
[268.722965] Starting dynamic subtest: smem
[268.820153] Dynamic subtest smem: SUCCESS (0.098s)
[268.821081] Subtest x-tiled: SUCCESS (0.098s)
[269.007346] [054/130] (758s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[269.042564] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[269.043447] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[269.110069] [055/130] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[269.175478] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[269.177120] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[269.259360] [056/130] (757s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[269.311516] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[269.312322] Starting dynamic subtest: pipe-A-default-mode
[269.615307] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[269.617449] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.303s)
[270.533832] [057/130] (756s left) gem_exec_balancer (parallel-out-fence)
[271.543262] Subtest parallel-out-fence: SKIP (0.000s)
[271.615005] [058/130] (755s left) kms_lease (implicit-plane-lease)
[271.671034] Starting subtest: implicit-plane-lease
[271.671954] Subtest implicit-plane-lease: SUCCESS (0.002s)
[271.750837] [059/130] (755s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[271.807384] Starting subtest: extended-pageflip-modeset-hang-oldfb
[271.809863] Starting dynamic subtest: pipe-A
[279.760584] Dynamic subtest pipe-A: SUCCESS (7.951s)
[279.778217] Starting dynamic subtest: pipe-C
[288.534014] Dynamic subtest pipe-C: SUCCESS (8.766s)
[288.536428] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.723s)
[289.475137] [060/130] (737s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[289.540130] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[289.541877] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[289.635209] [061/130] (737s left) gem_exec_params (rsvd2-dirt)
[289.667353] Starting subtest: rsvd2-dirt
[289.668982] Subtest rsvd2-dirt: SKIP (0.000s)
[289.773100] [062/130] (737s left) syncobj_wait (wait-for-submit-delayed-submit)
[289.808968] Starting subtest: wait-for-submit-delayed-submit
[289.911974] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[289.994580] [063/130] (737s left) syncobj_timeline (32bits-limit)
[290.026955] Starting subtest: 32bits-limit
[290.027737] Subtest 32bits-limit: SUCCESS (0.001s)
[290.094521] [064/130] (737s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[290.130317] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[290.164715] [065/130] (737s left) gem_mmap_wc (bad-size)
[290.195325] Starting subtest: bad-size
[290.196153] Subtest bad-size: SUCCESS (0.001s)
[290.293737] [066/130] (736s left) kms_frontbuffer_tracking (basic)
[290.350857] Starting subtest: basic
[295.050533] Subtest basic: SUCCESS (4.699s)
[295.146479] [067/130] (732s left) i915_pm_rps (thresholds)
[295.184032] Starting subtest: thresholds
[295.186259] Subtest thresholds: SKIP (0.001s)
[295.263070] [068/130] (732s left) kms_big_fb (linear-8bpp-rotate-270)
[295.332346] Starting subtest: linear-8bpp-rotate-270
[295.370127] Subtest linear-8bpp-rotate-270: SKIP (0.036s)
[295.492566] [069/130] (731s left) prime_mmap_kms (buffer-sharing)
[295.551963] Starting subtest: buffer-sharing
[296.033741] Subtest buffer-sharing: SUCCESS (0.483s)
[296.963412] [070/130] (730s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[300.571000] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[300.576583] Starting dynamic subtest: pipe-A-eDP-1
[301.448534] Dynamic subtest pipe-A-eDP-1: SKIP (0.874s)
[301.466061] Starting dynamic subtest: pipe-B-eDP-1
[302.669257] Dynamic subtest pipe-B-eDP-1: SKIP (1.216s)
[302.671881] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (2.098s)
[304.070897] [071/130] (723s left) kms_psr (psr-sprite-blt)
[304.137541] Starting subtest: psr-sprite-blt
[304.138749] Starting dynamic subtest: eDP-1
[306.104553] Dynamic subtest eDP-1: SUCCESS (1.966s)
[306.106084] Subtest psr-sprite-blt: SUCCESS (1.968s)
[307.014717] [072/130] (720s left) gem_exec_params (dr1-dirt)
[307.056551] Starting subtest: DR1-dirt
[307.057575] Subtest DR1-dirt: SUCCESS (0.000s)
[307.147377] [073/130] (720s left) gem_render_copy (yf-tiled-to-vebox-linear)
[307.181745] Starting subtest: yf-tiled-to-vebox-linear
[307.182575] Starting dynamic subtest: smem
[307.245425] Dynamic subtest smem: SUCCESS (0.063s)
[307.246328] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.064s)
[307.481400] [074/130] (719s left) gem_mmap_offset (bad-object)
[307.516639] Starting subtest: bad-object
[307.517402] Subtest bad-object: SUCCESS (0.001s)
[307.620071] [075/130] (719s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[307.651348] Starting subtest: etime-multi-wait-available-unsubmitted
[307.759194] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[307.843384] [076/130] (719s left) gem_mmap_wc (fault-concurrent)
[307.876747] Starting subtest: fault-concurrent
[307.968028] Subtest fault-concurrent: SUCCESS (0.092s)
[308.045903] [077/130] (719s left) kms_writeback (writeback-fb-id)
[308.106206] Subtest writeback-fb-id: SKIP (0.000s)
[308.130457] [078/130] (719s left) kms_cursor_edge_walk (128x128-top-edge)
[308.180500] Starting subtest: 128x128-top-edge
[308.182876] Starting dynamic subtest: pipe-A-eDP-1
[312.802854] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.620s)
[312.818366] Starting dynamic subtest: pipe-C-eDP-1
[317.105251] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.299s)
[317.106613] Subtest 128x128-top-edge: SUCCESS (8.924s)
[318.021446] [079/130] (709s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[318.090082] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[321.800863] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (3.710s)
[321.944584] [080/130] (705s left) gem_exec_reloc (basic-active)
[321.985307] Subtest basic-active: SKIP (0.000s)
[322.031577] [081/130] (705s left) api_intel_bb (add-remove-objects)
[322.063442] Starting subtest: add-remove-objects
[322.068653] Subtest add-remove-objects: SUCCESS (0.005s)
[322.178381] [082/130] (705s left) kms_rotation_crc (sprite-rotation-180)
[322.233513] Starting subtest: sprite-rotation-180
[328.667668] Subtest sprite-rotation-180: SUCCESS (6.433s)
[329.991860] [083/130] (697s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[330.066960] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[331.580017] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.511s)
[331.705472] [084/130] (695s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[331.765905] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[331.770210] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.004s)
[331.856417] [085/130] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[331.915296] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[331.917285] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[332.007014] [086/130] (695s left) gen7_exec_parse (oacontrol-tracking)
[332.040438] Subtest oacontrol-tracking: SKIP (0.000s)
[332.073148] [087/130] (695s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[335.640705] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[335.646418] Starting dynamic subtest: pipe-A-eDP-1
[357.813276] Dynamic subtest pipe-A-eDP-1: SUCCESS (22.171s)
[357.836946] Starting dynamic subtest: pipe-B-eDP-1
[379.987229] Dynamic subtest pipe-B-eDP-1: SUCCESS (22.171s)
[379.988055] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (44.349s)
[380.936605] [088/130] (646s left) prime_vgem (basic-write)
[380.974049] Starting subtest: basic-write
[380.982574] Subtest basic-write: SKIP (0.008s)
[381.085242] [089/130] (646s left) syncobj_timeline (invalid-query-illegal-handle)
[381.117760] Starting subtest: invalid-query-illegal-handle
[381.118545] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[381.200072] [090/130] (646s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[381.572025] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[382.496905] [091/130] (645s left) syncobj_timeline (wait-for-submit-delayed-submit)
[382.529418] Starting subtest: wait-for-submit-delayed-submit
[382.633715] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[382.724591] [092/130] (645s left) gem_ctx_persistence (many-contexts)
[382.762386] Starting subtest: many-contexts
[421.059160] Subtest many-contexts: SUCCESS (38.297s)
[421.153754] [093/130] (606s left) gem_lmem_swapping (heavy-random)
[421.193189] Subtest heavy-random: SKIP (0.000s)
[421.234697] [094/130] (606s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[421.294470] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[425.687434] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.392s)
[425.831858] [095/130] (601s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[425.899326] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[425.901057] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[426.002037] [096/130] (601s left) kms_psr (fbc-psr-basic)
[426.057019] Starting subtest: fbc-psr-basic
[426.057818] Starting dynamic subtest: eDP-1
[426.059359] Dynamic subtest eDP-1: SKIP (0.000s)
[426.060862] Subtest fbc-psr-basic: SKIP (0.001s)
[426.136840] [097/130] (601s left) gem_pread (display)
[426.166461] Subtest display: SKIP (0.000s)
[426.222319] [098/130] (601s left) fbdev (info)
[426.251924] Starting subtest: info
[426.252826] Subtest info: SUCCESS (0.000s)
[426.333318] [099/130] (601s left) kms_setmode (invalid-clone-single-crtc-stealing)
[426.364201] Starting subtest: invalid-clone-single-crtc-stealing
[426.366586] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[426.433847] [100/130] (601s left) kms_pm_dc (dc5-psr)
[427.495910] Starting subtest: dc5-psr
[430.912558] Subtest dc5-psr: SUCCESS (3.414s)
[431.845316] [101/130] (596s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[431.905224] Starting subtest: psr-rgb101010-draw-mmap-gtt
[437.757167] Subtest psr-rgb101010-draw-mmap-gtt: SUCCESS (5.852s)
[437.885563] [102/130] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[437.942210] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[437.943771] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[438.054745] [103/130] (589s left) gem_create (create-ext-set-pat)
[438.199920] Starting subtest: create-ext-set-pat
[438.202092] Subtest create-ext-set-pat: SKIP (0.000s)
[438.275777] [104/130] (589s left) perf_pmu (init-wait)
[438.312557] Starting subtest: init-wait
[438.313470] Starting dynamic subtest: rcs0
[438.315090] Dynamic subtest rcs0: SUCCESS (0.002s)
[438.325984] Starting dynamic subtest: bcs0
[438.326734] Dynamic subtest bcs0: SUCCESS (0.001s)
[438.335228] Starting dynamic subtest: vcs0
[438.335964] Dynamic subtest vcs0: SUCCESS (0.000s)
[438.343686] Starting dynamic subtest: vecs0
[438.344382] Dynamic subtest vecs0: SUCCESS (0.000s)
[438.345101] Subtest init-wait: SUCCESS (0.005s)
[438.392850] [105/130] (589s left) gem_exec_schedule (manyslice)
[438.428793] Starting subtest: manyslice
[438.429573] Starting dynamic subtest: rcs0
[441.644138] Dynamic subtest rcs0: SUCCESS (3.207s)
[441.662382] Starting dynamic subtest: bcs0
[445.151364] Dynamic subtest bcs0: SUCCESS (3.481s)
[445.161065] Starting dynamic subtest: vcs0
[449.255988] Dynamic subtest vcs0: SUCCESS (4.103s)
[449.265697] Starting dynamic subtest: vecs0
[452.860342] Dynamic subtest vecs0: SUCCESS (3.602s)
[452.862222] Subtest manyslice: SUCCESS (14.399s)
[453.142289] [106/130] (574s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[453.203782] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[459.549459] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.345s)
[459.695044] [107/130] (568s left) syncobj_wait (invalid-signal-one-illegal-handle)
[459.731927] Starting subtest: invalid-signal-one-illegal-handle
[459.732650] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[459.811459] [108/130] (568s left) sw_sync (alloc_timeline)
[459.843694] Starting subtest: alloc_timeline
[459.844627] Subtest alloc_timeline: SUCCESS (0.000s)
[459.892471] [109/130] (568s left) kms_atomic (plane-primary-legacy)
[459.948027] Starting subtest: plane-primary-legacy
[459.949046] Starting dynamic subtest: pipe-A-eDP-1
[460.698657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[460.699931] Subtest plane-primary-legacy: SUCCESS (0.750s)
[461.597060] [110/130] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[461.655776] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[466.298542] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (4.641s)
[466.425053] [111/130] (561s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[466.485051] Starting subtest: plane-upscale-factor-0-25-with-rotation
[466.485848] Starting dynamic subtest: pipe-A
[466.828898] Dynamic subtest pipe-A: SUCCESS (0.344s)
[466.848706] Starting dynamic subtest: pipe-B
[468.350534] Dynamic subtest pipe-B: SUCCESS (1.520s)
[468.372810] Starting dynamic subtest: pipe-C
[469.904812] Dynamic subtest pipe-C: SUCCESS (1.553s)
[469.906032] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (3.421s)
[471.177317] [112/130] (556s left) syncobj_timeline (single-wait-all-available-submitted)
[471.212414] Starting subtest: single-wait-all-available-submitted
[471.213342] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[471.288325] [113/130] (556s left) kms_psr (psr2-primary-page-flip)
[471.343510] Starting subtest: psr2-primary-page-flip
[471.344457] Starting dynamic subtest: eDP-1
[473.272212] Dynamic subtest eDP-1: SUCCESS (1.927s)
[473.273538] Subtest psr2-primary-page-flip: SUCCESS (1.928s)
[474.183907] [114/130] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[474.246055] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[474.247628] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[474.356726] [115/130] (553s left) core_auth (getclient-simple)
[474.385041] Starting subtest: getclient-simple
[474.386661] Subtest getclient-simple: SUCCESS (0.001s)
[474.473328] [116/130] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[474.525848] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[474.527906] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[474.622187] [117/130] (553s left) gem_exec_whisper (basic-contexts)
[474.658652] Starting subtest: basic-contexts
[477.330894] Subtest basic-contexts: SUCCESS (2.671s)
[477.524245] [118/130] (550s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[477.559667] Starting subtest: framebuffer-vs-set-tiling
[477.560371] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[477.673810] [119/130] (550s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[477.730751] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[477.731876] Starting dynamic subtest: pipe-A
[477.772178] Dynamic subtest pipe-A: SKIP (0.039s)
[477.783375] Starting dynamic subtest: pipe-B
[477.831407] Dynamic subtest pipe-B: SKIP (0.060s)
[477.841953] Starting dynamic subtest: pipe-C
[477.892875] Dynamic subtest pipe-C: SKIP (0.060s)
[477.894250] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.161s)
[477.987630] [120/130] (550s left) kms_flip (basic-plain-flip)
[478.050456] Starting subtest: basic-plain-flip
[478.051545] Starting dynamic subtest: A-eDP1
[480.017396] Dynamic subtest A-eDP1: SUCCESS (1.967s)
[480.030926] Starting dynamic subtest: B-eDP1
[482.002018] Dynamic subtest B-eDP1: SUCCESS (1.982s)
[482.028094] Starting dynamic subtest: C-eDP1
[483.967475] Dynamic subtest C-eDP1: SUCCESS (1.963s)
[483.970861] Subtest basic-plain-flip: SUCCESS (5.925s)
[485.255964] [121/130] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[485.320051] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[485.321726] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[485.442358] [122/130] (542s left) gem_busy (busy)
[485.479253] Starting subtest: busy
[485.480346] Starting dynamic subtest: all-engines
[485.511907] Dynamic subtest all-engines: SUCCESS (0.032s)
[485.523252] Starting dynamic subtest: rcs0
[485.561514] Dynamic subtest rcs0: SUCCESS (0.049s)
[485.578643] Starting dynamic subtest: bcs0
[485.606278] Dynamic subtest bcs0: SUCCESS (0.042s)
[485.623182] Starting dynamic subtest: vcs0
[485.646910] Dynamic subtest vcs0: SUCCESS (0.040s)
[485.661744] Starting dynamic subtest: vecs0
[485.687090] Dynamic subtest vecs0: SUCCESS (0.039s)
[485.688271] Subtest busy: SUCCESS (0.207s)
[486.021174] [123/130] (542s left) kms_color (ctm-0-25)
[486.079652] Starting subtest: ctm-0-25
[486.080569] Starting dynamic subtest: pipe-A-eDP-1
[490.034026] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.951s)
[490.058630] Starting dynamic subtest: pipe-B-eDP-1
[494.782669] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.747s)
[494.805624] Starting dynamic subtest: pipe-C-eDP-1
[499.472952] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.688s)
[499.473786] Subtest ctm-0-25: SUCCESS (13.395s)
[500.420803] [124/130] (527s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[500.491715] Starting subtest: yf-tiled-32bpp-rotate-90
[500.493473] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[500.589742] [125/130] (527s left) kms_flip (flip-vs-wf_vblank-interruptible)
[500.650104] Starting subtest: flip-vs-wf_vblank-interruptible
[500.653255] Starting dynamic subtest: A-eDP1
[502.894076] Dynamic subtest A-eDP1: SUCCESS (2.240s)
[502.919931] Starting dynamic subtest: B-eDP1
[505.134085] Dynamic subtest B-eDP1: SUCCESS (2.237s)
[505.159762] Starting dynamic subtest: C-eDP1
[507.357194] Dynamic subtest C-eDP1: SUCCESS (2.220s)
[507.360659] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (6.710s)
[508.611605] [126/130] (519s left) gem_mmap_gtt (big-bo-tiledy)
[508.644778] Starting subtest: big-bo-tiledY
[508.823106] Subtest big-bo-tiledY: SUCCESS (0.178s)
[508.937437] [127/130] (519s left) kms_psr (pr-primary-blt)
[509.030167] Starting subtest: pr-primary-blt
[509.031765] Subtest pr-primary-blt: SKIP (0.000s)
[509.109503] [128/130] (519s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[509.171092] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[509.171973] Starting dynamic subtest: pipe-A-eDP-1
[509.191241] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[509.201791] Starting dynamic subtest: pipe-B-eDP-1
[509.220223] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[509.229454] Starting dynamic subtest: pipe-C-eDP-1
[509.248234] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[509.249885] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.010s)
[511.623975] [129/130] (516s left) gem_spin_batch (user-each)
[511.668364] Starting subtest: user-each
[514.929050] Subtest user-each: SUCCESS (3.256s)
[515.163198] [130/130] (513s left) kms_dirtyfb (default-dirtyfb-ioctl)
[515.223396] Starting subtest: default-dirtyfb-ioctl
[515.224223] Starting dynamic subtest: A-eDP-1
[516.880500] Dynamic subtest A-eDP-1: SUCCESS (1.656s)
[516.881405] Subtest default-dirtyfb-ioctl: SUCCESS (1.657s)
[517.828111] Closing watchdogs
Done.