[62.497566] Initializing watchdogs
[62.497645]   /dev/watchdog0
[62.512326] [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]
[62.516541] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.518747] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.522369] [001/131] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[62.632157] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[62.634533] Starting dynamic subtest: pipe-A
[64.242824] Dynamic subtest pipe-A: SUCCESS (1.611s)
[64.251502] Starting dynamic subtest: pipe-B
[66.856986] Dynamic subtest pipe-B: SUCCESS (2.614s)
[66.864332] Starting dynamic subtest: pipe-C
[68.030338] Dynamic subtest pipe-C: SUCCESS (1.173s)
[68.038963] Starting dynamic subtest: pipe-D
[69.268716] Dynamic subtest pipe-D: SUCCESS (1.238s)
[69.271073] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.637s)
[70.431126] [002/131] (952s left) kms_cursor_crc (cursor-random-128x128)
[70.645250] Starting subtest: cursor-random-128x128
[70.650158] Starting dynamic subtest: pipe-A-eDP-1
[74.511990] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.863s)
[74.544156] Starting dynamic subtest: pipe-D-eDP-1
[78.978080] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.441s)
[78.980613] Subtest cursor-random-128x128: SUCCESS (8.333s)
[79.786872] [003/131] (943s left) kms_content_protection (uevent)
[79.964379] Starting subtest: uevent
[83.315363] Subtest uevent: SKIP (3.349s)
[84.483865] [004/131] (938s left) api_intel_allocator (reopen)
[84.546177] Starting subtest: reopen
[84.550663] Subtest reopen: SUCCESS (0.005s)
[84.663929] [005/131] (938s left) kms_plane_alpha_blend (alpha-7efc)
[84.756063] Starting subtest: alpha-7efc
[85.199711] Starting dynamic subtest: pipe-A-eDP-1
[85.775424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[85.797989] Starting dynamic subtest: pipe-D-eDP-1
[87.066017] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s)
[87.068335] Subtest alpha-7efc: SUCCESS (2.307s)
[87.919300] [006/131] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[88.025075] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[88.029242] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.118832] [007/131] (935s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[88.219710] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[88.222172] Starting dynamic subtest: A-eDP1
[91.834826] Dynamic subtest A-eDP1: SUCCESS (3.613s)
[91.843032] Starting dynamic subtest: B-eDP1
[95.008058] Dynamic subtest B-eDP1: SUCCESS (3.173s)
[95.017300] Starting dynamic subtest: C-eDP1
[98.082616] Dynamic subtest C-eDP1: SUCCESS (3.072s)
[98.091778] Starting dynamic subtest: D-eDP1
[101.152890] Dynamic subtest D-eDP1: SUCCESS (3.070s)
[101.154907] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.933s)
[101.945494] [008/131] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[102.056619] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[109.072100] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.018s)
[109.181896] [009/131] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[109.274724] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[109.279221] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[109.365095] [010/131] (913s left) perf_pmu (busy-double-start)
[109.404403] Starting subtest: busy-double-start
[109.406712] Starting dynamic subtest: rcs0
[113.048759] Dynamic subtest rcs0: FAIL (3.589s)
[113.058080] Starting dynamic subtest: bcs0
[116.634303] Dynamic subtest bcs0: FAIL (3.568s)
[116.644097] Starting dynamic subtest: vcs0
[120.437939] Dynamic subtest vcs0: SUCCESS (3.875s)
[120.448621] Starting dynamic subtest: vcs1
[124.464870] Dynamic subtest vcs1: SUCCESS (4.026s)
[124.474754] Starting dynamic subtest: vecs0
[128.406851] Dynamic subtest vecs0: SUCCESS (3.941s)
[128.415698] Starting dynamic subtest: ccs0
[132.042270] Dynamic subtest ccs0: FAIL (3.566s)
[132.044128] Subtest busy-double-start: FAIL (22.570s)
[132.080842] [011/131] (891s left) testdisplay
[132.436413] [012/131] (890s left) gem_exec_balancer (parallel)
[132.699571] Starting subtest: parallel
[133.613664] Subtest parallel: SUCCESS (0.913s)
[133.944543] [013/131] (889s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[134.049294] Starting subtest: 4-tiled-8bpp-rotate-90
[134.070180] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[134.191386] [014/131] (889s left) sriov_basic (bind-unbind-vf)
[134.254606] Starting subtest: bind-unbind-vf
[134.256974] Starting dynamic subtest: vf-1
[134.330762] Dynamic subtest vf-1: FAIL (0.006s)
[134.340802] Starting dynamic subtest: vf-2
[134.416266] Dynamic subtest vf-2: FAIL (0.004s)
[134.426216] Starting dynamic subtest: vf-3
[134.500277] Dynamic subtest vf-3: FAIL (0.003s)
[134.509529] Starting dynamic subtest: vf-4
[134.583132] Dynamic subtest vf-4: FAIL (0.005s)
[134.592409] Starting dynamic subtest: vf-5
[134.665286] Dynamic subtest vf-5: FAIL (0.003s)
[134.674067] Starting dynamic subtest: vf-6
[134.747768] Dynamic subtest vf-6: FAIL (0.004s)
[134.756614] Starting dynamic subtest: vf-7
[134.830685] Dynamic subtest vf-7: FAIL (0.003s)
[134.838487] Starting dynamic subtest: vf-random
[134.909375] Dynamic subtest vf-random: FAIL (0.003s)
[134.918036] Starting dynamic subtest: vf-last
[134.978126] Dynamic subtest vf-last: FAIL (0.512s)
[134.979792] Subtest bind-unbind-vf: FAIL (0.546s)
[135.013460] [015/131] (888s left) gem_exec_balancer (bonded-chain)
[135.075065] Starting subtest: bonded-chain
[142.050312] Subtest bonded-chain: SUCCESS (6.972s)
[142.354959] [016/131] (881s left) syncobj_timeline (multi-wait-available-submitted)
[142.418035] Starting subtest: multi-wait-available-submitted
[142.420567] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[142.531858] [017/131] (881s left) gem_partial_pwrite_pread (reads-snoop)
[142.596415] Subtest reads-snoop: SKIP (0.000s)
[142.673125] [018/131] (880s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[147.691344] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[147.693922] Starting dynamic subtest: pipe-A-eDP-1
[148.494357] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[148.503308] Starting dynamic subtest: pipe-B-eDP-1
[149.615291] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[149.619902] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.921s)
[150.789067] [019/131] (872s left) gem_ppgtt (flink-and-close-vma-leak)
[150.856192] Starting subtest: flink-and-close-vma-leak
[150.899705] Subtest flink-and-close-vma-leak: SUCCESS (0.044s)
[151.050351] [020/131] (872s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[151.161889] Starting subtest: fbc-rgb565-draw-mmap-gtt
[151.166097] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[151.275928] [021/131] (872s left) kms_joiner (invalid-modeset-force-big-joiner)
[151.384989] Starting subtest: invalid-modeset-force-big-joiner
[151.387348] Starting dynamic subtest: big_joiner_on_last_pipe
[151.728115] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.351s)
[151.730419] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.351s)
[152.510588] [022/131] (871s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[152.618060] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[152.620412] Starting dynamic subtest: pipe-A-eDP-1
[152.643764] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.654087] Starting dynamic subtest: pipe-B-eDP-1
[152.675848] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.683966] Starting dynamic subtest: pipe-C-eDP-1
[152.706097] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.714075] Starting dynamic subtest: pipe-D-eDP-1
[152.736413] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.740532] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[154.762045] [023/131] (869s left) vgem_basic (bad-pad)
[154.863374] Starting subtest: bad-pad
[154.865774] Subtest bad-pad: SUCCESS (0.000s)
[154.920712] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[154.924400] [024/131] (868s left) gem_exec_reloc (basic-wc-read-noreloc)
[154.987688] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[155.058332] [025/131] (868s left) api_intel_allocator (fork-simple-once)
[155.103219] Starting subtest: fork-simple-once
[155.116815] Subtest fork-simple-once: SUCCESS (0.016s)
[155.248342] [026/131] (868s left) kms_busy (basic-hang)
[155.358106] Starting subtest: basic-hang
[155.360479] Starting dynamic subtest: flip-pipe-A
[156.053104] Dynamic subtest flip-pipe-A: SUCCESS (0.691s)
[156.063747] Starting dynamic subtest: modeset-pipe-A
[159.469599] Dynamic subtest modeset-pipe-A: SUCCESS (3.417s)
[159.478937] Starting dynamic subtest: flip-pipe-D
[160.727587] Dynamic subtest flip-pipe-D: SUCCESS (1.256s)
[160.736637] Starting dynamic subtest: modeset-pipe-D
[164.162986] Dynamic subtest modeset-pipe-D: SUCCESS (3.432s)
[164.165437] Subtest basic-hang: SUCCESS (8.801s)
[164.962153] [027/131] (859s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[165.047324] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[165.049654] Starting dynamic subtest: pipe-A-eDP-1
[165.075089] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.083471] Starting dynamic subtest: pipe-B-eDP-1
[165.108072] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.116291] Starting dynamic subtest: pipe-C-eDP-1
[165.140689] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.149095] Starting dynamic subtest: pipe-D-eDP-1
[165.175699] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.180168] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[167.217514] [028/131] (856s left) kms_flip (wf_vblank-ts-check)
[167.311215] Starting subtest: wf_vblank-ts-check
[167.313448] Starting dynamic subtest: A-eDP1
[176.287779] Dynamic subtest A-eDP1: SUCCESS (8.942s)
[176.301336] Starting dynamic subtest: B-eDP1
[185.204721] Dynamic subtest B-eDP1: SUCCESS (8.914s)
[185.212812] Starting dynamic subtest: C-eDP1
[194.125368] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[194.135136] Starting dynamic subtest: D-eDP1
[203.047972] Dynamic subtest D-eDP1: SUCCESS (8.916s)
[203.050480] Subtest wf_vblank-ts-check: SUCCESS (35.695s)
[204.210286] [029/131] (819s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[204.323265] Starting subtest: cursorB-vs-flipB-atomic-transitions
[204.328424] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[204.471918] [030/131] (819s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[204.570671] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[204.572983] Starting dynamic subtest: A-eDP1
[208.120483] Dynamic subtest A-eDP1: SUCCESS (3.546s)
[208.128458] Starting dynamic subtest: B-eDP1
[211.297950] Dynamic subtest B-eDP1: SUCCESS (3.179s)
[211.307408] Starting dynamic subtest: C-eDP1
[214.366171] Dynamic subtest C-eDP1: SUCCESS (3.066s)
[214.381792] Starting dynamic subtest: D-eDP1
[217.439998] Dynamic subtest D-eDP1: SUCCESS (3.073s)
[217.442536] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.872s)
[218.231673] [031/131] (805s left) gem_ctx_exec (basic-nohangcheck)
[218.297811] Starting subtest: basic-nohangcheck
[218.539554] Subtest basic-nohangcheck: SUCCESS (0.244s)
[218.675430] [032/131] (805s left) sw_sync (sync_multi_timeline_wait)
[218.708121] Starting subtest: sync_multi_timeline_wait
[218.710556] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[218.762965] [033/131] (805s left) kms_cursor_legacy (forked-bo)
[218.875351] Starting subtest: forked-bo
[218.877495] Starting dynamic subtest: pipe-A
[224.385656] Dynamic subtest pipe-A: SUCCESS (5.456s)
[224.396151] Starting dynamic subtest: pipe-B
[229.854239] Dynamic subtest pipe-B: SUCCESS (5.467s)
[229.862904] Starting dynamic subtest: pipe-C
[235.319700] Dynamic subtest pipe-C: SUCCESS (5.464s)
[235.328327] Starting dynamic subtest: pipe-D
[240.805060] Dynamic subtest pipe-D: SUCCESS (5.483s)
[240.819140] Starting dynamic subtest: all-pipes
[246.309320] Dynamic subtest all-pipes: SUCCESS (5.503s)
[246.311343] Subtest forked-bo: SUCCESS (27.381s)
[246.408439] [034/131] (777s left) kms_cursor_crc (cursor-sliding-64x21)
[246.618757] Starting subtest: cursor-sliding-64x21
[246.663080] Subtest cursor-sliding-64x21: SKIP (0.041s)
[246.900951] [035/131] (777s left) kms_busy (extended-pageflip-hang-oldfb)
[247.000125] Starting subtest: extended-pageflip-hang-oldfb
[247.002328] Starting dynamic subtest: pipe-A
[247.449244] Dynamic subtest pipe-A: SUCCESS (0.448s)
[247.461530] Starting dynamic subtest: pipe-D
[248.570042] Dynamic subtest pipe-D: SUCCESS (1.120s)
[248.572739] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.572s)
[249.379044] [036/131] (774s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[249.431658] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[249.498265] [037/131] (774s left) gem_ctx_persistence (engines-hostile-preempt)
[249.558379] Starting subtest: engines-hostile-preempt
[249.560829] Starting dynamic subtest: rcs0
[249.636737] Dynamic subtest rcs0: SUCCESS (0.078s)
[249.648183] Starting dynamic subtest: bcs0
[249.704794] Dynamic subtest bcs0: SUCCESS (0.066s)
[249.715945] Starting dynamic subtest: vcs0
[250.925469] Dynamic subtest vcs0: SUCCESS (1.217s)
[250.936746] Starting dynamic subtest: vcs1
[252.905177] Dynamic subtest vcs1: SUCCESS (1.972s)
[252.915332] Starting dynamic subtest: vecs0
[254.963996] Dynamic subtest vecs0: SUCCESS (2.010s)
[254.974792] Starting dynamic subtest: ccs0
[255.000878] Dynamic subtest ccs0: SUCCESS (0.090s)
[255.003441] Subtest engines-hostile-preempt: SUCCESS (5.443s)
[255.080922] [038/131] (769s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[255.140892] Starting subtest: mixed-tiled-to-y-tiled-ccs
[255.145216] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[255.321976] [039/131] (769s left) kms_color (ctm-blue-to-red)
[255.421188] Starting subtest: ctm-blue-to-red
[255.423570] Starting dynamic subtest: pipe-A-eDP-1
[256.110357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[256.120953] Starting dynamic subtest: pipe-B-eDP-1
[257.439761] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.331s)
[257.449144] Starting dynamic subtest: pipe-C-eDP-1
[258.723532] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.282s)
[258.733062] Starting dynamic subtest: pipe-D-eDP-1
[260.047093] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[260.049059] Subtest ctm-blue-to-red: SUCCESS (4.623s)
[260.882136] [040/131] (763s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[260.942303] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[261.071307] [041/131] (763s left) gem_userptr_blits (coherency-unsync)
[261.145012] Subtest coherency-unsync: SKIP (0.000s)
[261.298592] [042/131] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[261.399672] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[261.404062] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[261.494221] [043/131] (763s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[261.580331] Starting subtest: coverage-vs-premult-vs-constant
[262.036142] Starting dynamic subtest: pipe-A-eDP-1
[262.659024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[262.668081] Starting dynamic subtest: pipe-D-eDP-1
[263.990034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[263.992294] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.408s)
[264.833208] [044/131] (759s left) kms_scaling_modes (scaling-mode-full)
[264.932380] Starting subtest: scaling-mode-full
[264.934810] Starting dynamic subtest: pipe-A-eDP-1
[265.052036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.119s)
[265.061369] Starting dynamic subtest: pipe-B-eDP-1
[266.257420] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.203s)
[266.266124] Starting dynamic subtest: pipe-C-eDP-1
[267.457765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[267.466305] Starting dynamic subtest: pipe-D-eDP-1
[268.582066] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[268.584414] Subtest scaling-mode-full: SUCCESS (3.650s)
[269.731480] [045/131] (755s left) gem_workarounds (suspend-resume-fd)
[269.793897] Starting subtest: suspend-resume-fd
[285.657813] Subtest suspend-resume-fd: SUCCESS (1.290s)
[285.794073] [046/131] (738s left) syncobj_basic (illegal-fd-to-handle)
[285.879594] Starting subtest: illegal-fd-to-handle
[285.882328] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[285.992809] [047/131] (738s left) fbdev (read)
[286.042925] Starting subtest: read
[286.575298] Subtest read: SUCCESS (0.530s)
[286.638035] [048/131] (738s left) syncobj_wait (wait-all-snapshot)
[286.695614] Starting subtest: wait-all-snapshot
[286.776897] Subtest wait-all-snapshot: SUCCESS (0.081s)
[286.856565] [049/131] (738s left) kms_psr (fbc-pr-sprite-plane-move)
[286.957913] Starting subtest: fbc-pr-sprite-plane-move
[286.962096] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[287.031115] [050/131] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[287.137383] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[287.141435] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[287.246850] [051/131] (737s left) gem_busy (parallel)
[287.438619] Starting subtest: parallel
[287.441389] Starting dynamic subtest: rcs0
[289.474196] Dynamic subtest rcs0: SUCCESS (2.031s)
[289.486460] Starting dynamic subtest: bcs0
[291.454942] Dynamic subtest bcs0: SUCCESS (1.977s)
[291.466430] Starting dynamic subtest: vcs0
[293.556310] Dynamic subtest vcs0: SUCCESS (2.045s)
[293.567286] Starting dynamic subtest: vcs1
[295.487905] Dynamic subtest vcs1: SUCCESS (1.981s)
[295.497585] Starting dynamic subtest: vecs0
[297.472165] Dynamic subtest vecs0: SUCCESS (1.981s)
[297.483333] Starting dynamic subtest: ccs0
[299.507115] Dynamic subtest ccs0: SUCCESS (1.980s)
[299.509657] Subtest parallel: SUCCESS (12.008s)
[299.722663] [052/131] (725s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[299.782066] Starting subtest: wait-all-for-submit-delayed-submit
[299.886726] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[299.964045] [053/131] (725s left) kms_pm_rpm (cursor-dpms)
[301.609200] Starting subtest: cursor-dpms
[301.614216] Subtest cursor-dpms: SKIP (0.000s)
[302.250815] [054/131] (722s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[302.310990] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[302.313394] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[302.403993] [055/131] (722s left) kms_addfb_basic (addfb25-bad-modifier)
[302.497805] Starting subtest: addfb25-bad-modifier
[302.500162] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[302.613594] [056/131] (722s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[302.722845] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[302.734032] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[302.852492] [057/131] (722s left) gem_exec_store (dword)
[302.919139] Starting subtest: dword
[302.921016] Starting dynamic subtest: rcs0
[303.003567] Dynamic subtest rcs0: SUCCESS (0.087s)
[303.016446] Starting dynamic subtest: bcs0
[303.045357] Dynamic subtest bcs0: SUCCESS (0.040s)
[303.057477] Starting dynamic subtest: vcs0
[303.086087] Dynamic subtest vcs0: SUCCESS (0.039s)
[303.097122] Starting dynamic subtest: vcs1
[303.127283] Dynamic subtest vcs1: SUCCESS (0.040s)
[303.139037] Starting dynamic subtest: vecs0
[303.167495] Dynamic subtest vecs0: SUCCESS (0.039s)
[303.177790] Starting dynamic subtest: ccs0
[303.210140] Dynamic subtest ccs0: SUCCESS (0.041s)
[303.212163] Subtest dword: SUCCESS (0.295s)
[303.394000] [058/131] (721s left) perf_pmu (rc6-suspend)
[303.429942] Starting subtest: rc6-suspend
[325.812414] Subtest rc6-suspend: SUCCESS (7.463s)
[326.706408] [059/131] (698s left) kms_flip (2x-busy-flip)
[326.820249] Starting subtest: 2x-busy-flip
[326.831567] Subtest 2x-busy-flip: SKIP (0.011s)
[326.909909] [060/131] (698s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[327.011892] Starting subtest: x-tiled-64bpp-rotate-270
[327.032173] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[327.166921] [061/131] (698s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[327.259541] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[327.261514] Starting dynamic subtest: pipe-A
[327.269056] Dynamic subtest pipe-A: SKIP (0.005s)
[327.279753] Starting dynamic subtest: pipe-B
[327.289813] Dynamic subtest pipe-B: SKIP (0.018s)
[327.298419] Starting dynamic subtest: pipe-C
[327.308997] Dynamic subtest pipe-C: SKIP (0.019s)
[327.317799] Starting dynamic subtest: pipe-D
[327.328028] Dynamic subtest pipe-D: SKIP (0.020s)
[327.331134] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.064s)
[327.424000] [062/131] (697s left) gem_lmem_swapping (smem-oom)
[327.466833] Subtest smem-oom: SKIP (0.000s)
[327.511513] [063/131] (697s left) perf (rc6-disable)
[327.628296] Starting subtest: rc6-disable
[327.817601] Subtest rc6-disable: SUCCESS (0.190s)
[327.870249] [064/131] (697s left) i915_query (query-regions-sanity-check)
[327.937598] Starting subtest: query-regions-sanity-check
[327.948161] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[328.090326] [065/131] (697s left) i915_drm_fdinfo (memory-info-active)
[328.127752] Starting subtest: memory-info-active
[328.130051] Starting dynamic subtest: smem0
[331.270817] Dynamic subtest smem0: SUCCESS (3.139s)
[331.273385] Subtest memory-info-active: SUCCESS (3.140s)
[331.347455] [066/131] (694s left) i915_suspend (forcewake)
[331.401715] Starting subtest: forcewake
[363.577649] Subtest forcewake: SUCCESS (2.197s)
[363.648370] [067/131] (661s left) kms_psr (fbc-psr-primary-render)
[363.755033] Starting subtest: fbc-psr-primary-render
[363.757244] Starting dynamic subtest: eDP-1
[363.761528] Dynamic subtest eDP-1: SKIP (0.000s)
[363.765712] Subtest fbc-psr-primary-render: SKIP (0.001s)
[363.827514] [068/131] (661s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[368.846467] Starting subtest: pr-plane-move-sf-dmg-area
[368.851451] Subtest pr-plane-move-sf-dmg-area: SKIP (0.003s)
[369.706223] [069/131] (656s left) prime_vgem (basic-gtt)
[369.813127] Starting subtest: basic-gtt
[369.817899] Subtest basic-gtt: SKIP (0.000s)
[369.927840] [070/131] (655s left) kms_psr (fbc-psr2-sprite-plane-move)
[370.031091] Starting subtest: fbc-psr2-sprite-plane-move
[370.033400] Starting dynamic subtest: eDP-1
[370.037782] Dynamic subtest eDP-1: SKIP (0.000s)
[370.042123] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[370.101542] [071/131] (655s left) gem_pread (bench)
[370.161004] Subtest bench: SKIP (0.000s)
[370.220172] [072/131] (655s left) kms_lease (lease-unleased-connector)
[370.312142] Starting subtest: lease-unleased-connector
[370.314484] Starting dynamic subtest: pipe-A-eDP-1
[370.319855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[370.330401] Starting dynamic subtest: pipe-B-eDP-1
[370.332748] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[370.342480] Starting dynamic subtest: pipe-C-eDP-1
[370.344853] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[370.354204] Starting dynamic subtest: pipe-D-eDP-1
[370.356184] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[370.358099] Subtest lease-unleased-connector: SUCCESS (0.033s)
[370.463497] [073/131] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[370.570565] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[370.574889] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[370.677022] [074/131] (655s left) kms_rotation_crc (cursor-rotation-180)
[370.763518] Starting subtest: cursor-rotation-180
[372.260727] Subtest cursor-rotation-180: SUCCESS (1.496s)
[373.459814] [075/131] (652s left) gem_render_copy (linear)
[373.531414] Starting subtest: linear
[373.533731] Starting dynamic subtest: smem
[373.574573] Dynamic subtest smem: SUCCESS (0.043s)
[373.576971] Subtest linear: SUCCESS (0.043s)
[373.757984] [076/131] (652s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[373.858525] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[373.860989] Starting dynamic subtest: pipe-A-eDP-1
[373.884951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[373.896782] Starting dynamic subtest: pipe-B-eDP-1
[373.918686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[373.927186] Starting dynamic subtest: pipe-C-eDP-1
[373.948876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[373.957303] Starting dynamic subtest: pipe-D-eDP-1
[373.979186] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[373.983635] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[376.095954] [077/131] (649s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[376.194025] Starting subtest: fbcpsr-modesetfrombusy
[382.436243] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.244s)
[382.576679] [078/131] (643s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[382.639249] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[382.744101] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[382.819590] [079/131] (643s left) syncobj_wait (wait-all-complex)
[382.877754] Starting subtest: wait-all-complex
[383.093449] Subtest wait-all-complex: SUCCESS (0.214s)
[383.170481] [080/131] (643s left) gem_exec_fence (concurrent)
[383.345660] Starting subtest: concurrent
[383.350118] Subtest concurrent: SKIP (0.000s)
[385.438824] [081/131] (640s left) syncobj_wait (invalid-wait-illegal-handle)
[385.491243] Starting subtest: invalid-wait-illegal-handle
[385.493176] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[385.599057] [082/131] (640s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[385.706520] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[387.008751] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.303s)
[387.248737] [083/131] (639s left) gem_exec_schedule (promotion)
[387.328184] Starting subtest: promotion
[387.330107] Starting dynamic subtest: rcs0
[387.431771] Dynamic subtest rcs0: SUCCESS (0.110s)
[387.443185] Starting dynamic subtest: vcs0
[387.516746] Dynamic subtest vcs0: SUCCESS (0.084s)
[387.528520] Starting dynamic subtest: vcs1
[387.598031] Dynamic subtest vcs1: SUCCESS (0.081s)
[387.611911] Starting dynamic subtest: vecs0
[387.689486] Dynamic subtest vecs0: SUCCESS (0.090s)
[387.701109] Starting dynamic subtest: ccs0
[387.776385] Dynamic subtest ccs0: SUCCESS (0.086s)
[387.778871] Subtest promotion: SUCCESS (0.455s)
[389.516445] [084/131] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[389.611200] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[389.615588] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[389.705801] [085/131] (636s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[389.802055] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[393.860244] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.061s)
[395.007486] [086/131] (631s left) gem_exec_schedule (implicit-boths)
[395.090143] Starting subtest: implicit-boths
[395.092478] Starting dynamic subtest: rcs0
[395.192269] Dynamic subtest rcs0: SUCCESS (0.113s)
[395.202060] Starting dynamic subtest: vcs0
[395.277998] Dynamic subtest vcs0: SUCCESS (0.085s)
[395.287430] Starting dynamic subtest: vcs1
[395.372718] Dynamic subtest vcs1: SUCCESS (0.094s)
[395.384996] Starting dynamic subtest: vecs0
[395.447551] Dynamic subtest vecs0: SUCCESS (0.074s)
[395.459711] Starting dynamic subtest: ccs0
[395.528630] Dynamic subtest ccs0: SUCCESS (0.081s)
[395.531289] Subtest implicit-boths: SUCCESS (0.450s)
[396.505272] [087/131] (629s left) kms_big_fb (x-tiled-addfb)
[396.616495] Starting subtest: x-tiled-addfb
[396.618751] Subtest x-tiled-addfb: SUCCESS (0.000s)
[396.731381] [088/131] (629s left) gem_pxp (create-valid-protected-context)
[396.858189] Starting subtest: create-valid-protected-context
[396.860622] Subtest create-valid-protected-context: SUCCESS (0.002s)
[396.967597] [089/131] (629s left) gem_exec_whisper (basic-queues-priority)
[397.031883] Starting subtest: basic-queues-priority
[421.468118] Subtest basic-queues-priority: SUCCESS (24.374s)
[421.600811] [090/131] (605s left) gem_exec_params (dr4-dirt)
[421.652812] Starting subtest: DR4-dirt
[421.655234] Subtest DR4-dirt: SUCCESS (0.000s)
[421.761031] [091/131] (604s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[421.879604] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[428.781165] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (6.902s)
[428.930572] [092/131] (597s left) kms_draw_crc (draw-method-pwrite)
[429.031168] Starting subtest: draw-method-pwrite
[429.033350] Starting dynamic subtest: xrgb8888-untiled
[429.605201] Dynamic subtest xrgb8888-untiled: SUCCESS (0.576s)
[429.616195] Starting dynamic subtest: rgb565-untiled
[430.061032] Dynamic subtest rgb565-untiled: SUCCESS (0.455s)
[430.071666] Starting dynamic subtest: xrgb2101010-untiled
[430.617016] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[430.629176] Starting dynamic subtest: xbgr16161616f-untiled
[431.406038] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.788s)
[431.419202] Starting dynamic subtest: xrgb8888-xtiled
[433.217284] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.810s)
[433.227391] Starting dynamic subtest: rgb565-xtiled
[434.339982] Dynamic subtest rgb565-xtiled: SUCCESS (1.122s)
[434.350159] Starting dynamic subtest: xrgb2101010-xtiled
[436.162624] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.821s)
[436.172418] Starting dynamic subtest: xbgr16161616f-xtiled
[439.530452] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.366s)
[439.540708] Starting dynamic subtest: xrgb8888-4tiled
[440.664255] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.133s)
[440.674608] Starting dynamic subtest: rgb565-4tiled
[441.242790] Dynamic subtest rgb565-4tiled: SUCCESS (0.576s)
[441.252235] Starting dynamic subtest: xrgb2101010-4tiled
[442.364562] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.122s)
[442.374480] Starting dynamic subtest: xbgr16161616f-4tiled
[445.376301] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.011s)
[445.378648] Subtest draw-method-pwrite: SUCCESS (16.343s)
[445.492230] [093/131] (581s left) gem_exec_params (batch-first)
[445.562608] Starting subtest: batch-first
[445.569226] Subtest batch-first: SUCCESS (0.007s)
[445.691620] [094/131] (581s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[445.793763] Starting subtest: yf-tiled-32bpp-rotate-0
[445.798014] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[445.911202] [095/131] (580s left) prime_mmap (test_invalid_sync_flags)
[445.963572] Starting subtest: test_invalid_sync_flags
[445.965552] Starting dynamic subtest: test_invalid_sync_flags-smem
[445.967495] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[445.969435] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[446.084468] [096/131] (580s left) kms_chamelium_frames (hdmi-crc-single)
[446.471311] Subtest hdmi-crc-single: SKIP (0.000s)
[447.302392] [097/131] (579s left) gem_ctx_shared (q-independent)
[447.365715] Starting subtest: Q-independent
[447.368037] Starting dynamic subtest: rcs0
[447.435905] Dynamic subtest rcs0: SUCCESS (0.070s)
[447.448759] Starting dynamic subtest: vcs0
[447.481983] Dynamic subtest vcs0: SUCCESS (0.045s)
[447.492360] Starting dynamic subtest: vcs1
[447.527264] Dynamic subtest vcs1: SUCCESS (0.043s)
[447.539416] Starting dynamic subtest: vecs0
[447.573479] Dynamic subtest vecs0: SUCCESS (0.046s)
[447.584784] Starting dynamic subtest: ccs0
[447.616950] Dynamic subtest ccs0: SUCCESS (0.043s)
[447.619763] Subtest Q-independent: SUCCESS (0.251s)
[449.471636] [098/131] (577s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[449.564583] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[449.569153] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[449.661860] [099/131] (577s left) kms_flip (2x-nonexisting-fb-interruptible)
[449.759974] Starting subtest: 2x-nonexisting-fb-interruptible
[449.770260] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[449.876054] [100/131] (577s left) kms_psr (psr2-primary-mmap-cpu)
[449.968431] Starting subtest: psr2-primary-mmap-cpu
[449.970722] Starting dynamic subtest: eDP-1
[451.701731] Dynamic subtest eDP-1: SUCCESS (1.732s)
[451.704177] Subtest psr2-primary-mmap-cpu: SUCCESS (1.733s)
[452.572220] [101/131] (574s left) gen9_exec_parse (allowed-all)
[452.644153] Subtest allowed-all: SKIP (0.000s)
[452.733026] [102/131] (574s left) kms_atomic (plane-invalid-params)
[452.819772] Starting subtest: plane-invalid-params
[452.822198] Starting dynamic subtest: pipe-A-eDP-1
[453.233983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s)
[453.236406] Subtest plane-invalid-params: SUCCESS (0.413s)
[454.104004] [103/131] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[454.208983] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[461.514501] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.307s)
[461.652647] [104/131] (565s left) syncobj_wait (multi-wait-submitted-signaled)
[461.703346] Starting subtest: multi-wait-submitted-signaled
[461.705745] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[461.798617] [105/131] (565s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[461.891091] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[461.893005] Starting dynamic subtest: pipe-A-eDP-1
[462.352994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[462.364811] Starting dynamic subtest: pipe-B-eDP-1
[463.707559] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[463.717227] Starting dynamic subtest: pipe-C-eDP-1
[465.016142] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s)
[465.031250] Starting dynamic subtest: pipe-D-eDP-1
[466.339232] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[466.341083] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.420s)
[467.515516] [106/131] (559s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[467.617985] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[467.622536] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[467.720773] [107/131] (559s left) vgem_basic (setversion)
[467.762749] Starting subtest: setversion
[467.766989] Subtest setversion: SUCCESS (0.000s)
[467.819719] [108/131] (559s left) kms_properties (get_properties-sanity-atomic)
[467.921158] Starting subtest: get_properties-sanity-atomic
[467.926482] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[467.999250] [109/131] (559s left) kms_big_fb (y-tiled-addfb)
[468.105894] Starting subtest: y-tiled-addfb
[468.110418] Subtest y-tiled-addfb: SKIP (0.000s)
[468.199482] [110/131] (559s left) kms_vrr (flip-basic)
[468.294194] Starting subtest: flip-basic
[468.300999] Subtest flip-basic: SKIP (0.000s)
[468.376731] [111/131] (559s left) syncobj_timeline (transfer-timeline-point)
[468.431748] Starting subtest: transfer-timeline-point
[468.433999] Subtest transfer-timeline-point: SUCCESS (0.001s)
[468.521182] [112/131] (559s left) kms_prop_blob (blob-multiple)
[468.578052] Starting subtest: blob-multiple
[468.580195] Subtest blob-multiple: SUCCESS (0.002s)
[468.679133] [113/131] (558s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[468.771150] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[468.774589] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[468.892493] [114/131] (558s left) core_setmaster (master-drop-set-user)
[468.955895] Starting subtest: master-drop-set-user
[468.968414] Subtest master-drop-set-user: SUCCESS (0.015s)
[469.007363] [115/131] (558s left) kms_psr (psr-cursor-plane-onoff)
[469.107000] Starting subtest: psr-cursor-plane-onoff
[469.108949] Starting dynamic subtest: eDP-1
[470.795371] Dynamic subtest eDP-1: SUCCESS (1.687s)
[470.797817] Subtest psr-cursor-plane-onoff: SUCCESS (1.688s)
[471.662552] [116/131] (556s left) kms_universal_plane (cursor-fb-leak)
[471.762211] Starting subtest: cursor-fb-leak
[471.764487] Starting dynamic subtest: pipe-A-eDP-1
[472.081636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.318s)
[472.092903] Starting dynamic subtest: pipe-B-eDP-1
[473.471516] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[473.482978] Starting dynamic subtest: pipe-C-eDP-1
[474.761778] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.286s)
[474.772229] Starting dynamic subtest: pipe-D-eDP-1
[476.085288] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[476.087871] Subtest cursor-fb-leak: SUCCESS (4.320s)
[477.254770] [117/131] (550s left) gen9_exec_parse (batch-without-end)
[477.318124] Subtest batch-without-end: SKIP (0.000s)
[477.407698] [118/131] (550s left) gem_workarounds (reset-context)
[477.474249] Starting subtest: reset-context
[477.665452] Subtest reset-context: SUCCESS (0.189s)
[477.807900] [119/131] (550s left) gem_mmap_gtt (basic)
[477.874254] Subtest basic: SKIP (0.000s)
[477.939347] [120/131] (549s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[477.997248] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[478.103737] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[478.185062] [121/131] (549s left) gem_exec_reloc (basic-write-read-active)
[478.242626] Subtest basic-write-read-active: SKIP (0.000s)
[478.342759] [122/131] (549s left) kms_addfb_basic (too-high)
[478.448275] Starting subtest: too-high
[478.450367] Subtest too-high: SUCCESS (0.001s)
[478.563432] [123/131] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[478.670771] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[478.674881] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[478.776905] [124/131] (549s left) gem_exec_fence (syncobj-timeline-export)
[479.331235] Starting subtest: syncobj-timeline-export
[479.338142] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[480.440752] [125/131] (547s left) gem_softpin (32b-excludes-last-page)
[480.491115] Starting subtest: 32b-excludes-last-page
[480.496306] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[480.631308] [126/131] (547s left) kms_chamelium_color (gamma)
[480.733294] Subtest gamma: SKIP (0.000s)
[480.780487] [127/131] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[480.872894] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[480.877153] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[480.976276] [128/131] (547s left) i915_pm_rpm (gem-mmap-type)
[482.503903] Starting subtest: gem-mmap-type
[482.506389] Starting dynamic subtest: wb-smem0
[486.689374] Dynamic subtest wb-smem0: SUCCESS (4.181s)
[486.701749] Starting dynamic subtest: wc-smem0
[489.516995] Dynamic subtest wc-smem0: SUCCESS (2.826s)
[489.527548] Starting dynamic subtest: uc-smem0
[492.672330] Dynamic subtest uc-smem0: SUCCESS (3.154s)
[492.674344] Subtest gem-mmap-type: SUCCESS (10.164s)
[492.772093] [129/131] (535s left) kms_flip (dpms-vs-vblank-race-interruptible)
[492.873513] Starting subtest: dpms-vs-vblank-race-interruptible
[492.875865] Starting dynamic subtest: A-eDP1
[497.783926] Dynamic subtest A-eDP1: SUCCESS (4.905s)
[497.800716] Starting dynamic subtest: B-eDP1
[502.386106] Dynamic subtest B-eDP1: SUCCESS (4.598s)
[502.396473] Starting dynamic subtest: C-eDP1
[506.978109] Dynamic subtest C-eDP1: SUCCESS (4.592s)
[506.989384] Starting dynamic subtest: D-eDP1
[511.567048] Dynamic subtest D-eDP1: SUCCESS (4.587s)
[511.569423] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.691s)
[512.444918] [130/131] (515s left) kms_flip (busy-flip)
[512.542012] Starting subtest: busy-flip
[512.544348] Starting dynamic subtest: A-eDP1
[514.256714] Dynamic subtest A-eDP1: SUCCESS (1.713s)
[514.269164] Starting dynamic subtest: B-eDP1
[515.982906] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[515.994482] Starting dynamic subtest: C-eDP1
[517.695094] Dynamic subtest C-eDP1: SUCCESS (1.708s)
[517.705961] Starting dynamic subtest: D-eDP1
[519.422175] Dynamic subtest D-eDP1: SUCCESS (1.727s)
[519.424602] Subtest busy-flip: SUCCESS (6.882s)
[520.586090] [131/131] (507s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[520.680521] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[520.682708] Starting dynamic subtest: pipe-A-default-mode
[520.969871] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[520.974592] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.287s)
[521.801966] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_plane_alpha_blend
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: testdisplay
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: sriov_basic
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_partial_pwrite_pread
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: gem_ppgtt
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_busy
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_ctx_exec
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_busy
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_plane_alpha_blend
results: parsing output: 43/ for test: kms_scaling_modes
results: parsing output: 44/ for test: gem_workarounds
results: parsing output: 45/ for test: syncobj_basic
results: parsing output: 46/ for test: fbdev
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_busy
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_exec_store
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_lmem_swapping
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: i915_query
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: i915_suspend
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_pread
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_draw_crc
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: kms_properties
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_vrr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_prop_blob
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: core_setmaster
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_universal_plane
results: parsing output: 116/ for test: gen9_exec_parse
results: parsing output: 117/ for test: gem_workarounds
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: kms_chamelium_color
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_pm_rpm
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_flip_scaled_crc
Done.