[60.277923] Initializing watchdogs
[60.277972]   /dev/watchdog0
[60.293371] [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]
[60.297945] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.300123] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.303602] [001/133] (960s left) kms_pm_rpm (fences)
[62.106141] Starting subtest: fences
[62.111243] Subtest fences: SKIP (0.000s)
[62.657035] [002/133] (958s left) i915_query (query-topology-coherent-slice-mask)
[62.714261] Starting subtest: query-topology-coherent-slice-mask
[62.718606] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[62.812166] [003/133] (958s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[62.900074] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[62.902437] Starting dynamic subtest: pipe-A-eDP-1
[62.928553] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.938804] Starting dynamic subtest: pipe-B-eDP-1
[62.962552] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.969165] Starting dynamic subtest: pipe-C-eDP-1
[62.992389] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.999325] Starting dynamic subtest: pipe-D-eDP-1
[63.024981] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.029381] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[65.194170] [004/133] (955s left) gem_exec_schedule (fairslice)
[65.272693] Starting subtest: fairslice
[65.274615] Starting dynamic subtest: rcs0
[67.292560] Dynamic subtest rcs0: SUCCESS (2.021s)
[67.304108] Starting dynamic subtest: bcs0
[69.316055] Dynamic subtest bcs0: SUCCESS (2.022s)
[69.325104] Starting dynamic subtest: vcs0
[71.336663] Dynamic subtest vcs0: SUCCESS (2.018s)
[71.345238] Starting dynamic subtest: vcs1
[73.358574] Dynamic subtest vcs1: SUCCESS (2.021s)
[73.368480] Starting dynamic subtest: vecs0
[75.377765] Dynamic subtest vecs0: SUCCESS (2.019s)
[75.387056] Starting dynamic subtest: ccs0
[77.396803] Dynamic subtest ccs0: SUCCESS (2.019s)
[77.398975] Subtest fairslice: SUCCESS (12.121s)
[77.688441] [005/133] (943s left) kms_cursor_edge_walk (256x256-right-edge)
[77.788570] Starting subtest: 256x256-right-edge
[77.790812] Starting dynamic subtest: pipe-A-eDP-1
[81.272212] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[81.281211] Starting dynamic subtest: pipe-D-eDP-1
[84.405139] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[84.407079] Subtest 256x256-right-edge: SUCCESS (6.615s)
[85.206689] [006/133] (935s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[85.312624] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[92.230091] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.920s)
[92.353827] [007/133] (928s left) gem_eio (in-flight-immediate)
[92.577804] Starting subtest: in-flight-immediate
[100.536785] Subtest in-flight-immediate: SUCCESS (7.959s)
[100.652805] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[100.655818] [008/133] (920s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[100.741038] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[100.743349] Starting dynamic subtest: pipe-A-eDP-1
[100.765411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.775765] Starting dynamic subtest: pipe-B-eDP-1
[100.796901] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.804579] Starting dynamic subtest: pipe-C-eDP-1
[100.824792] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.832489] Starting dynamic subtest: pipe-D-eDP-1
[100.853666] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.857708] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[103.026032] [009/133] (918s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[103.102376] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[103.167745] [010/133] (917s left) kms_rotation_crc (exhaust-fences)
[103.260482] Starting subtest: exhaust-fences
[103.264846] Subtest exhaust-fences: SKIP (0.000s)
[103.336536] [011/133] (917s left) gem_close (basic)
[103.399035] Starting subtest: basic
[103.401355] Subtest basic: SUCCESS (0.000s)
[103.518854] [012/133] (917s left) kms_chamelium_hpd (common-hpd-after-suspend)
[103.905751] Subtest common-hpd-after-suspend: SKIP (0.000s)
[104.742241] [013/133] (916s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[104.866841] Starting subtest: short-flip-before-cursor-toggle
[105.781837] Subtest short-flip-before-cursor-toggle: SUCCESS (0.914s)
[106.587827] [014/133] (914s left) core_setmaster_vs_auth
[106.770306] [015/133] (914s left) gem_pwrite (basic-random)
[106.838083] Subtest basic-random: SKIP (0.000s)
[106.907896] [016/133] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[107.001181] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[107.005230] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[107.098184] [017/133] (914s left) kms_pm_rpm (modeset-non-lpsp-stress)
[109.024382] Starting subtest: modeset-non-lpsp-stress
[110.171393] Subtest modeset-non-lpsp-stress: SKIP (1.147s)
[110.562467] [018/133] (910s left) kms_flip (2x-flip-vs-expired-vblank)
[110.655346] Starting subtest: 2x-flip-vs-expired-vblank
[110.669406] Subtest 2x-flip-vs-expired-vblank: SKIP (0.013s)
[110.752805] [019/133] (910s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[110.842748] Starting subtest: plane-lut1d-ctm3x4-lut1d
[110.990451] Starting dynamic subtest: pipe-A-plane-0
[111.167298] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[111.176753] Starting dynamic subtest: pipe-A-plane-1
[111.333981] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[111.347537] Starting dynamic subtest: pipe-A-plane-2
[111.499985] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[112.779987] Starting dynamic subtest: pipe-B-plane-0
[113.026998] Dynamic subtest pipe-B-plane-0: SUCCESS (0.254s)
[113.039860] Starting dynamic subtest: pipe-B-plane-1
[113.193359] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[113.202962] Starting dynamic subtest: pipe-B-plane-2
[113.384225] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[114.555160] Starting dynamic subtest: pipe-C-plane-0
[114.681257] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[114.690377] Starting dynamic subtest: pipe-C-plane-1
[114.825698] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[114.834844] Starting dynamic subtest: pipe-C-plane-2
[114.969666] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[116.183638] Starting dynamic subtest: pipe-D-plane-0
[116.344515] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[116.353621] Starting dynamic subtest: pipe-D-plane-1
[116.510939] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[116.520784] Starting dynamic subtest: pipe-D-plane-2
[116.655782] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[116.942056] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.098s)
[117.755887] [020/133] (903s left) gem_spin_batch (spin-all-new)
[117.821690] Starting subtest: spin-all-new
[117.839922] Subtest spin-all-new: SUCCESS (0.014s)
[118.976753] [021/133] (902s left) kms_psr (psr-primary-render)
[119.081907] Starting subtest: psr-primary-render
[119.084215] Starting dynamic subtest: eDP-1
[120.865468] Dynamic subtest eDP-1: SUCCESS (1.783s)
[120.867815] Subtest psr-primary-render: SUCCESS (1.784s)
[121.725410] [022/133] (899s left) kms_plane_cursor (overlay)
[121.820148] Starting subtest: overlay
[121.824410] Starting dynamic subtest: pipe-A-eDP-1-size-64
[124.403508] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.585s)
[124.461315] Starting dynamic subtest: pipe-A-eDP-1-size-128
[126.949552] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.494s)
[127.008944] Starting dynamic subtest: pipe-A-eDP-1-size-256
[129.562100] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s)
[129.909676] Starting dynamic subtest: pipe-B-eDP-1-size-64
[133.175489] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.277s)
[133.233619] Starting dynamic subtest: pipe-B-eDP-1-size-128
[135.854093] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.627s)
[135.914835] Starting dynamic subtest: pipe-B-eDP-1-size-256
[138.401030] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.494s)
[138.747692] Starting dynamic subtest: pipe-C-eDP-1-size-64
[141.617257] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.879s)
[141.654621] Starting dynamic subtest: pipe-C-eDP-1-size-128
[143.851638] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[143.889795] Starting dynamic subtest: pipe-C-eDP-1-size-256
[146.062284] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[146.397492] Starting dynamic subtest: pipe-D-eDP-1-size-64
[149.277357] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.897s)
[149.313801] Starting dynamic subtest: pipe-D-eDP-1-size-128
[151.500283] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[151.537697] Starting dynamic subtest: pipe-D-eDP-1-size-256
[153.678279] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.148s)
[153.998164] Subtest overlay: SUCCESS (32.175s)
[154.852592] [023/133] (866s left) gen9_exec_parse (batch-zero-length)
[154.905635] Subtest batch-zero-length: SKIP (0.000s)
[154.975514] [024/133] (866s left) gem_exec_balancer (parallel-contexts)
[155.230783] Starting subtest: parallel-contexts
[158.454893] Subtest parallel-contexts: SUCCESS (3.228s)
[159.078511] [025/133] (862s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[159.179546] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[159.183870] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[159.293207] [026/133] (862s left) gem_mmap_gtt (big-bo-tiledy)
[159.346297] Subtest big-bo-tiledY: SKIP (0.000s)
[159.403607] [027/133] (862s left) gem_wait (write-wait)
[159.473680] Starting subtest: write-wait
[159.476068] Starting dynamic subtest: all-engines
[160.572348] Dynamic subtest all-engines: SUCCESS (1.099s)
[160.589055] Starting dynamic subtest: rcs0
[161.635270] Dynamic subtest rcs0: SUCCESS (1.062s)
[161.651426] Starting dynamic subtest: bcs0
[162.694362] Dynamic subtest bcs0: SUCCESS (1.057s)
[162.711802] Starting dynamic subtest: vcs0
[163.750847] Dynamic subtest vcs0: SUCCESS (1.053s)
[163.767864] Starting dynamic subtest: vcs1
[164.805780] Dynamic subtest vcs1: SUCCESS (1.053s)
[164.821888] Starting dynamic subtest: vecs0
[165.860256] Dynamic subtest vecs0: SUCCESS (1.052s)
[165.877304] Starting dynamic subtest: ccs0
[166.919342] Dynamic subtest ccs0: SUCCESS (1.057s)
[166.922029] Subtest write-wait: SUCCESS (7.449s)
[167.119578] [028/133] (854s left) kms_psr (fbc-psr-sprite-plane-move)
[167.226875] Starting subtest: fbc-psr-sprite-plane-move
[167.229189] Starting dynamic subtest: eDP-1
[167.233471] Dynamic subtest eDP-1: SKIP (0.000s)
[167.237727] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[167.315333] [029/133] (854s left) sysfs_timeslice_duration (invalid)
[167.374592] Starting subtest: invalid
[167.376866] Starting dynamic subtest: vecs0
[167.379067] Dynamic subtest vecs0: SUCCESS (0.000s)
[167.388557] Starting dynamic subtest: ccs0
[167.390639] Dynamic subtest ccs0: SUCCESS (0.000s)
[167.398712] Starting dynamic subtest: vcs0
[167.400541] Dynamic subtest vcs0: SUCCESS (0.000s)
[167.408696] Starting dynamic subtest: bcs0
[167.410744] Dynamic subtest bcs0: SUCCESS (0.000s)
[167.418898] Starting dynamic subtest: rcs0
[167.421020] Dynamic subtest rcs0: SUCCESS (0.000s)
[167.428975] Starting dynamic subtest: vcs1
[167.431075] Dynamic subtest vcs1: SUCCESS (0.000s)
[167.433127] Subtest invalid: SUCCESS (0.006s)
[167.471162] [030/133] (854s left) kms_psr (pr-sprite-plane-onoff)
[167.579175] Starting subtest: pr-sprite-plane-onoff
[167.583166] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[167.672384] [031/133] (854s left) kms_cursor_crc (cursor-offscreen-256x256)
[167.908825] Starting subtest: cursor-offscreen-256x256
[167.913754] Starting dynamic subtest: pipe-A-eDP-1
[169.859048] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[169.889481] Starting dynamic subtest: pipe-D-eDP-1
[172.434992] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s)
[172.437386] Subtest cursor-offscreen-256x256: SUCCESS (4.526s)
[173.297319] [032/133] (848s left) gem_ctx_persistence (engines-hostile)
[173.350499] Starting subtest: engines-hostile
[173.352800] Starting dynamic subtest: rcs0
[173.397872] Dynamic subtest rcs0: SUCCESS (0.047s)
[173.408355] Starting dynamic subtest: bcs0
[173.513629] Dynamic subtest bcs0: SUCCESS (0.115s)
[173.524751] Starting dynamic subtest: vcs0
[173.604623] Dynamic subtest vcs0: SUCCESS (0.089s)
[173.615375] Starting dynamic subtest: vcs1
[173.693037] Dynamic subtest vcs1: SUCCESS (0.086s)
[173.704315] Starting dynamic subtest: vecs0
[173.783982] Dynamic subtest vecs0: SUCCESS (0.088s)
[173.794613] Starting dynamic subtest: ccs0
[173.882767] Dynamic subtest ccs0: SUCCESS (0.097s)
[173.885555] Subtest engines-hostile: SUCCESS (0.533s)
[173.960195] [033/133] (848s left) gem_exec_reloc (basic-gtt-read-active)
[174.021236] Subtest basic-gtt-read-active: SKIP (0.000s)
[174.091566] [034/133] (848s left) gem_workarounds (basic-read)
[174.159315] Starting subtest: basic-read
[174.172296] Subtest basic-read: SUCCESS (0.011s)
[174.306665] [035/133] (847s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[174.356186] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[174.358016] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[174.480598] [036/133] (847s left) i915_drm_fdinfo (context-close-stress)
[174.517523] Starting subtest: context-close-stress
[185.264679] Subtest context-close-stress: SUCCESS (10.744s)
[185.342741] [037/133] (836s left) gem_ctx_persistence (legacy-engines-hang)
[185.562252] Starting subtest: legacy-engines-hang
[185.564786] Starting dynamic subtest: render
[185.689677] Dynamic subtest render: SUCCESS (0.127s)
[185.703243] Starting dynamic subtest: bsd1
[185.783583] Dynamic subtest bsd1: SUCCESS (0.091s)
[185.799049] Starting dynamic subtest: bsd2
[185.875568] Dynamic subtest bsd2: SUCCESS (0.089s)
[185.886131] Starting dynamic subtest: blt
[185.950524] Dynamic subtest blt: SUCCESS (0.073s)
[185.959997] Starting dynamic subtest: vebox
[186.077747] Dynamic subtest vebox: SUCCESS (0.125s)
[186.080215] Subtest legacy-engines-hang: SUCCESS (0.517s)
[186.174675] [038/133] (836s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[186.281991] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[186.286089] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[186.352064] [039/133] (836s left) syncobj_wait (wait-delayed-signal)
[186.407987] Starting subtest: wait-delayed-signal
[186.510664] Subtest wait-delayed-signal: SUCCESS (0.102s)
[186.602536] [040/133] (835s left) gem_exec_schedule (noreorder)
[186.782657] Starting subtest: noreorder
[186.785075] Starting dynamic subtest: rcs0
[186.842841] Dynamic subtest rcs0: SUCCESS (0.060s)
[186.853659] Starting dynamic subtest: vcs0
[188.886775] Dynamic subtest vcs0: SUCCESS (2.041s)
[188.898883] Starting dynamic subtest: vcs1
[190.927135] Dynamic subtest vcs1: SUCCESS (2.037s)
[190.938438] Starting dynamic subtest: vecs0
[192.914827] Dynamic subtest vecs0: SUCCESS (1.985s)
[192.926633] Starting dynamic subtest: ccs0
[192.994994] Dynamic subtest ccs0: SUCCESS (0.079s)
[192.997864] Subtest noreorder: SUCCESS (6.214s)
[193.181937] [041/133] (829s left) gem_exec_schedule (preempt-self)
[193.269206] Starting subtest: preempt-self
[193.271481] Starting dynamic subtest: rcs0
[193.300957] Dynamic subtest rcs0: SUCCESS (0.032s)
[193.314409] Starting dynamic subtest: bcs0
[193.328986] Dynamic subtest bcs0: SUCCESS (0.027s)
[193.342711] Starting dynamic subtest: vcs0
[193.362535] Dynamic subtest vcs0: SUCCESS (0.033s)
[193.375286] Starting dynamic subtest: vcs1
[193.393916] Dynamic subtest vcs1: SUCCESS (0.031s)
[193.403226] Starting dynamic subtest: vecs0
[193.437761] Dynamic subtest vecs0: SUCCESS (0.042s)
[193.451755] Starting dynamic subtest: ccs0
[193.470874] Dynamic subtest ccs0: SUCCESS (0.032s)
[193.473313] Subtest preempt-self: SUCCESS (0.203s)
[194.987505] [042/133] (827s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[195.085901] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[195.088213] Starting dynamic subtest: pipe-A-default-mode
[196.263731] Dynamic subtest pipe-A-default-mode: SKIP (1.175s)
[196.268207] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.177s)
[196.419551] [043/133] (826s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[196.523034] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[197.380834] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.859s)
[197.558529] [044/133] (825s left) api_intel_bb (delta-check)
[197.605071] Starting subtest: delta-check
[197.608946] Subtest delta-check: SUCCESS (0.006s)
[197.718902] [045/133] (824s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[197.770537] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[197.772787] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[197.862306] [046/133] (824s left) kms_dp_aux_dev (basic)
[197.918626] Starting subtest: basic
[198.139479] Subtest basic: SUCCESS (0.221s)
[198.211992] [047/133] (824s left) kms_psr (fbc-psr2-primary-blt)
[198.307942] Starting subtest: fbc-psr2-primary-blt
[198.310302] Starting dynamic subtest: eDP-1
[198.314295] Dynamic subtest eDP-1: SKIP (0.000s)
[198.318495] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[198.383251] [048/133] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[198.474288] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[198.478626] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.568379] [049/133] (824s left) gem_render_copy (yf-tiled)
[198.632570] Starting subtest: yf-tiled
[198.637611] Subtest yf-tiled: SKIP (0.000s)
[198.819663] [050/133] (824s left) kms_content_protection (dp-mst-type-0)
[198.972246] Starting subtest: dp-mst-type-0
[198.976513] Subtest dp-mst-type-0: SKIP (0.000s)
[199.084317] [051/133] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[199.174418] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[199.178751] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[199.268908] [052/133] (823s left) kms_hdr (bpc-switch-dpms)
[199.358720] Starting subtest: bpc-switch-dpms
[200.407814] Starting dynamic subtest: pipe-A-eDP-1
[204.851828] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.447s)
[204.854138] Subtest bpc-switch-dpms: SUCCESS (5.494s)
[204.966468] [053/133] (818s left) gem_request_retire (retire-vma-not-inactive)
[205.024704] Starting subtest: retire-vma-not-inactive
[205.082590] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[205.192623] [054/133] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[205.290085] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[205.294309] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[205.387727] [055/133] (817s left) gem_mmap_gtt (basic-write-gtt)
[205.442932] Subtest basic-write-gtt: SKIP (0.000s)
[205.499599] [056/133] (817s left) kms_lease (lease-unleased-connector)
[205.589826] Starting subtest: lease-unleased-connector
[205.592121] Starting dynamic subtest: pipe-A-eDP-1
[205.594551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[205.607023] Starting dynamic subtest: pipe-B-eDP-1
[205.609168] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[205.618615] Starting dynamic subtest: pipe-C-eDP-1
[205.620735] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[205.628736] Starting dynamic subtest: pipe-D-eDP-1
[205.630597] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[205.632434] Subtest lease-unleased-connector: SUCCESS (0.031s)
[205.727158] [057/133] (817s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[205.788499] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[205.897033] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.109s)
[205.975877] [058/133] (817s left) kms_flip (blocking-wf_vblank)
[206.082368] Starting subtest: blocking-wf_vblank
[206.084605] Starting dynamic subtest: A-eDP1
[214.963320] Dynamic subtest A-eDP1: SUCCESS (8.881s)
[214.972069] Starting dynamic subtest: B-eDP1
[223.900649] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[223.912209] Starting dynamic subtest: C-eDP1
[232.820419] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[232.833556] Starting dynamic subtest: D-eDP1
[241.753480] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[241.755925] Subtest blocking-wf_vblank: SUCCESS (35.674s)
[242.966960] [059/133] (780s left) gem_exec_store (cachelines)
[243.037869] Starting subtest: cachelines
[243.040236] Starting dynamic subtest: rcs0
[243.110280] Dynamic subtest rcs0: SUCCESS (0.073s)
[243.119221] Starting dynamic subtest: bcs0
[243.160398] Dynamic subtest bcs0: SUCCESS (0.049s)
[243.169268] Starting dynamic subtest: vcs0
[243.215645] Dynamic subtest vcs0: SUCCESS (0.053s)
[243.224170] Starting dynamic subtest: vcs1
[243.272577] Dynamic subtest vcs1: SUCCESS (0.055s)
[243.281369] Starting dynamic subtest: vecs0
[243.322257] Dynamic subtest vecs0: SUCCESS (0.048s)
[243.330815] Starting dynamic subtest: ccs0
[243.371285] Dynamic subtest ccs0: SUCCESS (0.048s)
[243.373606] Subtest cachelines: SUCCESS (0.336s)
[243.555270] [060/133] (779s left) perf (invalid-oa-metric-set-id)
[243.687433] Starting subtest: invalid-oa-metric-set-id
[243.699669] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[243.740430] [061/133] (779s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[243.844750] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[243.848857] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[243.913824] [062/133] (779s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[244.010064] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[244.383409] Starting dynamic subtest: pipe-A-eDP-1
[247.143175] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.759s)
[247.511184] Starting dynamic subtest: pipe-B-eDP-1
[250.281118] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[250.629891] Starting dynamic subtest: pipe-C-eDP-1
[253.389101] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[253.756203] Starting dynamic subtest: pipe-D-eDP-1
[256.518152] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[256.520634] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.510s)
[257.709533] [063/133] (765s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[257.817412] Starting subtest: 4-tiled-64bpp-rotate-0
[259.385844] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.569s)
[259.553448] [064/133] (763s left) prime_busy (before-wait)
[259.606067] Starting subtest: before-wait
[259.610927] Starting dynamic subtest: rcs0
[259.640610] Dynamic subtest rcs0: SUCCESS (0.031s)
[259.650803] Starting dynamic subtest: bcs0
[259.694075] Dynamic subtest bcs0: SUCCESS (0.053s)
[259.703784] Starting dynamic subtest: vcs0
[259.733373] Dynamic subtest vcs0: SUCCESS (0.039s)
[259.741096] Starting dynamic subtest: vcs1
[259.773071] Dynamic subtest vcs1: SUCCESS (0.039s)
[259.783084] Starting dynamic subtest: vecs0
[259.813449] Dynamic subtest vecs0: SUCCESS (0.040s)
[259.822203] Starting dynamic subtest: ccs0
[259.854503] Dynamic subtest ccs0: SUCCESS (0.040s)
[259.963482] Subtest before-wait: SUCCESS (0.355s)
[260.041404] [065/133] (763s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[260.146068] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[260.148444] Starting dynamic subtest: pipe-A-eDP-1
[265.973192] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.833s)
[265.985301] Starting dynamic subtest: pipe-B-eDP-1
[272.624537] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.649s)
[272.627063] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.485s)
[273.509032] [066/133] (750s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[273.596803] Starting subtest: plane-primary-overlay-mutable-zpos
[277.045061] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.445s)
[278.221395] [067/133] (745s left) kms_draw_crc (draw-method-mmap-wc)
[278.324129] Starting subtest: draw-method-mmap-wc
[278.326073] Starting dynamic subtest: xrgb8888-untiled
[278.555992] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[278.565274] Starting dynamic subtest: rgb565-untiled
[278.766990] Dynamic subtest rgb565-untiled: SUCCESS (0.209s)
[278.777915] Starting dynamic subtest: xrgb2101010-untiled
[278.989233] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[278.999051] Starting dynamic subtest: xbgr16161616f-untiled
[279.199870] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[279.208301] Starting dynamic subtest: xrgb8888-xtiled
[279.333075] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[279.341818] Starting dynamic subtest: rgb565-xtiled
[279.455410] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[279.463986] Starting dynamic subtest: xrgb2101010-xtiled
[279.566950] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[279.577467] Starting dynamic subtest: xbgr16161616f-xtiled
[279.677668] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[279.685963] Starting dynamic subtest: xrgb8888-4tiled
[279.821990] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[279.830078] Starting dynamic subtest: rgb565-4tiled
[279.955451] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[279.965823] Starting dynamic subtest: xrgb2101010-4tiled
[280.111156] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.153s)
[280.121638] Starting dynamic subtest: xbgr16161616f-4tiled
[280.300085] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.186s)
[280.301879] Subtest draw-method-mmap-wc: SUCCESS (1.979s)
[280.391835] [068/133] (743s left) perf (blocking-parameterized)
[280.495456] Starting subtest: blocking-parameterized
[300.514298] Subtest blocking-parameterized: SUCCESS (20.016s)
[300.562495] [069/133] (723s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[300.658487] Starting subtest: psr-2p-pri-indfb-multidraw
[300.662524] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[300.768857] [070/133] (722s left) prime_vgem (fence-write-hang)
[300.840774] Subtest fence-write-hang: SKIP (0.000s)
[300.944438] [071/133] (722s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[301.058264] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[301.860667] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.804s)
[302.032922] [072/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[302.129132] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[302.133076] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[302.228703] [073/133] (721s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[302.336454] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[306.779698] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.447s)
[307.926691] [074/133] (715s left) kms_plane (plane-position-covered)
[308.043739] Starting subtest: plane-position-covered
[308.579275] Starting dynamic subtest: pipe-A-plane-1
[309.915270] Dynamic subtest pipe-A-plane-1: SUCCESS (1.335s)
[309.925872] Starting dynamic subtest: pipe-A-plane-2
[311.234544] Dynamic subtest pipe-A-plane-2: SUCCESS (1.320s)
[311.244187] Starting dynamic subtest: pipe-A-plane-3
[312.560068] Dynamic subtest pipe-A-plane-3: SUCCESS (1.323s)
[312.569903] Starting dynamic subtest: pipe-A-plane-4
[313.869548] Dynamic subtest pipe-A-plane-4: SUCCESS (1.311s)
[313.879392] Starting dynamic subtest: pipe-A-plane-5
[313.895396] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[315.130763] Starting dynamic subtest: pipe-B-plane-1
[316.459553] Dynamic subtest pipe-B-plane-1: SUCCESS (1.336s)
[316.469077] Starting dynamic subtest: pipe-B-plane-2
[317.765022] Dynamic subtest pipe-B-plane-2: SUCCESS (1.306s)
[317.774963] Starting dynamic subtest: pipe-B-plane-3
[319.077423] Dynamic subtest pipe-B-plane-3: SUCCESS (1.311s)
[319.086732] Starting dynamic subtest: pipe-B-plane-4
[320.324652] Dynamic subtest pipe-B-plane-4: SUCCESS (1.247s)
[320.333810] Starting dynamic subtest: pipe-B-plane-5
[320.349258] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[320.351342] Subtest plane-position-covered: SUCCESS (12.306s)
[321.209478] [075/133] (702s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[321.442891] Starting subtest: cursor-rapid-movement-128x128
[321.447936] Starting dynamic subtest: pipe-A-eDP-1
[321.976104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[322.006389] Starting dynamic subtest: pipe-D-eDP-1
[323.236947] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[323.239393] Subtest cursor-rapid-movement-128x128: SUCCESS (1.794s)
[324.068549] [076/133] (699s left) gem_ctx_param (invalid-param-get)
[324.124017] Starting subtest: invalid-param-get
[324.126460] Subtest invalid-param-get: SUCCESS (0.001s)
[324.213720] [077/133] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[324.307134] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[324.311640] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[324.417915] [078/133] (699s left) kms_flip (2x-flip-vs-dpms-on-nop)
[324.516425] Starting subtest: 2x-flip-vs-dpms-on-nop
[324.524529] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[324.607883] [079/133] (699s left) gem_ppgtt (blt-vs-render-ctxn)
[324.659597] Starting subtest: blt-vs-render-ctxN
[357.592627] Subtest blt-vs-render-ctxN: SUCCESS (32.929s)
[357.704786] [080/133] (666s left) perf (oa-exponents)
[357.861548] Starting subtest: oa-exponents
[357.864181] Starting dynamic subtest: 0-rcs0
[359.657409] Dynamic subtest 0-rcs0: SUCCESS (1.794s)
[359.668243] Starting dynamic subtest: 1-vecs0
[361.486406] Dynamic subtest 1-vecs0: SUCCESS (1.828s)
[361.488907] Subtest oa-exponents: SUCCESS (3.624s)
[361.542338] [081/133] (662s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[361.658305] Starting subtest: pr-cursor-plane-move-continuous-sf
[361.662466] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[361.728538] [082/133] (662s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[361.827379] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[361.831362] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[361.924890] [083/133] (662s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[362.042223] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[379.747695] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.706s)
[380.551592] [084/133] (643s left) gem_close_race (multigpu-basic-process)
[380.622209] Starting subtest: multigpu-basic-process
[380.626746] Subtest multigpu-basic-process: SKIP (0.000s)
[380.852827] [085/133] (643s left) perf_pmu (pmu-read)
[380.896043] Starting subtest: pmu-read
[380.898205] Subtest pmu-read: SUCCESS (0.003s)
[380.999287] [086/133] (643s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[381.062660] Starting subtest: invalid-multi-wait-unsubmitted
[381.064640] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[381.185473] [087/133] (643s left) gem_exec_fence (syncobj-import)
[381.626195] Starting subtest: syncobj-import
[381.632038] Subtest syncobj-import: SUCCESS (0.005s)
[383.014643] [088/133] (641s left) gem_mmap_offset (mmap-unmap)
[383.070532] Starting subtest: mmap-unmap
[383.072548] Starting dynamic subtest: smem0
[406.470231] Dynamic subtest smem0: SUCCESS (23.400s)
[406.473176] Subtest mmap-unmap: SUCCESS (23.401s)
[406.599804] [089/133] (617s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[406.706070] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[406.710453] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[406.804903] [090/133] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[406.894984] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[414.595647] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.703s)
[414.720507] [091/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[414.824506] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[419.704877] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.883s)
[420.836711] [092/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[420.934583] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[420.938686] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[421.055877] [093/133] (603s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[421.146120] Starting subtest: bad-pixel-format-y-tiled-ccs
[421.148394] Starting dynamic subtest: pipe-A-eDP-1
[421.170698] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[421.182071] Starting dynamic subtest: pipe-B-eDP-1
[421.203589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[421.212614] Starting dynamic subtest: pipe-C-eDP-1
[421.233627] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[421.242440] Starting dynamic subtest: pipe-D-eDP-1
[421.264351] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[421.268393] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[423.393300] [094/133] (601s left) gem_exec_flush (basic-uc-rw-default)
[423.454536] Starting subtest: basic-uc-rw-default
[428.927333] Subtest basic-uc-rw-default: SUCCESS (5.473s)
[429.121141] [095/133] (595s left) drm_read (short-buffer-block)
[429.286965] Starting subtest: short-buffer-block
[429.289412] Subtest short-buffer-block: SUCCESS (0.000s)
[429.409436] [096/133] (595s left) syncobj_timeline (wait-all-for-submit-snapshot)
[429.467966] Starting subtest: wait-all-for-submit-snapshot
[429.550266] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[429.641805] [097/133] (595s left) kms_getfb (getfb-handle-not-fb)
[429.738763] Starting subtest: getfb-handle-not-fb
[429.741096] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[429.848422] [098/133] (595s left) i915_pm_rps (basic-api)
[429.915633] Starting subtest: basic-api
[429.919649] Subtest basic-api: SKIP (0.001s)
[430.012976] [099/133] (594s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[430.096085] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[430.098156] Starting dynamic subtest: pipe-A-eDP-1
[430.623790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[430.634319] Starting dynamic subtest: pipe-B-eDP-1
[432.008419] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[432.018239] Starting dynamic subtest: pipe-C-eDP-1
[433.418501] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[433.432984] Starting dynamic subtest: pipe-D-eDP-1
[434.753829] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[434.756132] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.632s)
[435.925105] [100/133] (589s left) sw_sync (sync_random_merge)
[435.963158] Starting subtest: sync_random_merge
[436.008843] Subtest sync_random_merge: SUCCESS (0.046s)
[436.072509] [101/133] (588s left) gem_userptr_blits (map-fixed-invalidate-busy)
[436.143298] Starting subtest: map-fixed-invalidate-busy
[436.147394] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[436.260521] [102/133] (588s left) kms_sequence (queue-idle)
[436.359944] Starting subtest: queue-idle
[436.362286] Starting dynamic subtest: pipe-A-eDP-1
[438.160696] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.801s)
[438.171099] Starting dynamic subtest: pipe-B-eDP-1
[440.714393] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.553s)
[440.724818] Starting dynamic subtest: pipe-C-eDP-1
[443.220408] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.504s)
[443.231793] Starting dynamic subtest: pipe-D-eDP-1
[445.646307] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[445.648597] Subtest queue-idle: SUCCESS (9.286s)
[446.462802] [103/133] (578s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[446.557743] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[446.562748] Starting dynamic subtest: pipe-A-eDP-1
[446.582884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[446.592377] Starting dynamic subtest: pipe-B-eDP-1
[446.612040] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[446.621189] Starting dynamic subtest: pipe-C-eDP-1
[446.641395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[446.652767] Starting dynamic subtest: pipe-D-eDP-1
[446.673039] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[446.675306] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[448.917108] [104/133] (576s left) kms_getfb (getfb-handle-closed)
[449.016801] Starting subtest: getfb-handle-closed
[449.019051] Subtest getfb-handle-closed: SUCCESS (0.000s)
[449.116909] [105/133] (576s left) gem_caching (read-writes)
[449.168579] Subtest read-writes: SKIP (0.000s)
[449.236858] [106/133] (575s left) gem_mmap_gtt (basic-small-copy-xy)
[449.287505] Subtest basic-small-copy-XY: SKIP (0.000s)
[449.344807] [107/133] (575s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[449.441628] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[454.026828] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.588s)
[455.165483] [108/133] (570s left) kms_joiner (invalid-modeset-force-big-joiner)
[455.263620] Starting subtest: invalid-modeset-force-big-joiner
[455.267765] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[455.347998] [109/133] (569s left) gem_eio (suspend)
[455.584971] Starting subtest: suspend
[468.709209] Subtest suspend: SUCCESS (13.125s)
[479.878715] [110/133] (556s left) gem_fence_thrash (bo-write-verify-threaded-x)
[479.935558] Starting subtest: bo-write-verify-threaded-x
[479.951201] Subtest bo-write-verify-threaded-x: SKIP (0.015s)
[480.016832] [111/133] (556s left) i915_pm_rps (thresholds)
[480.081170] Starting subtest: thresholds
[480.085832] Subtest thresholds: SKIP (0.001s)
[480.198329] [112/133] (556s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[480.311818] Starting subtest: yf-tiled-64bpp-rotate-0
[480.316320] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[480.408339] [113/133] (556s left) kms_vblank (wait-forked-busy)
[480.509342] Starting subtest: wait-forked-busy
[480.511629] Starting dynamic subtest: pipe-A-eDP-1
[482.404089] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.893s)
[482.419456] Starting dynamic subtest: pipe-D-eDP-1
[484.930544] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[484.933231] Subtest wait-forked-busy: SUCCESS (4.422s)
[485.736396] [114/133] (550s left) gem_exec_balancer (nop)
[485.794676] Starting subtest: nop
[532.546266] Subtest nop: SUCCESS (46.748s)
[532.890062] [115/133] (503s left) i915_pm_freq_api (freq-basic-api)
[532.953778] Starting subtest: freq-basic-api
[532.956225] Starting dynamic subtest: gt0
[532.962034] Dynamic subtest gt0: SUCCESS (0.008s)
[532.973608] Starting dynamic subtest: gt1
[532.975753] Dynamic subtest gt1: SUCCESS (0.004s)
[532.977983] Subtest freq-basic-api: SUCCESS (0.013s)
[533.085100] [116/133] (503s left) gem_basic (multigpu-create-close)
[533.146302] Starting subtest: multigpu-create-close
[533.150703] Subtest multigpu-create-close: SKIP (0.000s)
[533.249793] [117/133] (503s left) kms_psr (psr2-cursor-render)
[533.356829] Starting subtest: psr2-cursor-render
[533.358999] Starting dynamic subtest: eDP-1
[535.135374] Dynamic subtest eDP-1: SUCCESS (1.777s)
[535.137733] Subtest psr2-cursor-render: SUCCESS (1.778s)
[535.937892] [118/133] (500s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[536.029713] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[536.033753] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[536.128480] [119/133] (500s left) kms_chamelium_frames (hdmi-crc-multiple)
[536.515115] Subtest hdmi-crc-multiple: SKIP (0.000s)
[537.348078] [120/133] (499s left) gem_ctx_shared (q-in-order)
[537.406040] Starting subtest: Q-in-order
[537.408385] Starting dynamic subtest: rcs0
[537.519058] Dynamic subtest rcs0: SUCCESS (0.111s)
[537.536967] Starting dynamic subtest: vcs0
[537.599486] Dynamic subtest vcs0: SUCCESS (0.081s)
[537.617277] Starting dynamic subtest: vcs1
[537.677984] Dynamic subtest vcs1: SUCCESS (0.078s)
[537.693973] Starting dynamic subtest: vecs0
[537.758591] Dynamic subtest vecs0: SUCCESS (0.080s)
[537.776266] Starting dynamic subtest: ccs0
[537.855303] Dynamic subtest ccs0: SUCCESS (0.094s)
[537.857631] Subtest Q-in-order: SUCCESS (0.449s)
[538.988554] [121/133] (497s left) drm_buddy (drm_buddy)
[539.029833] Starting subtest: drm_buddy
[539.034578] Subtest drm_buddy: SKIP (0.001s)
[539.083559] [122/133] (497s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[539.189741] Starting subtest: stress-xrgb8888-4tiled
[545.093302] Subtest stress-xrgb8888-4tiled: SUCCESS (5.903s)
[545.149105] [123/133] (491s left) kms_frontbuffer_tracking (psr-suspend)
[545.254108] Starting subtest: psr-suspend
[584.427269] Subtest psr-suspend: SUCCESS (8.812s)
[596.587474] [124/133] (452s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[596.685643] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[596.689744] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[596.793248] [125/133] (452s left) gem_fence_thrash (bo-write-verify-none)
[596.830330] Starting subtest: bo-write-verify-none
[596.858701] Subtest bo-write-verify-none: SKIP (0.027s)
[596.918048] [126/133] (452s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[597.027263] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[597.031639] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[597.118737] [127/133] (452s left) perf (disabled-read-error)
[597.192427] Starting subtest: disabled-read-error
[597.208909] Subtest disabled-read-error: SUCCESS (0.016s)
[597.258957] [128/133] (451s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[597.360304] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[597.364687] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[597.458046] [129/133] (451s left) gem_huc_copy (huc-copy)
[597.515866] Starting subtest: huc-copy
[597.518247] Subtest huc-copy: SUCCESS (0.004s)
[597.634798] [130/133] (451s left) gem_userptr_blits (relocations)
[597.692635] Starting subtest: relocations
[597.696281] Subtest relocations: SKIP (0.001s)
[597.841800] [131/133] (451s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[597.937467] Starting subtest: plane-upscale-20x20-with-pixel-format
[597.939525] Starting dynamic subtest: pipe-A
[598.998007] Dynamic subtest pipe-A: SUCCESS (1.049s)
[599.008137] Starting dynamic subtest: pipe-B
[601.174477] Dynamic subtest pipe-B: SUCCESS (2.155s)
[601.184646] Starting dynamic subtest: pipe-C
[602.376404] Dynamic subtest pipe-C: SUCCESS (1.191s)
[602.387708] Starting dynamic subtest: pipe-D
[603.611189] Dynamic subtest pipe-D: SUCCESS (1.225s)
[603.613802] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.625s)
[604.824942] [132/133] (444s left) gem_render_copy (y-tiled-to-vebox-linear)
[604.910645] Starting subtest: y-tiled-to-vebox-linear
[604.915617] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[605.094549] [133/133] (444s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[605.149625] Starting subtest: single-wait-for-submit-unsubmitted
[605.250360] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[605.341420] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_cursor_edge_walk
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: gem_close
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: core_setmaster_vs_auth
results: parsing output: 14/ for test: gem_pwrite
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_color_pipeline
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_plane_cursor
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: sysfs_timeslice_duration
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_workarounds
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_dp_aux_dev
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_hdr
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_exec_store
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_atomic
results: parsing output: 66/ for test: kms_draw_crc
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: gem_ppgtt
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: gem_close_race
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_flush
results: parsing output: 94/ for test: drm_read
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: i915_pm_rps
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_sequence
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_caching
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_joiner
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: gem_fence_thrash
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: i915_pm_freq_api
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: drm_buddy
results: parsing output: 121/ for test: kms_pipe_stress
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_fence_thrash
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_huc_copy
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: syncobj_wait
Done.