[58.078376] Initializing watchdogs
[58.078421]   /dev/watchdog0
[58.092282] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.096415] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.098794] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.102178] [001/133] (960s left) perf (invalid-oa-exponent)
[58.246620] Starting subtest: invalid-oa-exponent
[58.259469] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[58.298249] [002/133] (960s left) kms_vblank (query-idle)
[58.395861] Starting subtest: query-idle
[58.398126] Starting dynamic subtest: pipe-A-eDP-1
[60.187643] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.776s)
[60.200437] Starting dynamic subtest: pipe-D-eDP-1
[62.619717] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.417s)
[62.622070] Subtest query-idle: SUCCESS (4.196s)
[63.447015] [003/133] (955s left) gem_ctx_persistence (smoketest)
[63.508956] Starting subtest: smoketest
[104.229680] Subtest smoketest: SUCCESS (40.684s)
[104.307191] [004/133] (914s left) syncobj_timeline (invalid-transfer-bad-pad)
[104.364351] Starting subtest: invalid-transfer-bad-pad
[104.366605] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[104.458183] [005/133] (914s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[104.584125] Starting subtest: cursor-vs-flip-atomic-transitions
[134.794659] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.207s)
[135.605022] [006/133] (883s left) gem_mmap_wc (write-prefaulted)
[135.671491] Subtest write-prefaulted: SKIP (0.000s)
[135.724518] [007/133] (883s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[136.106442] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[136.908187] [008/133] (881s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[137.026600] Starting subtest: 4-tiled-8bpp-rotate-270
[137.050109] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[137.160010] [009/133] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[137.255605] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[137.259918] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[137.365007] [010/133] (881s left) kms_joiner (basic-ultra-joiner)
[137.471763] Starting subtest: basic-ultra-joiner
[137.476056] Subtest basic-ultra-joiner: SKIP (0.000s)
[137.540371] [011/133] (881s left) gem_tiled_blits (normal)
[137.592790] Subtest normal: SKIP (0.000s)
[137.654828] [012/133] (881s left) kms_vrr (max-min)
[137.750067] Starting subtest: max-min
[137.756355] Subtest max-min: SKIP (0.000s)
[137.818355] [013/133] (881s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[137.942031] Starting subtest: cursorB-vs-flipB-legacy
[137.945846] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[138.087698] [014/133] (881s left) gem_exec_schedule (pi-userfault)
[138.271583] Starting subtest: pi-userfault
[138.273988] Starting dynamic subtest: rcs0
[138.281125] Dynamic subtest rcs0: SUCCESS (0.012s)
[138.290755] Starting dynamic subtest: bcs0
[138.292670] Dynamic subtest bcs0: SUCCESS (0.007s)
[138.300426] Starting dynamic subtest: vcs0
[138.302605] Dynamic subtest vcs0: SUCCESS (0.011s)
[138.309854] Starting dynamic subtest: vcs1
[138.312094] Dynamic subtest vcs1: SUCCESS (0.009s)
[138.319678] Starting dynamic subtest: vecs0
[138.321857] Dynamic subtest vecs0: SUCCESS (0.007s)
[138.331903] Starting dynamic subtest: ccs0
[138.334150] Dynamic subtest ccs0: SUCCESS (0.015s)
[138.336060] Subtest pi-userfault: SUCCESS (0.064s)
[138.514950] [015/133] (880s left) api_intel_bb (intel-bb-blit-none)
[138.578794] Starting subtest: intel-bb-blit-none
[142.629146] Subtest intel-bb-blit-none: SUCCESS (4.049s)
[142.752408] [016/133] (876s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[142.861621] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[149.596063] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.737s)
[149.718739] [017/133] (869s left) kms_prime (d3hot)
[149.801709] Subtest D3hot: SKIP (0.000s)
[149.942171] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[149.945526] [018/133] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[150.045427] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[157.508799] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.467s)
[157.619864] [019/133] (861s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[157.678739] Starting subtest: framebuffer-vs-set-tiling
[157.682805] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[157.819686] [020/133] (861s left) gem_softpin (allocator-nopin)
[157.867365] Starting subtest: allocator-nopin
[157.961384] Subtest allocator-nopin: SUCCESS (0.094s)
[158.103829] [021/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[158.198782] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[158.202717] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[158.267279] [022/133] (861s left) api_intel_bb (crc32)
[158.328790] Starting subtest: crc32
[158.330695] Starting dynamic subtest: rcs0-smem0
[158.616112] Dynamic subtest rcs0-smem0: SUCCESS (0.287s)
[158.627566] Starting dynamic subtest: bcs0-smem0
[158.946202] Dynamic subtest bcs0-smem0: SUCCESS (0.329s)
[158.957975] Starting dynamic subtest: vcs0-smem0
[159.294121] Dynamic subtest vcs0-smem0: SUCCESS (0.348s)
[159.304913] Starting dynamic subtest: vcs1-smem0
[159.649711] Dynamic subtest vcs1-smem0: SUCCESS (0.353s)
[159.660971] Starting dynamic subtest: vecs0-smem0
[160.020904] Dynamic subtest vecs0-smem0: SUCCESS (0.370s)
[160.032040] Starting dynamic subtest: ccs0-smem0
[160.323486] Dynamic subtest ccs0-smem0: SUCCESS (0.302s)
[160.325969] Subtest crc32: SUCCESS (1.996s)
[160.451204] [023/133] (859s left) gem_exec_whisper (basic-queues-forked)
[160.505420] Starting subtest: basic-queues-forked
[183.713667] Subtest basic-queues-forked: SUCCESS (23.205s)
[183.911201] [024/133] (835s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[184.021872] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[184.024183] Starting dynamic subtest: pipe-A
[184.359791] Dynamic subtest pipe-A: SUCCESS (0.340s)
[184.370385] Starting dynamic subtest: pipe-B
[185.753387] Dynamic subtest pipe-B: SUCCESS (1.393s)
[185.762995] Starting dynamic subtest: pipe-C
[187.210599] Dynamic subtest pipe-C: SUCCESS (1.457s)
[187.220344] Starting dynamic subtest: pipe-D
[188.635105] Dynamic subtest pipe-D: SUCCESS (1.424s)
[188.637528] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.616s)
[189.785664] [025/133] (829s left) tools_test (tools_test)
[189.845890] Starting subtest: tools_test
[189.906932] Subtest tools_test: SUCCESS (0.073s)
[189.964260] [026/133] (829s left) perf (rc6-disable)
[190.057726] Starting subtest: rc6-disable
[190.230805] Subtest rc6-disable: SUCCESS (0.172s)
[190.280954] [027/133] (829s left) gem_exec_fence (invalid-timeline-fence-array)
[190.832699] Starting subtest: invalid-timeline-fence-array
[190.837808] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[192.411547] [028/133] (827s left) kms_plane_cursor (primary)
[192.500917] Starting subtest: primary
[192.505567] Starting dynamic subtest: pipe-A-eDP-1-size-64
[195.119918] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.620s)
[195.143398] Starting dynamic subtest: pipe-A-eDP-1-size-128
[197.731967] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.594s)
[197.756275] Starting dynamic subtest: pipe-A-eDP-1-size-256
[200.333210] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[200.656485] Starting dynamic subtest: pipe-B-eDP-1-size-64
[204.001067] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.356s)
[204.024637] Starting dynamic subtest: pipe-B-eDP-1-size-128
[206.568985] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.550s)
[206.591981] Starting dynamic subtest: pipe-B-eDP-1-size-256
[209.146977] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[209.462938] Starting dynamic subtest: pipe-C-eDP-1-size-64
[212.322154] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.870s)
[212.348148] Starting dynamic subtest: pipe-C-eDP-1-size-128
[214.655725] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.314s)
[214.681445] Starting dynamic subtest: pipe-C-eDP-1-size-256
[216.855368] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[217.173333] Starting dynamic subtest: pipe-D-eDP-1-size-64
[220.065831] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.905s)
[220.091658] Starting dynamic subtest: pipe-D-eDP-1-size-128
[222.299107] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[222.325069] Starting dynamic subtest: pipe-D-eDP-1-size-256
[224.533074] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[224.843826] Subtest primary: SUCCESS (32.341s)
[225.702111] [029/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[225.812031] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[225.816229] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[225.905881] [030/133] (793s left) kms_flip (plain-flip-fb-recreate)
[225.988618] Starting subtest: plain-flip-fb-recreate
[225.990507] Starting dynamic subtest: A-eDP1
[234.906797] Dynamic subtest A-eDP1: SUCCESS (8.920s)
[234.921894] Starting dynamic subtest: B-eDP1
[243.738209] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[243.749214] Starting dynamic subtest: C-eDP1
[252.557425] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[252.568389] Starting dynamic subtest: D-eDP1
[261.399125] Dynamic subtest D-eDP1: SUCCESS (8.838s)
[261.402983] Subtest plain-flip-fb-recreate: SUCCESS (35.417s)
[262.580846] [031/133] (757s left) prime_self_import (basic-with_fd_dup)
[262.615506] Starting subtest: basic-with_fd_dup
[262.625993] Subtest basic-with_fd_dup: SUCCESS (0.013s)
[262.731363] [032/133] (757s left) gem_exec_reloc (basic-wc-noreloc)
[262.797613] Subtest basic-wc-noreloc: SKIP (0.000s)
[262.877604] [033/133] (756s left) gem_mmap_gtt (basic-read-write)
[262.932575] Subtest basic-read-write: SKIP (0.000s)
[262.989343] [034/133] (756s left) gem_pxp (verify-pxp-stale-ctx-execution)
[263.115237] Starting subtest: verify-pxp-stale-ctx-execution
[264.173154] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[264.308187] [035/133] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[264.406099] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[264.410062] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[264.499962] [036/133] (755s left) gem_mmap_gtt (bad-object)
[264.562444] Subtest bad-object: SKIP (0.000s)
[264.614383] [037/133] (755s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[264.700859] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[264.702991] Starting dynamic subtest: pipe-A-eDP-1
[264.711593] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[264.721059] Starting dynamic subtest: pipe-B-eDP-1
[264.729437] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[264.737832] Starting dynamic subtest: pipe-C-eDP-1
[264.745770] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[264.753302] Starting dynamic subtest: pipe-D-eDP-1
[264.761113] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[264.765214] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[266.868299] [038/133] (753s left) dumb_buffer (map-valid)
[266.918286] Starting subtest: map-valid
[266.920196] Subtest map-valid: SUCCESS (0.000s)
[267.016925] [039/133] (753s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[267.129137] Starting subtest: cursorA-vs-flipB-varying-size
[267.133539] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[267.278702] [040/133] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[267.381872] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[267.386243] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[267.464342] [041/133] (752s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[267.550304] Starting subtest: bad-aux-stride-y-tiled-ccs
[267.552549] Starting dynamic subtest: pipe-A-eDP-1
[267.574801] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[267.584799] Starting dynamic subtest: pipe-B-eDP-1
[267.606249] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[267.613979] Starting dynamic subtest: pipe-C-eDP-1
[267.635726] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[267.643314] Starting dynamic subtest: pipe-D-eDP-1
[267.665450] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[267.669775] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[269.731852] [042/133] (750s left) sriov_basic (bind-unbind-vf)
[269.796795] Starting subtest: bind-unbind-vf
[269.799239] Starting dynamic subtest: vf-1
[269.872262] Dynamic subtest vf-1: FAIL (0.018s)
[269.881091] Starting dynamic subtest: vf-2
[269.949978] Dynamic subtest vf-2: FAIL (0.005s)
[269.961317] Starting dynamic subtest: vf-3
[270.035209] Dynamic subtest vf-3: FAIL (0.003s)
[270.045459] Starting dynamic subtest: vf-4
[270.118902] Dynamic subtest vf-4: FAIL (0.003s)
[270.127591] Starting dynamic subtest: vf-5
[270.200118] Dynamic subtest vf-5: FAIL (0.003s)
[270.209652] Starting dynamic subtest: vf-6
[270.284138] Dynamic subtest vf-6: FAIL (0.004s)
[270.294129] Starting dynamic subtest: vf-7
[270.367489] Dynamic subtest vf-7: FAIL (0.004s)
[270.377138] Starting dynamic subtest: vf-random
[270.449907] Dynamic subtest vf-random: FAIL (0.004s)
[270.459240] Starting dynamic subtest: vf-last
[270.530977] Dynamic subtest vf-last: FAIL (0.508s)
[270.533356] Subtest bind-unbind-vf: FAIL (0.559s)
[270.571557] [043/133] (749s left) gem_request_retire (retire-vma-not-inactive)
[270.620908] Starting subtest: retire-vma-not-inactive
[270.680618] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[270.787607] [044/133] (749s left) kms_big_fb (x-tiled-addfb-size-overflow)
[270.879324] Starting subtest: x-tiled-addfb-size-overflow
[270.881119] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[270.977396] [045/133] (749s left) kms_pm_dc (dc9-dpms)
[272.067038] Starting subtest: dc9-dpms
[273.490743] Subtest dc9-dpms: SUCCESS (1.425s)
[273.569176] [046/133] (746s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[273.665078] Starting subtest: psr2-cursor-plane-move-continuous-sf
[273.667728] Starting dynamic subtest: pipe-A-eDP-1
[284.011475] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.347s)
[284.020479] Starting dynamic subtest: pipe-B-eDP-1
[295.108475] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.094s)
[295.110696] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.445s)
[295.905474] [047/133] (724s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[295.999987] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[296.004294] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[296.071724] [048/133] (724s left) syncobj_wait (signal)
[296.126045] Starting subtest: signal
[296.128342] Subtest signal: SUCCESS (0.000s)
[296.212236] [049/133] (724s left) kms_dp_aux_dev (basic)
[296.270733] Starting subtest: basic
[296.493401] Subtest basic: SUCCESS (0.222s)
[296.561726] [050/133] (723s left) gem_exec_reloc (basic-cpu-active)
[296.622214] Subtest basic-cpu-active: SKIP (0.000s)
[296.695684] [051/133] (723s left) kms_lease (simple-lease)
[296.797259] Starting subtest: simple-lease
[296.799461] Starting dynamic subtest: pipe-A-eDP-1
[297.293921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[297.301970] Starting dynamic subtest: pipe-B-eDP-1
[298.743541] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[298.754226] Starting dynamic subtest: pipe-C-eDP-1
[300.152060] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.409s)
[300.160395] Starting dynamic subtest: pipe-D-eDP-1
[301.544804] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s)
[301.547276] Subtest simple-lease: SUCCESS (4.749s)
[302.369192] [052/133] (718s left) kms_cursor_crc (cursor-onscreen-256x256)
[302.619815] Starting subtest: cursor-onscreen-256x256
[302.622089] Starting dynamic subtest: pipe-A-eDP-1
[304.741593] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[304.768316] Starting dynamic subtest: pipe-D-eDP-1
[307.533119] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[307.535411] Subtest cursor-onscreen-256x256: SUCCESS (4.914s)
[308.417278] [053/133] (712s left) gem_exec_alignment (forked)
[308.481670] Starting subtest: forked
[347.275611] Subtest forked: SUCCESS (38.738s)
[347.325627] [054/133] (673s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[347.466588] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[354.981146] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.517s)
[355.082821] [055/133] (665s left) kms_psr (fbc-psr2-sprite-plane-move)
[355.176070] Starting subtest: fbc-psr2-sprite-plane-move
[355.178318] Starting dynamic subtest: eDP-1
[355.182643] Dynamic subtest eDP-1: SKIP (0.000s)
[355.187645] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[355.248754] [056/133] (665s left) kms_plane (pixel-format-x-tiled-modifier)
[355.339197] Starting subtest: pixel-format-x-tiled-modifier
[355.367865] Starting dynamic subtest: pipe-A-plane-0
[356.033827] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s)
[356.044535] Starting dynamic subtest: pipe-A-plane-3
[356.444795] Dynamic subtest pipe-A-plane-3: SUCCESS (0.409s)
[356.453155] Starting dynamic subtest: pipe-A-plane-5
[356.456493] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[357.516199] Starting dynamic subtest: pipe-B-plane-0
[358.164782] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[358.173673] Starting dynamic subtest: pipe-B-plane-3
[358.564376] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[358.572480] Starting dynamic subtest: pipe-B-plane-5
[358.576232] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[358.894267] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.554s)
[359.691564] [057/133] (661s left) perf_pmu (init-sema)
[359.742714] Starting subtest: init-sema
[359.745152] Starting dynamic subtest: rcs0
[359.747504] Dynamic subtest rcs0: SUCCESS (0.002s)
[359.757187] Starting dynamic subtest: bcs0
[359.759417] Dynamic subtest bcs0: SUCCESS (0.000s)
[359.767638] Starting dynamic subtest: vcs0
[359.769934] Dynamic subtest vcs0: SUCCESS (0.001s)
[359.777819] Starting dynamic subtest: vcs1
[359.779757] Dynamic subtest vcs1: SUCCESS (0.001s)
[359.787606] Starting dynamic subtest: vecs0
[359.789530] Dynamic subtest vecs0: SUCCESS (0.001s)
[359.797713] Starting dynamic subtest: ccs0
[359.799989] Dynamic subtest ccs0: SUCCESS (0.000s)
[359.802267] Subtest init-sema: SUCCESS (0.008s)
[359.851458] [058/133] (661s left) intel_hwmon (hwmon-read)
[359.919461] Subtest hwmon-read: SKIP (0.000s)
[359.979265] [059/133] (660s left) gem_create (create-size-update)
[360.034666] Starting subtest: create-size-update
[360.036992] Subtest create-size-update: SUCCESS (0.000s)
[360.249159] [060/133] (660s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[360.343567] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[360.348056] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[360.428192] [061/133] (660s left) kms_color_pipeline (plane-ctm3x4)
[360.515244] Starting subtest: plane-ctm3x4
[360.652970] Starting dynamic subtest: pipe-A-plane-0
[360.774108] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[360.783622] Starting dynamic subtest: pipe-A-plane-1
[360.886425] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[360.895432] Starting dynamic subtest: pipe-A-plane-2
[360.997499] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[362.188745] Starting dynamic subtest: pipe-B-plane-0
[362.309158] Dynamic subtest pipe-B-plane-0: SUCCESS (0.132s)
[362.318608] Starting dynamic subtest: pipe-B-plane-1
[362.421801] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s)
[362.430522] Starting dynamic subtest: pipe-B-plane-2
[362.575408] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[363.725314] Starting dynamic subtest: pipe-C-plane-0
[363.829194] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[363.837981] Starting dynamic subtest: pipe-C-plane-1
[363.940839] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s)
[363.955531] Starting dynamic subtest: pipe-C-plane-2
[364.096591] Dynamic subtest pipe-C-plane-2: SUCCESS (0.153s)
[365.274687] Starting dynamic subtest: pipe-D-plane-0
[365.402692] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[365.414316] Starting dynamic subtest: pipe-D-plane-1
[365.523273] Dynamic subtest pipe-D-plane-1: SUCCESS (0.120s)
[365.532526] Starting dynamic subtest: pipe-D-plane-2
[365.634851] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[365.924186] Subtest plane-ctm3x4: SUCCESS (5.406s)
[366.739094] [062/133] (654s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[366.806738] Starting subtest: single-wait-all-for-submit-available-submitted
[366.809178] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[366.934777] [063/133] (654s left) kms_chamelium_color (ctm-red-to-blue)
[367.023447] Subtest ctm-red-to-blue: SKIP (0.000s)
[367.070673] [064/133] (654s left) kms_cursor_crc (cursor-size-hints)
[367.202465] Starting subtest: cursor-size-hints
[367.204768] Starting dynamic subtest: pipe-A-eDP-1
[367.852972] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[367.862124] Starting dynamic subtest: pipe-D-eDP-1
[369.104219] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s)
[369.106697] Subtest cursor-size-hints: SUCCESS (1.901s)
[369.897197] [065/133] (651s left) kms_flip (2x-wf_vblank-ts-check)
[369.986781] Starting subtest: 2x-wf_vblank-ts-check
[369.995328] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[370.074376] [066/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[370.174441] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[370.178154] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[370.292172] [067/133] (650s left) kms_cursor_crc (cursor-sliding-max-size)
[370.583327] Starting subtest: cursor-sliding-max-size
[370.589373] Subtest cursor-sliding-max-size: SKIP (0.000s)
[370.696348] [068/133] (650s left) gem_userptr_blits (map-fixed-invalidate-busy)
[370.761012] Starting subtest: map-fixed-invalidate-busy
[370.765088] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[370.886267] [069/133] (650s left) i915_pm_rc6_residency (media-rc6-accuracy)
[370.934341] Starting subtest: media-rc6-accuracy
[370.937977] Subtest media-rc6-accuracy: SKIP (0.000s)
[371.044411] [070/133] (650s left) kms_psr (psr-primary-mmap-gtt)
[371.134410] Starting subtest: psr-primary-mmap-gtt
[371.136316] Starting dynamic subtest: eDP-1
[372.603658] Dynamic subtest eDP-1: SKIP (1.463s)
[372.608625] Subtest psr-primary-mmap-gtt: SKIP (1.466s)
[372.748529] [071/133] (648s left) gem_exec_params (invalid-fence-in-submit)
[372.806681] Starting subtest: invalid-fence-in-submit
[372.809071] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[372.916916] [072/133] (648s left) gem_exec_whisper (basic-contexts-priority-all)
[372.989089] Starting subtest: basic-contexts-priority-all
[395.229415] Subtest basic-contexts-priority-all: SUCCESS (22.240s)
[395.413224] [073/133] (626s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[395.530263] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[395.534257] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[395.629422] [074/133] (625s left) gem_ctx_persistence (engines-mixed)
[395.681406] Starting subtest: engines-mixed
[395.683586] Starting dynamic subtest: rcs0
[395.796045] Dynamic subtest rcs0: SUCCESS (0.114s)
[395.807256] Starting dynamic subtest: bcs0
[395.851576] Dynamic subtest bcs0: SUCCESS (0.054s)
[395.861069] Starting dynamic subtest: vcs0
[395.883047] Dynamic subtest vcs0: SUCCESS (0.029s)
[395.893560] Starting dynamic subtest: vcs1
[395.968877] Dynamic subtest vcs1: SUCCESS (0.085s)
[395.980338] Starting dynamic subtest: vecs0
[396.021222] Dynamic subtest vecs0: SUCCESS (0.049s)
[396.033246] Starting dynamic subtest: ccs0
[396.085673] Dynamic subtest ccs0: SUCCESS (0.063s)
[396.088142] Subtest engines-mixed: SUCCESS (0.406s)
[396.166246] [075/133] (625s left) kms_psr (psr-cursor-mmap-gtt)
[396.261247] Starting subtest: psr-cursor-mmap-gtt
[396.263623] Starting dynamic subtest: eDP-1
[398.023713] Dynamic subtest eDP-1: SUCCESS (1.762s)
[398.026171] Subtest psr-cursor-mmap-gtt: SUCCESS (1.764s)
[398.903219] [076/133] (622s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[399.015654] Starting subtest: primary-yf-tiled-reflect-x-0
[399.075223] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[399.175723] [077/133] (622s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[399.270895] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[399.273079] Starting dynamic subtest: pipe-A-eDP-1
[399.281604] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.290708] Starting dynamic subtest: pipe-B-eDP-1
[399.299307] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.307695] Starting dynamic subtest: pipe-C-eDP-1
[399.315827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.323913] Starting dynamic subtest: pipe-D-eDP-1
[399.332495] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.336376] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[401.463590] [078/133] (620s left) gem_basic (create-fd-close)
[401.522874] Starting subtest: create-fd-close
[401.526761] Subtest create-fd-close: SUCCESS (0.000s)
[401.632160] [079/133] (620s left) kms_frontbuffer_tracking (fbc-suspend)
[401.735110] Starting subtest: fbc-suspend
[439.578333] Subtest fbc-suspend: SUCCESS (8.375s)
[440.785426] [080/133] (580s left) perf (invalid-remove-userspace-config)
[440.909342] Starting subtest: invalid-remove-userspace-config
[440.918242] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[440.959158] [081/133] (580s left) kms_universal_plane (disable-primary-vs-flip)
[441.056045] Starting subtest: disable-primary-vs-flip
[441.058080] Starting dynamic subtest: pipe-A-eDP-1
[442.560900] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.486s)
[442.571098] Starting dynamic subtest: pipe-B-eDP-1
[444.732328] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.150s)
[444.746045] Starting dynamic subtest: pipe-C-eDP-1
[446.930566] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.178s)
[446.941322] Starting dynamic subtest: pipe-D-eDP-1
[449.113783] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[449.116211] Subtest disable-primary-vs-flip: SUCCESS (7.990s)
[449.909034] [082/133] (571s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[449.966408] Starting subtest: invalid-multi-wait-all-unsubmitted
[449.968740] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[450.055860] [083/133] (571s left) gem_softpin (32b-excludes-last-page)
[450.110206] Starting subtest: 32b-excludes-last-page
[450.115796] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[450.238650] [084/133] (571s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[450.328953] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[450.333342] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[450.418209] [085/133] (571s left) gem_exec_parallel (fds)
[450.473138] Starting subtest: fds
[450.475465] Starting dynamic subtest: rcs0
[453.283311] Dynamic subtest rcs0: SUCCESS (2.797s)
[453.294540] Starting dynamic subtest: bcs0
[457.209035] Dynamic subtest bcs0: SUCCESS (3.914s)
[457.221681] Starting dynamic subtest: vcs0
[460.975355] Dynamic subtest vcs0: SUCCESS (3.756s)
[460.985571] Starting dynamic subtest: vcs1
[465.008616] Dynamic subtest vcs1: SUCCESS (4.025s)
[465.021264] Starting dynamic subtest: vecs0
[468.940472] Dynamic subtest vecs0: SUCCESS (3.928s)
[468.950560] Starting dynamic subtest: ccs0
[472.564393] Dynamic subtest ccs0: SUCCESS (3.625s)
[472.566873] Subtest fds: SUCCESS (22.061s)
[472.755522] [086/133] (549s left) kms_psr (pr-cursor-plane-move)
[472.870535] Starting subtest: pr-cursor-plane-move
[472.874922] Subtest pr-cursor-plane-move: SKIP (0.000s)
[472.942888] [087/133] (549s left) gem_eio (banned)
[473.164805] Starting subtest: banned
[473.770338] Subtest banned: SUCCESS (0.606s)
[473.935298] [088/133] (548s left) kms_addfb_basic (bad-pitch-128)
[473.983894] Starting subtest: bad-pitch-128
[473.985698] Subtest bad-pitch-128: SUCCESS (0.000s)
[474.110212] [089/133] (548s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[474.177228] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[474.279331] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[474.353544] [090/133] (547s left) kms_feature_discovery (chamelium)
[474.437690] Starting subtest: chamelium
[474.441678] Subtest chamelium: SKIP (0.000s)
[474.524610] [091/133] (547s left) syncobj_wait (invalid-signal-one-illegal-handle)
[474.594118] Starting subtest: invalid-signal-one-illegal-handle
[474.596492] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[474.698632] [092/133] (547s left) kms_properties (colorop-properties-atomic)
[474.780740] Starting subtest: colorop-properties-atomic
[474.783027] Starting dynamic subtest: pipe-A-eDP-1
[475.157404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[475.168599] Starting dynamic subtest: pipe-B-eDP-1
[476.198168] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.041s)
[476.209621] Starting dynamic subtest: pipe-C-eDP-1
[477.244235] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.044s)
[477.257552] Starting dynamic subtest: pipe-D-eDP-1
[478.271914] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.027s)
[478.273832] Subtest colorop-properties-atomic: SUCCESS (3.491s)
[479.073488] [093/133] (543s left) gem_exec_balancer (bonded-semaphore)
[479.132197] Starting subtest: bonded-semaphore
[479.136841] Subtest bonded-semaphore: SKIP (0.000s)
[479.451024] [094/133] (542s left) i915_query (query-topology-garbage-items)
[479.520408] Starting subtest: query-topology-garbage-items
[479.522870] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[479.650059] [095/133] (542s left) gem_flink_basic (flink-lifetime)
[479.697707] Starting subtest: flink-lifetime
[479.700027] Subtest flink-lifetime: SUCCESS (0.002s)
[479.801964] [096/133] (542s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[479.893404] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[479.895694] Starting dynamic subtest: pipe-A
[479.915885] Dynamic subtest pipe-A: SKIP (0.018s)
[479.928777] Starting dynamic subtest: pipe-B
[479.953293] Dynamic subtest pipe-B: SKIP (0.037s)
[479.965699] Starting dynamic subtest: pipe-C
[479.986816] Dynamic subtest pipe-C: SKIP (0.034s)
[479.997048] Starting dynamic subtest: pipe-D
[480.022454] Dynamic subtest pipe-D: SKIP (0.034s)
[480.026629] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.125s)
[480.107143] [097/133] (542s left) gem_exec_fence (basic-wait)
[480.279853] Starting subtest: basic-wait
[480.282114] Starting dynamic subtest: rcs0
[480.352956] Dynamic subtest rcs0: SUCCESS (0.073s)
[480.363943] Starting dynamic subtest: bcs0
[480.409696] Dynamic subtest bcs0: SUCCESS (0.055s)
[480.422734] Starting dynamic subtest: vcs0
[480.471685] Dynamic subtest vcs0: SUCCESS (0.060s)
[480.482133] Starting dynamic subtest: vcs1
[480.533755] Dynamic subtest vcs1: SUCCESS (0.060s)
[480.547116] Starting dynamic subtest: vecs0
[480.584850] Dynamic subtest vecs0: SUCCESS (0.049s)
[480.595127] Starting dynamic subtest: ccs0
[480.636325] Dynamic subtest ccs0: SUCCESS (0.049s)
[480.638997] Subtest basic-wait: SUCCESS (0.358s)
[482.829423] [098/133] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[482.946453] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[482.950530] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[483.070488] [099/133] (539s left) gem_pread (display)
[483.115822] Subtest display: SKIP (0.000s)
[483.172272] [100/133] (539s left) gem_exec_schedule (u-semaphore-noskip)
[483.241626] Starting subtest: u-semaphore-noskip
[483.644615] Subtest u-semaphore-noskip: SUCCESS (0.409s)
[483.979189] [101/133] (538s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[484.031947] Starting subtest: multi-wait-all-for-submit-submitted
[484.136999] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[484.230928] [102/133] (538s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[484.335907] Starting subtest: extended-modeset-hang-oldfb-with-reset
[484.338153] Starting dynamic subtest: pipe-A
[496.148101] Dynamic subtest pipe-A: SUCCESS (11.809s)
[496.158542] Starting dynamic subtest: pipe-D
[508.433191] Dynamic subtest pipe-D: SUCCESS (12.282s)
[508.435480] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.096s)
[509.234584] [103/133] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[509.344642] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[509.348635] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[509.442665] [104/133] (513s left) sysfs_heartbeat_interval (idempotent)
[509.506254] Starting subtest: idempotent
[509.508584] Starting dynamic subtest: vecs0
[509.510884] Dynamic subtest vecs0: SUCCESS (0.001s)
[509.521559] Starting dynamic subtest: ccs0
[509.523433] Dynamic subtest ccs0: SUCCESS (0.001s)
[509.532567] Starting dynamic subtest: vcs0
[509.534472] Dynamic subtest vcs0: SUCCESS (0.000s)
[509.543555] Starting dynamic subtest: bcs0
[509.545413] Dynamic subtest bcs0: SUCCESS (0.001s)
[509.554508] Starting dynamic subtest: rcs0
[509.556774] Dynamic subtest rcs0: SUCCESS (0.001s)
[509.566626] Starting dynamic subtest: vcs1
[509.568851] Dynamic subtest vcs1: SUCCESS (0.000s)
[509.570771] Subtest idempotent: SUCCESS (0.007s)
[509.614678] [105/133] (513s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[509.711413] Starting subtest: psr-rgb101010-draw-render
[516.898858] Subtest psr-rgb101010-draw-render: SUCCESS (7.190s)
[517.013475] [106/133] (505s left) gem_render_copy_redux (interruptible)
[517.075586] Starting subtest: interruptible
[517.392294] Subtest interruptible: SUCCESS (0.318s)
[517.563008] [107/133] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[517.655084] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[517.659516] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[517.755994] [108/133] (505s left) kms_psr (fbc-psr2-cursor-render)
[517.839830] Starting subtest: fbc-psr2-cursor-render
[517.841783] Starting dynamic subtest: eDP-1
[517.845315] Dynamic subtest eDP-1: SKIP (0.000s)
[517.849152] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[517.911578] [109/133] (505s left) kms_big_fb (linear-addfb)
[518.020153] Starting subtest: linear-addfb
[518.022078] Subtest linear-addfb: SUCCESS (0.000s)
[518.112672] [110/133] (504s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[518.213096] Starting subtest: yf-tiled-64bpp-rotate-90
[518.216796] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[518.314029] [111/133] (504s left) gen9_exec_parse (batch-without-end)
[518.378989] Subtest batch-without-end: SKIP (0.000s)
[518.457080] [112/133] (504s left) kms_content_protection (dp-mst-type-1)
[518.599603] Starting subtest: dp-mst-type-1
[518.603530] Subtest dp-mst-type-1: SKIP (0.000s)
[518.728911] [113/133] (504s left) sw_sync (timeline_closed)
[518.768309] Starting subtest: timeline_closed
[518.770182] Subtest timeline_closed: SUCCESS (0.000s)
[518.823144] [114/133] (504s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[518.911554] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[518.913309] Starting dynamic subtest: pipe-A-eDP-1
[525.645510] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.731s)
[525.656328] Starting dynamic subtest: pipe-B-eDP-1
[532.563264] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.917s)
[532.565663] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.652s)
[533.435787] [115/133] (489s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[533.529024] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[540.373535] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.851s)
[540.523715] [116/133] (482s left) i915_drm_fdinfo (most-busy-idle-check-all)
[540.558950] Starting subtest: most-busy-idle-check-all
[540.561344] Starting dynamic subtest: rcs0
[540.566054] Dynamic subtest rcs0: SKIP (0.004s)
[540.578569] Starting dynamic subtest: bcs0
[540.582782] Dynamic subtest bcs0: SKIP (0.000s)
[540.592213] Starting dynamic subtest: vcs0
[540.596609] Dynamic subtest vcs0: SKIP (0.000s)
[540.606032] Starting dynamic subtest: vcs1
[540.610431] Dynamic subtest vcs1: SKIP (0.000s)
[540.619911] Starting dynamic subtest: vecs0
[540.624437] Dynamic subtest vecs0: SKIP (0.000s)
[540.633714] Starting dynamic subtest: ccs0
[540.638109] Dynamic subtest ccs0: SKIP (0.000s)
[540.643012] Subtest most-busy-idle-check-all: SKIP (0.009s)
[540.689182] [117/133] (482s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[540.825348] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[540.827550] Starting dynamic subtest: pipe-A-eDP-1
[541.672701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.842s)
[541.682883] Starting dynamic subtest: pipe-B-eDP-1
[543.212410] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.537s)
[543.223396] Starting dynamic subtest: pipe-C-eDP-1
[544.680358] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.468s)
[544.691770] Starting dynamic subtest: pipe-D-eDP-1
[546.206751] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[546.208995] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.378s)
[547.400426] [118/133] (476s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[547.504243] Starting subtest: y-tiled-64bpp-rotate-90
[547.508934] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[547.601182] [119/133] (475s left) syncobj_timeline (multi-wait-for-submit-signaled)
[547.657058] Starting subtest: multi-wait-for-submit-signaled
[547.659054] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[547.749464] [120/133] (475s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[547.843078] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[547.847139] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[547.939990] [121/133] (475s left) kms_addfb_basic (bad-pitch-65536)
[547.995349] Starting subtest: bad-pitch-65536
[547.997645] Subtest bad-pitch-65536: SUCCESS (0.000s)
[548.125693] [122/133] (475s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[548.220937] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[548.225310] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[548.327619] [123/133] (475s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[548.434689] Starting subtest: x-tiled-8bpp-rotate-270
[548.455522] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[548.568675] [124/133] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[548.658630] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[548.662190] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[548.775808] [125/133] (474s left) gem_exec_flush (basic-wb-rw-before-default)
[548.834652] Starting subtest: basic-wb-rw-before-default
[554.323085] Subtest basic-wb-rw-before-default: SUCCESS (5.466s)
[554.490254] [126/133] (469s left) gem_mmap_offset (bad-extensions)
[554.551485] Starting subtest: bad-extensions
[554.553854] Subtest bad-extensions: SUCCESS (0.000s)
[554.657592] [127/133] (469s left) kms_async_flips (test-cursor)
[554.744656] Starting subtest: test-cursor
[555.116430] Starting dynamic subtest: pipe-A-eDP-1
[555.873138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[556.254475] Starting dynamic subtest: pipe-B-eDP-1
[557.011247] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[557.379706] Starting dynamic subtest: pipe-C-eDP-1
[558.140294] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[558.512632] Starting dynamic subtest: pipe-D-eDP-1
[559.266244] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.763s)
[559.268597] Subtest test-cursor: SUCCESS (4.525s)
[560.439968] [128/133] (463s left) kms_chamelium_audio (hdmi-audio-edid)
[560.829721] Subtest hdmi-audio-edid: SKIP (0.000s)
[561.643578] [129/133] (462s left) i915_hangman (gt-engine-hang)
[561.712705] Starting subtest: gt-engine-hang
[561.715020] Starting dynamic subtest: rcs0
[563.644967] Dynamic subtest rcs0: SUCCESS (1.933s)
[563.658199] Starting dynamic subtest: bcs0
[565.691237] Dynamic subtest bcs0: SUCCESS (2.044s)
[565.706586] Starting dynamic subtest: vcs0
[567.675787] Dynamic subtest vcs0: SUCCESS (1.982s)
[567.691884] Starting dynamic subtest: vcs1
[569.659426] Dynamic subtest vcs1: SUCCESS (1.981s)
[569.673239] Starting dynamic subtest: vecs0
[571.644022] Dynamic subtest vecs0: SUCCESS (1.982s)
[571.656144] Starting dynamic subtest: ccs0
[573.691637] Dynamic subtest ccs0: SUCCESS (2.045s)
[573.694977] Subtest gt-engine-hang: SUCCESS (11.983s)
[573.811195] [130/133] (450s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[573.922023] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[573.926557] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.029765] [131/133] (449s left) kms_plane_alpha_blend (constant-alpha-mid)
[574.123958] Starting subtest: constant-alpha-mid
[574.433462] Starting dynamic subtest: pipe-A-eDP-1
[575.352420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.916s)
[575.363287] Starting dynamic subtest: pipe-D-eDP-1
[576.818780] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.467s)
[576.821058] Subtest constant-alpha-mid: SUCCESS (2.698s)
[577.619018] [132/133] (446s left) gem_userptr_blits (probe)
[577.707005] Starting subtest: probe
[577.784707] Subtest probe: SUCCESS (0.080s)
[577.909105] [133/133] (446s left) device_reset (unbind-reset-rebind)
[577.959487] Starting subtest: unbind-reset-rebind
[581.374481] Subtest unbind-reset-rebind: SUCCESS (3.410s)
[581.411651] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: kms_chamelium_hpd
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_joiner
results: parsing output: 10/ for test: gem_tiled_blits
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_prime
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: gem_softpin
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: api_intel_bb
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: tools_test
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: kms_plane_cursor
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: prime_self_import
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: dumb_buffer
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: sriov_basic
results: parsing output: 42/ for test: gem_request_retire
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_pm_dc
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_dp_aux_dev
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_lease
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: gem_exec_alignment
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: intel_hwmon
results: parsing output: 58/ for test: gem_create
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_chamelium_color
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: i915_pm_rc6_residency
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: gem_exec_whisper
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_basic
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_universal_plane
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_eio
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_feature_discovery
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: gem_flink_basic
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_pread
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_busy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: sysfs_heartbeat_interval
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_render_copy_redux
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: sw_sync
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: gem_mmap_offset
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_chamelium_audio
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_plane_alpha_blend
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: device_reset
Done.