[61.617540] Initializing watchdogs
[61.617597]   /dev/watchdog0
[61.631276] [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]
[61.635486] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.637771] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.641082] [001/133] (960s left) gem_ctx_param (invalid-ctx-get)
[61.710772] Starting subtest: invalid-ctx-get
[61.713181] Subtest invalid-ctx-get: SUCCESS (0.000s)
[61.793462] [002/133] (960s left) gem_softpin (allocator-nopin)
[61.854802] Starting subtest: allocator-nopin
[61.966590] Subtest allocator-nopin: SUCCESS (0.112s)
[62.121674] [003/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[62.219386] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[62.257654] Starting dynamic subtest: pipe-A-plane-0
[62.557300] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[62.566048] Starting dynamic subtest: pipe-A-plane-3
[62.789754] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[62.796897] Starting dynamic subtest: pipe-A-plane-5
[62.801258] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[63.861672] Starting dynamic subtest: pipe-B-plane-0
[64.154435] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[64.163182] Starting dynamic subtest: pipe-B-plane-3
[64.387652] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[64.396358] Starting dynamic subtest: pipe-B-plane-5
[64.400492] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[64.710722] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.494s)
[65.533557] [004/133] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[65.631753] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[65.636016] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[65.732406] [005/133] (956s left) gem_mmap_gtt (basic-read-write-distinct)
[65.806245] Subtest basic-read-write-distinct: SKIP (0.000s)
[65.861990] [006/133] (956s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[65.951253] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[65.955518] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[66.048816] [007/133] (956s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[66.146504] Starting subtest: primary-yf-tiled-reflect-x-180
[66.206507] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[66.309209] [008/133] (956s left) kms_scaling_modes (scaling-mode-center)
[66.407023] Starting subtest: scaling-mode-center
[66.409237] Starting dynamic subtest: pipe-A-eDP-1
[66.512652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[66.521933] Starting dynamic subtest: pipe-B-eDP-1
[67.656819] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[67.667609] Starting dynamic subtest: pipe-C-eDP-1
[68.873400] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s)
[68.880800] Starting dynamic subtest: pipe-D-eDP-1
[70.008975] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[70.011127] Subtest scaling-mode-center: SUCCESS (3.604s)
[71.180585] [009/133] (951s left) kms_async_flips (crc-atomic)
[71.289253] Starting subtest: crc-atomic
[71.659866] Starting dynamic subtest: pipe-A-eDP-1
[74.610902] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.933s)
[74.970343] Starting dynamic subtest: pipe-B-eDP-1
[77.839762] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.879s)
[78.212831] Starting dynamic subtest: pipe-C-eDP-1
[81.176928] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.942s)
[81.524284] Starting dynamic subtest: pipe-D-eDP-1
[84.386488] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s)
[84.388794] Subtest crc-atomic: SUCCESS (13.101s)
[85.549334] [010/133] (936s left) syncobj_basic (bad-pad-handle-to-fd)
[85.598978] Starting subtest: bad-pad-handle-to-fd
[85.601329] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[85.689177] [011/133] (936s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[85.786753] Starting subtest: pipe-fbc-rte
[85.793290] Starting dynamic subtest: pipe-B-eDP-1
[91.219240] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.437s)
[91.226363] Subtest pipe-fbc-rte: SUCCESS (5.438s)
[93.484039] [012/133] (929s left) kms_psr (pr-cursor-blt)
[93.585073] Starting subtest: pr-cursor-blt
[93.589244] Subtest pr-cursor-blt: SKIP (0.000s)
[93.655374] [013/133] (928s left) perf_pmu (idle)
[93.695836] Starting subtest: idle
[93.698283] Starting dynamic subtest: rcs0
[94.241250] Dynamic subtest rcs0: SUCCESS (0.545s)
[94.251722] Starting dynamic subtest: bcs0
[94.762719] Dynamic subtest bcs0: SUCCESS (0.520s)
[94.773107] Starting dynamic subtest: vcs0
[95.291060] Dynamic subtest vcs0: SUCCESS (0.527s)
[95.301300] Starting dynamic subtest: vcs1
[95.818317] Dynamic subtest vcs1: SUCCESS (0.526s)
[95.828453] Starting dynamic subtest: vecs0
[96.345730] Dynamic subtest vecs0: SUCCESS (0.526s)
[96.356566] Starting dynamic subtest: ccs0
[96.872320] Dynamic subtest ccs0: SUCCESS (0.525s)
[96.874930] Subtest idle: SUCCESS (3.177s)
[96.963478] [014/133] (925s left) api_intel_allocator (reserve-simple)
[97.016313] Starting subtest: reserve-simple
[97.018973] Subtest reserve-simple: SUCCESS (0.005s)
[97.132168] [015/133] (925s left) kms_invalid_mode (clock-too-high)
[97.224120] Starting subtest: clock-too-high
[97.226037] Starting dynamic subtest: pipe-A-eDP-1
[97.230185] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.238023] Starting dynamic subtest: pipe-B-eDP-1
[97.242497] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.250129] Starting dynamic subtest: pipe-C-eDP-1
[97.254115] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.261066] Starting dynamic subtest: pipe-D-eDP-1
[97.265402] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.269307] Subtest clock-too-high: SKIP (0.003s)
[97.301981] [016/133] (925s left) i915_hangman (gt-error-state-capture)
[97.373159] Starting subtest: gt-error-state-capture
[97.375411] Starting dynamic subtest: rcs0
[108.854094] Dynamic subtest rcs0: SUCCESS (11.479s)
[108.865417] Starting dynamic subtest: bcs0
[120.885297] Dynamic subtest bcs0: SUCCESS (12.031s)
[120.896422] Starting dynamic subtest: vcs0
[132.853282] Dynamic subtest vcs0: SUCCESS (11.965s)
[132.864792] Starting dynamic subtest: vcs1
[144.820083] Dynamic subtest vcs1: SUCCESS (11.966s)
[144.831999] Starting dynamic subtest: vecs0
[155.828042] Dynamic subtest vecs0: SUCCESS (11.006s)
[155.839563] Starting dynamic subtest: ccs0
[166.900381] Dynamic subtest ccs0: SUCCESS (11.070s)
[166.903291] Subtest gt-error-state-capture: SUCCESS (69.526s)
[167.036540] [017/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[167.146778] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[167.151147] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[167.247087] [018/133] (855s left) kms_chamelium_audio (dp-audio)
[167.640178] Subtest dp-audio: SKIP (0.000s)
[168.478916] [019/133] (854s left) kms_dp_link_training (non-uhbr-sst)
[168.579096] Starting subtest: non-uhbr-sst
[168.587599] Subtest non-uhbr-sst: SKIP (0.000s)
[168.645250] [020/133] (854s left) gem_exec_reloc (basic-wc-noreloc)
[168.708217] Subtest basic-wc-noreloc: SKIP (0.000s)
[168.775474] [021/133] (854s left) gem_lmem_swapping (random)
[168.817125] Subtest random: SKIP (0.000s)
[168.867980] [022/133] (854s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[168.927941] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[168.992743] [023/133] (854s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[169.083226] Starting subtest: fbcpsr-rgb565-draw-pwrite
[176.072024] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.990s)
[176.180827] [024/133] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[176.287625] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[176.291852] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[176.391386] [025/133] (846s left) kms_feature_discovery (psr2)
[176.492877] Starting subtest: psr2
[176.495151] Subtest psr2: SUCCESS (0.000s)
[176.568153] [026/133] (846s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[176.676579] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[176.679046] Starting dynamic subtest: pipe-A-eDP-1
[182.501827] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.831s)
[182.511199] Starting dynamic subtest: pipe-B-eDP-1
[189.154381] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.649s)
[189.156690] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.482s)
[190.036364] [027/133] (833s left) kms_sequence (queue-busy)
[190.120150] Starting subtest: queue-busy
[190.122523] Starting dynamic subtest: pipe-A-eDP-1
[192.061822] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[192.071283] Starting dynamic subtest: pipe-B-eDP-1
[194.637039] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.576s)
[194.645180] Starting dynamic subtest: pipe-C-eDP-1
[197.257736] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.618s)
[197.266973] Starting dynamic subtest: pipe-D-eDP-1
[199.884332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.627s)
[199.886608] Subtest queue-busy: SUCCESS (9.766s)
[200.754423] [028/133] (822s left) gem_exec_reloc (basic-wc)
[200.825391] Subtest basic-wc: SKIP (0.000s)
[200.895697] [029/133] (822s left) syncobj_timeline (signal)
[200.954245] Starting subtest: signal
[200.956577] Subtest signal: SUCCESS (0.000s)
[201.067059] [030/133] (822s left) kms_flip (plain-flip-ts-check-interruptible)
[201.170660] Starting subtest: plain-flip-ts-check-interruptible
[201.172901] Starting dynamic subtest: A-eDP1
[210.086808] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[210.096401] Starting dynamic subtest: B-eDP1
[218.909228] Dynamic subtest B-eDP1: SUCCESS (8.821s)
[218.919959] Starting dynamic subtest: C-eDP1
[227.735396] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[227.744466] Starting dynamic subtest: D-eDP1
[236.530946] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[236.533478] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.363s)
[237.722526] [031/133] (785s left) kms_plane (plane-position-hole-dpms)
[237.822467] Starting subtest: plane-position-hole-dpms
[238.325698] Starting dynamic subtest: pipe-A-plane-1
[240.614528] Dynamic subtest pipe-A-plane-1: SUCCESS (2.290s)
[240.623399] Starting dynamic subtest: pipe-A-plane-2
[242.997794] Dynamic subtest pipe-A-plane-2: SUCCESS (2.382s)
[243.007456] Starting dynamic subtest: pipe-A-plane-3
[245.351878] Dynamic subtest pipe-A-plane-3: SUCCESS (2.354s)
[245.360762] Starting dynamic subtest: pipe-A-plane-4
[247.705656] Dynamic subtest pipe-A-plane-4: SUCCESS (2.352s)
[247.714982] Starting dynamic subtest: pipe-A-plane-5
[247.727856] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[248.927865] Starting dynamic subtest: pipe-B-plane-1
[251.337565] Dynamic subtest pipe-B-plane-1: SUCCESS (2.415s)
[251.346449] Starting dynamic subtest: pipe-B-plane-2
[253.805546] Dynamic subtest pipe-B-plane-2: SUCCESS (2.468s)
[253.814366] Starting dynamic subtest: pipe-B-plane-3
[256.243884] Dynamic subtest pipe-B-plane-3: SUCCESS (2.438s)
[256.252813] Starting dynamic subtest: pipe-B-plane-4
[258.602541] Dynamic subtest pipe-B-plane-4: SUCCESS (2.358s)
[258.611293] Starting dynamic subtest: pipe-B-plane-5
[258.627962] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[258.630098] Subtest plane-position-hole-dpms: SUCCESS (20.806s)
[259.414331] [032/133] (763s left) gem_exec_reloc (basic-gtt)
[259.483843] Subtest basic-gtt: SKIP (0.000s)
[259.551208] [033/133] (763s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[259.645359] Starting subtest: crc-primary-basic-y-tiled-ccs
[259.647565] Starting dynamic subtest: pipe-A-eDP-1
[259.670746] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[259.681841] Starting dynamic subtest: pipe-B-eDP-1
[259.703904] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[259.711969] Starting dynamic subtest: pipe-C-eDP-1
[259.733605] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[259.741699] Starting dynamic subtest: pipe-D-eDP-1
[259.763292] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[259.767305] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[261.886391] [034/133] (761s left) perf (polling-parameterized)
[262.002725] Starting subtest: polling-parameterized
[282.077521] Subtest polling-parameterized: SUCCESS (20.023s)
[282.117468] [035/133] (741s left) gem_exec_fence (basic-wait-all)
[282.180662] Starting subtest: basic-wait-all
[282.283325] Subtest basic-wait-all: SUCCESS (0.103s)
[283.977198] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[283.980737] [036/133] (739s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[284.084467] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[284.088894] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[284.164249] [037/133] (739s left) i915_query (hwconfig_table)
[284.222568] Starting subtest: hwconfig_table
[284.526484] Subtest hwconfig_table: SUCCESS (0.001s)
[284.565823] [038/133] (739s left) gem_exec_params (larger-than-life-batch)
[284.614608] Starting subtest: larger-than-life-batch
[286.918119] Subtest larger-than-life-batch: SUCCESS (2.302s)
[287.947235] [039/133] (735s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[288.092481] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[288.096882] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[288.216771] [040/133] (735s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[288.328463] Starting subtest: yf-tiled-addfb-size-overflow
[288.332606] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[288.424706] [041/133] (735s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[288.480995] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[288.483779] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[288.555950] [042/133] (735s left) kms_vblank (query-forked-busy)
[288.655388] Starting subtest: query-forked-busy
[288.657525] Starting dynamic subtest: pipe-A-eDP-1
[290.545324] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[290.564876] Starting dynamic subtest: pipe-D-eDP-1
[293.127125] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.582s)
[293.129518] Subtest query-forked-busy: SUCCESS (4.474s)
[293.924734] [043/133] (729s left) perf (non-zero-reason)
[294.052487] Starting subtest: non-zero-reason
[294.054897] Starting dynamic subtest: 0-rcs0
[299.454734] Dynamic subtest 0-rcs0: SUCCESS (5.351s)
[299.466488] Starting dynamic subtest: 1-vcs0
[303.296894] Dynamic subtest 1-vcs0: SUCCESS (3.894s)
[303.300077] Subtest non-zero-reason: SUCCESS (9.247s)
[303.346269] [044/133] (720s left) perf (rc6-disable)
[303.432580] Starting subtest: rc6-disable
[303.609208] Subtest rc6-disable: SUCCESS (0.176s)
[303.655456] [045/133] (720s left) kms_content_protection (lic-type-0-hdcp14)
[303.791946] Starting subtest: lic-type-0-hdcp14
[303.796640] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[303.928089] [046/133] (720s left) gem_exec_fence (nb-await)
[304.099037] Starting subtest: nb-await
[304.101617] Starting dynamic subtest: rcs0
[304.167419] Dynamic subtest rcs0: SUCCESS (0.068s)
[304.180366] Starting dynamic subtest: bcs0
[304.225047] Dynamic subtest bcs0: SUCCESS (0.055s)
[304.237055] Starting dynamic subtest: vcs0
[304.283571] Dynamic subtest vcs0: SUCCESS (0.058s)
[304.295079] Starting dynamic subtest: vcs1
[304.342072] Dynamic subtest vcs1: SUCCESS (0.056s)
[304.352913] Starting dynamic subtest: vecs0
[304.401457] Dynamic subtest vecs0: SUCCESS (0.057s)
[304.414410] Starting dynamic subtest: ccs0
[304.462106] Dynamic subtest ccs0: SUCCESS (0.058s)
[304.464798] Subtest nb-await: SUCCESS (0.364s)
[305.954957] [047/133] (718s left) syncobj_timeline (invalid-signal-zero-handles)
[306.008806] Starting subtest: invalid-signal-zero-handles
[306.010798] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[306.112416] [048/133] (717s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[306.205990] Starting subtest: plane-lut1d-ctm3x4
[306.373302] Starting dynamic subtest: pipe-A-plane-0
[306.528668] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[306.538183] Starting dynamic subtest: pipe-A-plane-1
[306.662159] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s)
[306.671386] Starting dynamic subtest: pipe-A-plane-2
[306.795245] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[308.044857] Starting dynamic subtest: pipe-B-plane-0
[308.226063] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[308.237611] Starting dynamic subtest: pipe-B-plane-1
[308.381714] Dynamic subtest pipe-B-plane-1: SUCCESS (0.153s)
[308.391083] Starting dynamic subtest: pipe-B-plane-2
[308.571828] Dynamic subtest pipe-B-plane-2: SUCCESS (0.187s)
[309.754183] Starting dynamic subtest: pipe-C-plane-0
[309.880460] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[309.890190] Starting dynamic subtest: pipe-C-plane-1
[310.035882] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[310.044824] Starting dynamic subtest: pipe-C-plane-2
[310.169289] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[311.391119] Starting dynamic subtest: pipe-D-plane-0
[311.515328] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[311.524696] Starting dynamic subtest: pipe-D-plane-1
[311.647955] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[311.657583] Starting dynamic subtest: pipe-D-plane-2
[311.781305] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[312.069203] Subtest plane-lut1d-ctm3x4: SUCCESS (5.864s)
[312.868482] [049/133] (711s left) kms_setmode (invalid-clone-exclusive-crtc)
[312.936304] Starting subtest: invalid-clone-exclusive-crtc
[312.943108] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[313.028860] [050/133] (711s left) gem_exec_reloc (basic-wc-read-noreloc)
[313.091038] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[313.162098] [051/133] (711s left) gem_ctx_shared (q-promotion)
[313.230298] Starting subtest: Q-promotion
[313.232736] Starting dynamic subtest: rcs0
[313.326336] Dynamic subtest rcs0: SUCCESS (0.095s)
[313.342172] Starting dynamic subtest: vcs0
[313.413859] Dynamic subtest vcs0: SUCCESS (0.086s)
[313.429301] Starting dynamic subtest: vcs1
[313.491178] Dynamic subtest vcs1: SUCCESS (0.076s)
[313.507341] Starting dynamic subtest: vecs0
[313.571505] Dynamic subtest vecs0: SUCCESS (0.078s)
[313.586300] Starting dynamic subtest: ccs0
[313.662948] Dynamic subtest ccs0: SUCCESS (0.092s)
[313.665434] Subtest Q-promotion: SUCCESS (0.433s)
[314.982220] [052/133] (709s left) kms_flip (flip-vs-wf_vblank-interruptible)
[315.082031] Starting subtest: flip-vs-wf_vblank-interruptible
[315.084201] Starting dynamic subtest: A-eDP1
[317.010712] Dynamic subtest A-eDP1: SUCCESS (1.927s)
[317.024267] Starting dynamic subtest: B-eDP1
[318.940864] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[318.953247] Starting dynamic subtest: C-eDP1
[320.846187] Dynamic subtest C-eDP1: SUCCESS (1.904s)
[320.857285] Starting dynamic subtest: D-eDP1
[322.776703] Dynamic subtest D-eDP1: SUCCESS (1.928s)
[322.779247] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.697s)
[324.015439] [053/133] (700s left) gem_mmap_gtt (big-bo)
[324.084301] Subtest big-bo: SKIP (0.000s)
[324.149225] [054/133] (700s left) kms_psr (psr2-cursor-plane-move)
[324.234303] Starting subtest: psr2-cursor-plane-move
[324.236549] Starting dynamic subtest: eDP-1
[325.902242] Dynamic subtest eDP-1: SUCCESS (1.669s)
[325.904474] Subtest psr2-cursor-plane-move: SUCCESS (1.670s)
[326.789236] [055/133] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[326.897707] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[326.902153] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[326.994303] [056/133] (697s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[327.092725] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[328.217152] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.124s)
[328.325263] [057/133] (696s left) kms_big_fb (linear-64bpp-rotate-180)
[328.428222] Starting subtest: linear-64bpp-rotate-180
[330.153074] Subtest linear-64bpp-rotate-180: SUCCESS (1.723s)
[330.316245] [058/133] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[330.433920] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[330.437502] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[330.529306] [059/133] (693s left) kms_psr (fbc-psr2-dpms)
[330.611447] Starting subtest: fbc-psr2-dpms
[330.613236] Starting dynamic subtest: eDP-1
[330.616555] Dynamic subtest eDP-1: SKIP (0.000s)
[330.619970] Subtest fbc-psr2-dpms: SKIP (0.001s)
[330.697079] [060/133] (693s left) gem_madvise (dontneed-before-mmap)
[330.738922] Starting subtest: dontneed-before-mmap
[330.767733] Subtest dontneed-before-mmap: SUCCESS (0.030s)
[330.886930] [061/133] (693s left) gem_exec_schedule (timeslicing)
[330.952461] Starting subtest: timeslicing
[330.954485] Starting dynamic subtest: rcs0
[330.972999] Dynamic subtest rcs0: SUCCESS (0.019s)
[330.984187] Starting dynamic subtest: bcs0
[330.994102] Dynamic subtest bcs0: SUCCESS (0.021s)
[331.002482] Starting dynamic subtest: vcs0
[331.016433] Dynamic subtest vcs0: SUCCESS (0.022s)
[331.024716] Starting dynamic subtest: vcs1
[331.038520] Dynamic subtest vcs1: SUCCESS (0.021s)
[331.046909] Starting dynamic subtest: vecs0
[331.059117] Dynamic subtest vecs0: SUCCESS (0.020s)
[331.067256] Starting dynamic subtest: ccs0
[331.080998] Dynamic subtest ccs0: SUCCESS (0.021s)
[331.082998] Subtest timeslicing: SUCCESS (0.129s)
[332.939466] [062/133] (691s left) gem_exec_store (dword)
[333.006019] Starting subtest: dword
[333.008391] Starting dynamic subtest: rcs0
[333.078192] Dynamic subtest rcs0: SUCCESS (0.073s)
[333.090725] Starting dynamic subtest: bcs0
[333.119664] Dynamic subtest bcs0: SUCCESS (0.040s)
[333.129947] Starting dynamic subtest: vcs0
[333.162549] Dynamic subtest vcs0: SUCCESS (0.042s)
[333.172291] Starting dynamic subtest: vcs1
[333.206505] Dynamic subtest vcs1: SUCCESS (0.042s)
[333.218730] Starting dynamic subtest: vecs0
[333.249073] Dynamic subtest vecs0: SUCCESS (0.041s)
[333.259133] Starting dynamic subtest: ccs0
[333.294332] Dynamic subtest ccs0: SUCCESS (0.043s)
[333.296838] Subtest dword: SUCCESS (0.291s)
[333.483196] [063/133] (691s left) syncobj_wait (multi-wait-submitted-signaled)
[333.536386] Starting subtest: multi-wait-submitted-signaled
[333.538795] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[333.631378] [064/133] (691s left) kms_flip (absolute-wf_vblank-interruptible)
[333.733587] Starting subtest: absolute-wf_vblank-interruptible
[333.735770] Starting dynamic subtest: A-eDP1
[342.480834] Dynamic subtest A-eDP1: SUCCESS (8.711s)
[342.490059] Starting dynamic subtest: B-eDP1
[351.202874] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[351.214870] Starting dynamic subtest: C-eDP1
[359.939882] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[359.951790] Starting dynamic subtest: D-eDP1
[368.664671] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[368.667753] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.889s)
[369.836409] [065/133] (654s left) kms_pm_rpm (modeset-non-lpsp)
[372.091687] Starting subtest: modeset-non-lpsp
[373.241703] Subtest modeset-non-lpsp: SKIP (1.147s)
[373.614339] [066/133] (651s left) gem_softpin (evict-active)
[373.673910] Starting subtest: evict-active
[373.683556] Subtest evict-active: SUCCESS (0.010s)
[373.797609] [067/133] (651s left) syncobj_wait (signal)
[373.848916] Starting subtest: signal
[373.851793] Subtest signal: SUCCESS (0.000s)
[373.939858] [068/133] (650s left) gem_create (create-invalid-size)
[373.989171] Starting subtest: create-invalid-size
[373.991094] Subtest create-invalid-size: SUCCESS (0.000s)
[374.179879] [069/133] (650s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[374.269349] Starting subtest: stress-mm-invalidate-close-overlap
[376.417292] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[376.551151] [070/133] (648s left) dmabuf_sync_file (import-multiple-read-write)
[376.600151] Starting subtest: import-multiple-read-write
[376.602596] Subtest import-multiple-read-write: SUCCESS (0.003s)
[376.666232] [071/133] (648s left) gem_mmap_gtt (hang-user)
[376.722385] Subtest hang-user: SKIP (0.000s)
[376.784739] [072/133] (648s left) kms_busy (basic-hang)
[376.892934] Starting subtest: basic-hang
[376.895223] Starting dynamic subtest: flip-pipe-A
[377.476357] Dynamic subtest flip-pipe-A: SUCCESS (0.584s)
[377.486721] Starting dynamic subtest: modeset-pipe-A
[380.939151] Dynamic subtest modeset-pipe-A: SUCCESS (3.460s)
[380.949715] Starting dynamic subtest: flip-pipe-D
[382.128393] Dynamic subtest flip-pipe-D: SUCCESS (1.185s)
[382.139059] Starting dynamic subtest: modeset-pipe-D
[385.567264] Dynamic subtest modeset-pipe-D: SUCCESS (3.440s)
[385.569616] Subtest basic-hang: SUCCESS (8.675s)
[386.408385] [073/133] (638s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[386.486322] Starting subtest: basic-batch-kernel-default-cmd
[386.490864] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[386.672628] [074/133] (638s left) gem_ctx_persistence (saturated-hostile)
[386.733865] Starting subtest: saturated-hostile
[386.736254] Starting dynamic subtest: rcs0
[387.554070] Dynamic subtest rcs0: SUCCESS (0.819s)
[387.566326] Starting dynamic subtest: bcs0
[388.337788] Dynamic subtest bcs0: SUCCESS (0.781s)
[388.350987] Starting dynamic subtest: vcs0
[389.135864] Dynamic subtest vcs0: SUCCESS (0.796s)
[389.148544] Starting dynamic subtest: vcs1
[389.911836] Dynamic subtest vcs1: SUCCESS (0.774s)
[389.924479] Starting dynamic subtest: vecs0
[390.725271] Dynamic subtest vecs0: SUCCESS (0.811s)
[390.735090] Starting dynamic subtest: ccs0
[391.552245] Dynamic subtest ccs0: SUCCESS (0.825s)
[391.554819] Subtest saturated-hostile: SUCCESS (4.819s)
[391.631598] [075/133] (633s left) gem_eio (unwedge-stress)
[391.828219] Starting subtest: unwedge-stress
[391.830893] Starting dynamic subtest: render
[396.345160] Dynamic subtest render: SUCCESS (4.515s)
[396.361643] Starting dynamic subtest: bsd1
[414.356295] Dynamic subtest bsd1: SUCCESS (18.009s)
[414.373342] Starting dynamic subtest: bsd2
[432.299369] Dynamic subtest bsd2: SUCCESS (17.941s)
[432.316089] Starting dynamic subtest: blt
[432.321061] Dynamic subtest blt: SKIP (0.000s)
[432.330425] Starting dynamic subtest: vebox
[450.327438] Dynamic subtest vebox: SUCCESS (18.026s)
[450.329766] Subtest unwedge-stress: SUCCESS (58.497s)
[451.963946] [076/133] (573s left) gem_exec_fence (concurrent)
[452.142107] Starting subtest: concurrent
[452.146301] Subtest concurrent: SKIP (0.000s)
[453.995280] [077/133] (571s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[454.099828] Starting subtest: crc-primary-suspend-y-tiled-ccs
[454.102073] Starting dynamic subtest: pipe-A-eDP-1
[454.110899] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[454.121131] Starting dynamic subtest: pipe-B-eDP-1
[454.130152] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[454.139150] Starting dynamic subtest: pipe-C-eDP-1
[454.147566] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[454.156211] Starting dynamic subtest: pipe-D-eDP-1
[454.164583] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[454.168627] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[456.325097] [078/133] (568s left) kms_cursor_crc (cursor-random-256x85)
[456.607249] Starting subtest: cursor-random-256x85
[456.658140] Subtest cursor-random-256x85: SKIP (0.046s)
[456.837375] [079/133] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[456.935623] Starting subtest: fbcpsr-1p-rte
[463.948300] Subtest fbcpsr-1p-rte: SUCCESS (7.016s)
[464.084957] [080/133] (561s left) sysfs_heartbeat_interval (invalid)
[464.147698] Starting subtest: invalid
[464.150165] Starting dynamic subtest: vecs0
[464.152572] Dynamic subtest vecs0: SUCCESS (0.000s)
[464.162659] Starting dynamic subtest: ccs0
[464.164631] Dynamic subtest ccs0: SUCCESS (0.000s)
[464.173393] Starting dynamic subtest: vcs0
[464.175625] Dynamic subtest vcs0: SUCCESS (0.000s)
[464.184523] Starting dynamic subtest: bcs0
[464.186781] Dynamic subtest bcs0: SUCCESS (0.000s)
[464.195601] Starting dynamic subtest: rcs0
[464.197446] Dynamic subtest rcs0: SUCCESS (0.000s)
[464.206448] Starting dynamic subtest: vcs1
[464.208606] Dynamic subtest vcs1: SUCCESS (0.000s)
[464.210709] Subtest invalid: SUCCESS (0.005s)
[464.255285] [081/133] (561s left) core_debugfs (read-all-entries)
[464.315704] Starting subtest: read-all-entries
[464.396089] Subtest read-all-entries: SUCCESS (0.083s)
[464.478971] [082/133] (561s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[464.577335] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[464.579673] Starting dynamic subtest: pipe-A-eDP-1
[464.600693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[464.612175] Starting dynamic subtest: pipe-B-eDP-1
[464.631307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[464.640476] Starting dynamic subtest: pipe-C-eDP-1
[464.659883] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[464.668985] Starting dynamic subtest: pipe-D-eDP-1
[464.688386] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[464.690297] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[466.774709] [083/133] (558s left) gem_exercise_blt (fast-copy)
[466.851133] Starting subtest: fast-copy
[466.853297] Starting dynamic subtest: linear-smem-smem
[466.874167] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[466.884108] Starting dynamic subtest: xmajor-smem-smem
[466.891902] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[466.900879] Starting dynamic subtest: tile4-smem-smem
[466.908818] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[466.917672] Starting dynamic subtest: tile64-smem-smem
[466.926386] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[466.928732] Subtest fast-copy: SUCCESS (0.077s)
[467.049655] [084/133] (558s left) gem_mmap_gtt (big-bo-tiledx)
[467.111192] Subtest big-bo-tiledX: SKIP (0.000s)
[467.173188] [085/133] (558s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[467.267932] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[467.272216] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[467.382207] [086/133] (558s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[467.483511] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[467.589443] [087/133] (558s left) gem_ctx_isolation (nonpriv-switch)
[467.678573] Starting subtest: nonpriv-switch
[467.680538] Starting dynamic subtest: rcs0
[467.931113] Dynamic subtest rcs0: SUCCESS (0.256s)
[467.941519] Starting dynamic subtest: bcs0
[468.216510] Dynamic subtest bcs0: SUCCESS (0.284s)
[468.228079] Starting dynamic subtest: vcs0
[468.507500] Dynamic subtest vcs0: SUCCESS (0.290s)
[468.517963] Starting dynamic subtest: vcs1
[470.192572] Dynamic subtest vcs1: SUCCESS (1.684s)
[470.204551] Starting dynamic subtest: vecs0
[472.195909] Dynamic subtest vecs0: SUCCESS (2.001s)
[472.205797] Starting dynamic subtest: ccs0
[474.203206] Dynamic subtest ccs0: SUCCESS (2.006s)
[474.205516] Subtest nonpriv-switch: SUCCESS (6.528s)
[474.429059] [088/133] (551s left) syncobj_wait (wait-all-for-submit-complex)
[474.491566] Starting subtest: wait-all-for-submit-complex
[474.704168] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[474.783513] [089/133] (551s left) gem_exec_schedule (noreorder-priority)
[474.994820] Starting subtest: noreorder-priority
[474.999799] Starting dynamic subtest: rcs0
[476.117301] Dynamic subtest rcs0: SUCCESS (1.152s)
[476.131029] Starting dynamic subtest: vcs0
[477.911715] Dynamic subtest vcs0: SUCCESS (1.791s)
[477.922476] Starting dynamic subtest: vcs1
[479.898913] Dynamic subtest vcs1: SUCCESS (1.984s)
[479.909979] Starting dynamic subtest: vecs0
[481.873356] Dynamic subtest vecs0: SUCCESS (1.972s)
[481.886211] Starting dynamic subtest: ccs0
[483.027732] Dynamic subtest ccs0: SUCCESS (1.152s)
[483.030276] Subtest noreorder-priority: SUCCESS (8.065s)
[483.223963] [090/133] (542s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[483.327125] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[483.329428] Starting dynamic subtest: pipe-A-eDP-1
[483.770885] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[483.779637] Starting dynamic subtest: pipe-B-eDP-1
[485.232081] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s)
[485.243940] Starting dynamic subtest: pipe-C-eDP-1
[486.593097] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[486.604493] Starting dynamic subtest: pipe-D-eDP-1
[488.023669] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.431s)
[488.025734] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.670s)
[489.200032] [091/133] (536s left) kms_lease (possible-crtcs-filtering)
[489.298026] Starting subtest: possible-crtcs-filtering
[489.302755] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[489.430273] [092/133] (536s left) i915_pm_rc6_residency (rc6-idle)
[489.478241] Starting subtest: rc6-idle
[489.509302] Starting dynamic subtest: gt0-rcs0
[513.793088] Dynamic subtest gt0-rcs0: SUCCESS (24.283s)
[513.802317] Starting dynamic subtest: gt0-bcs0
[538.076642] Dynamic subtest gt0-bcs0: SUCCESS (24.281s)
[538.085914] Starting dynamic subtest: gt0-ccs0
[562.376210] Dynamic subtest gt0-ccs0: SUCCESS (24.296s)
[562.387897] Starting dynamic subtest: gt1-vcs0
[568.604165] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[568.616826] Starting dynamic subtest: gt1-vecs0
[574.774179] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[574.776668] Subtest rc6-idle: SUCCESS (85.245s)
[574.816487] [093/133] (451s left) fbdev (eof)
[574.865698] Starting subtest: eof
[574.867969] Subtest eof: SUCCESS (0.000s)
[574.934169] [094/133] (451s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[574.993785] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[574.998219] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[575.178282] [095/133] (450s left) gem_fence_thrash (bo-copy)
[575.217801] Starting subtest: bo-copy
[575.245591] Subtest bo-copy: SKIP (0.025s)
[575.308069] [096/133] (450s left) gen9_exec_parse (basic-rejected-ctx-param)
[575.372771] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[575.440070] [097/133] (450s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[575.505328] Starting subtest: multi-wait-available-unsubmitted-submitted
[575.507599] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[575.609856] [098/133] (450s left) gem_mmap_wc (write-prefaulted)
[575.665762] Subtest write-prefaulted: SKIP (0.000s)
[575.729735] [099/133] (450s left) kms_draw_crc (draw-method-pwrite)
[575.834919] Starting subtest: draw-method-pwrite
[575.837054] Starting dynamic subtest: xrgb8888-untiled
[576.400642] Dynamic subtest xrgb8888-untiled: SUCCESS (0.567s)
[576.411519] Starting dynamic subtest: rgb565-untiled
[576.833838] Dynamic subtest rgb565-untiled: SUCCESS (0.432s)
[576.843832] Starting dynamic subtest: xrgb2101010-untiled
[577.378473] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[577.388070] Starting dynamic subtest: xbgr16161616f-untiled
[578.123177] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.744s)
[578.133170] Starting dynamic subtest: xrgb8888-xtiled
[579.889732] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.764s)
[579.900145] Starting dynamic subtest: rgb565-xtiled
[580.956744] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s)
[580.966328] Starting dynamic subtest: xrgb2101010-xtiled
[582.745611] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.788s)
[582.755492] Starting dynamic subtest: xbgr16161616f-xtiled
[585.979022] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.232s)
[585.988691] Starting dynamic subtest: xrgb8888-4tiled
[587.056934] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.077s)
[587.067138] Starting dynamic subtest: rgb565-4tiled
[587.601350] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s)
[587.610975] Starting dynamic subtest: xrgb2101010-4tiled
[588.668224] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.066s)
[588.678033] Starting dynamic subtest: xbgr16161616f-4tiled
[591.645733] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.977s)
[591.648073] Subtest draw-method-pwrite: SUCCESS (15.812s)
[591.743434] [100/133] (434s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[591.852136] Starting subtest: 4-tiled-addfb-size-offset-overflow
[591.853976] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[591.954831] [101/133] (434s left) gem_exec_reloc (basic-wc-gtt-active)
[592.007461] Subtest basic-wc-gtt-active: SKIP (0.000s)
[592.071196] [102/133] (434s left) kms_atomic_transition (plane-all-transition)
[592.154198] Starting subtest: plane-all-transition
[592.156482] Starting dynamic subtest: pipe-A-eDP-1
[594.646659] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[594.971503] Starting dynamic subtest: pipe-B-eDP-1
[598.225803] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.270s)
[598.529470] Subtest plane-all-transition: SUCCESS (6.377s)
[599.365435] [103/133] (427s left) kms_chamelium_hpd (dp-hpd)
[599.793431] Subtest dp-hpd: SKIP (0.000s)
[600.572183] [104/133] (425s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[600.675427] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[600.679952] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[600.759205] [105/133] (425s left) gem_mmap_gtt (big-bo-tiledy)
[600.822869] Subtest big-bo-tiledY: SKIP (0.000s)
[600.884085] [106/133] (425s left) gem_render_copy (yf-tiled-ccs-to-linear)
[600.943776] Starting subtest: yf-tiled-ccs-to-linear
[600.947974] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[601.137295] [107/133] (425s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[601.239732] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[601.244117] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[601.339227] [108/133] (425s left) gem_exec_balancer (busy)
[601.395531] Starting subtest: busy
[602.907633] Subtest busy: SUCCESS (1.510s)
[603.222244] [109/133] (423s left) i915_drm_fdinfo (busy-idle-check-all)
[603.261663] Starting subtest: busy-idle-check-all
[603.264060] Starting dynamic subtest: rcs0
[603.268768] Dynamic subtest rcs0: SKIP (0.004s)
[603.280848] Starting dynamic subtest: bcs0
[603.285326] Dynamic subtest bcs0: SKIP (0.000s)
[603.294470] Starting dynamic subtest: vcs0
[603.299014] Dynamic subtest vcs0: SKIP (0.000s)
[603.308440] Starting dynamic subtest: vcs1
[603.312845] Dynamic subtest vcs1: SKIP (0.000s)
[603.322609] Starting dynamic subtest: vecs0
[603.326995] Dynamic subtest vecs0: SKIP (0.000s)
[603.336497] Starting dynamic subtest: ccs0
[603.340869] Dynamic subtest ccs0: SKIP (0.000s)
[603.345205] Subtest busy-idle-check-all: SKIP (0.009s)
[603.385192] [110/133] (423s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[603.535240] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[603.539572] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[603.681048] [111/133] (423s left) kms_flip (2x-busy-flip)
[603.770232] Starting subtest: 2x-busy-flip
[603.781289] Subtest 2x-busy-flip: SKIP (0.010s)
[603.863634] [112/133] (422s left) kms_hdr (invalid-metadata-sizes)
[603.965229] Starting subtest: invalid-metadata-sizes
[603.971416] Subtest invalid-metadata-sizes: SKIP (0.000s)
[604.035012] [113/133] (422s left) gem_busy (close-race)
[604.095599] Starting subtest: close-race
[627.925316] Subtest close-race: SUCCESS (23.827s)
[628.297916] [114/133] (398s left) kms_plane_scaling (planes-scaler-unity-scaling)
[628.433702] Starting subtest: planes-scaler-unity-scaling
[628.435976] Starting dynamic subtest: pipe-A
[628.496369] Dynamic subtest pipe-A: SUCCESS (0.064s)
[628.508127] Starting dynamic subtest: pipe-B
[629.606886] Dynamic subtest pipe-B: SUCCESS (1.110s)
[629.617606] Starting dynamic subtest: pipe-C
[630.714372] Dynamic subtest pipe-C: SUCCESS (1.106s)
[630.724431] Starting dynamic subtest: pipe-D
[631.857233] Dynamic subtest pipe-D: SUCCESS (1.142s)
[631.859600] Subtest planes-scaler-unity-scaling: SUCCESS (3.425s)
[633.020808] [115/133] (393s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[633.118052] Starting subtest: pr-cursor-plane-move-continuous-sf
[633.122559] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[633.185662] [116/133] (393s left) kms_cursor_crc (cursor-onscreen-max-size)
[633.499380] Starting subtest: cursor-onscreen-max-size
[633.507644] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[633.653917] [117/133] (393s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[633.757329] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[633.761761] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[633.867951] [118/133] (393s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[633.967066] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[638.030064] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.064s)
[639.226663] [119/133] (387s left) syncobj_wait (reset-signaled)
[639.286472] Starting subtest: reset-signaled
[639.288430] Subtest reset-signaled: SUCCESS (0.000s)
[639.356361] [120/133] (387s left) gem_watchdog (default-virtual)
[639.416700] Starting subtest: default-virtual
[645.691396] Subtest default-virtual: SUCCESS (6.283s)
[645.781092] [121/133] (381s left) gem_ctx_engines (none)
[645.855270] Starting subtest: none
[645.857504] Subtest none: SUCCESS (0.001s)
[646.049622] [122/133] (381s left) kms_chamelium_edid (vga-edid-read)
[646.451955] Subtest vga-edid-read: SKIP (0.000s)
[647.227442] [123/133] (380s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[647.324259] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[655.926620] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.606s)
[656.040879] [124/133] (371s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[656.151406] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[656.153652] Starting dynamic subtest: A-eDP1
[659.725078] Dynamic subtest A-eDP1: SUCCESS (3.571s)
[659.735115] Starting dynamic subtest: B-eDP1
[662.914774] Dynamic subtest B-eDP1: SUCCESS (3.189s)
[662.925501] Starting dynamic subtest: C-eDP1
[666.017381] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[666.028358] Starting dynamic subtest: D-eDP1
[669.101684] Dynamic subtest D-eDP1: SUCCESS (3.082s)
[669.103947] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.952s)
[669.906270] [125/133] (357s left) kms_psr (fbc-psr2-sprite-render)
[670.006183] Starting subtest: fbc-psr2-sprite-render
[670.008060] Starting dynamic subtest: eDP-1
[670.012149] Dynamic subtest eDP-1: SKIP (0.000s)
[670.016220] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[670.079669] [126/133] (357s left) kms_plane_alpha_blend (constant-alpha-min)
[670.161412] Starting subtest: constant-alpha-min
[670.443305] Starting dynamic subtest: pipe-A-eDP-1
[671.151236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[671.161558] Starting dynamic subtest: pipe-D-eDP-1
[672.579397] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[672.581720] Subtest constant-alpha-min: SUCCESS (2.420s)
[673.389941] [127/133] (354s left) kms_cursor_edge_walk (64x64-top-bottom)
[673.483302] Starting subtest: 64x64-top-bottom
[673.485576] Starting dynamic subtest: pipe-A-eDP-1
[676.932749] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[676.942650] Starting dynamic subtest: pipe-D-eDP-1
[680.069301] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[680.071596] Subtest 64x64-top-bottom: SUCCESS (6.588s)
[680.876956] [128/133] (346s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[680.985550] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[680.990032] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[681.116625] [129/133] (346s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[681.213418] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[681.217471] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[681.326300] [130/133] (346s left) syncobj_eventfd (binary-wait)
[681.370125] Starting subtest: binary-wait
[681.378758] Subtest binary-wait: SUCCESS (0.010s)
[681.468242] [131/133] (346s left) kms_pm_dc (dc5-psr)
[682.569110] Starting subtest: dc5-psr
[685.444281] Subtest dc5-psr: SUCCESS (2.876s)
[686.300475] [132/133] (341s left) gem_mmap_gtt (medium-copy-odd)
[686.357648] Subtest medium-copy-odd: SKIP (0.000s)
[686.412879] [133/133] (341s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[686.517319] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[686.519616] Starting dynamic subtest: pipe-A-default-mode
[687.663421] Dynamic subtest pipe-A-default-mode: SKIP (1.140s)
[687.667603] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.142s)
[687.808791] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_param
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_rotation_crc
results: parsing output: 7/ for test: kms_scaling_modes
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: syncobj_basic
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: i915_hangman
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_audio
results: parsing output: 18/ for test: kms_dp_link_training
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_feature_discovery
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: kms_sequence
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: i915_query
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: kms_setmode
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: gem_ctx_shared
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_madvise
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: gem_exec_store
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: dmabuf_sync_file
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_busy
results: parsing output: 72/ for test: gem_exec_flush
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: sysfs_heartbeat_interval
results: parsing output: 80/ for test: core_debugfs
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_exercise_blt
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: gem_ctx_isolation
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: i915_pm_rc6_residency
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: gem_fence_thrash
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_mmap_wc
results: parsing output: 98/ for test: kms_draw_crc
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_hdr
results: parsing output: 112/ for test: gem_busy
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: gem_watchdog
results: parsing output: 120/ for test: gem_ctx_engines
results: parsing output: 121/ for test: kms_chamelium_edid
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_plane_alpha_blend
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_eventfd
results: parsing output: 130/ for test: kms_pm_dc
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.