[60.798768] Initializing watchdogs
[60.798816]   /dev/watchdog0
[60.817758] [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.822050] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.824329] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.827779] [001/133] (960s left) kms_psr (psr2-primary-blt)
[60.960525] Starting subtest: psr2-primary-blt
[60.962607] Starting dynamic subtest: eDP-1
[62.660642] Dynamic subtest eDP-1: SUCCESS (1.701s)
[62.663239] Subtest psr2-primary-blt: SUCCESS (1.701s)
[63.516931] [002/133] (957s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[63.642185] Starting subtest: 2x-cursor-vs-flip-legacy
[63.646854] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[63.786353] [003/133] (957s left) syncobj_wait (multi-wait-submitted-signaled)
[63.833669] Starting subtest: multi-wait-submitted-signaled
[63.836183] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[63.925150] [004/133] (957s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[64.026181] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[64.030153] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[64.119106] [005/133] (957s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[64.205315] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[64.209788] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[64.284607] [006/133] (957s left) gem_exec_whisper (basic-contexts-forked-all)
[64.355495] Starting subtest: basic-contexts-forked-all
[84.773032] Subtest basic-contexts-forked-all: SUCCESS (20.418s)
[84.951578] [007/133] (936s left) gem_eio (wait-wedge-10ms)
[85.180057] Starting subtest: wait-wedge-10ms
[87.019095] Subtest wait-wedge-10ms: SUCCESS (1.840s)
[87.166515] [008/133] (934s left) gem_exec_alignment (many)
[87.243397] Starting subtest: many
[110.687280] Subtest many: SUCCESS (23.397s)
[113.809351] [009/133] (907s left) gem_userptr_blits (huge-split)
[113.920958] Starting subtest: huge-split
[113.933542] Subtest huge-split: SUCCESS (0.012s)
[114.042391] [010/133] (907s left) gem_exec_gttfill (all-engines)
[114.109751] Starting subtest: all-engines
[137.951823] Subtest all-engines: SUCCESS (23.841s)
[138.139556] [011/133] (883s left) gem_exec_schedule (lateslice)
[138.265030] Starting subtest: lateslice
[138.267408] Starting dynamic subtest: rcs0
[138.287790] Dynamic subtest rcs0: SUCCESS (0.030s)
[138.298684] Starting dynamic subtest: bcs0
[138.311697] Dynamic subtest bcs0: SUCCESS (0.023s)
[138.319588] Starting dynamic subtest: vcs0
[138.334026] Dynamic subtest vcs0: SUCCESS (0.022s)
[138.342512] Starting dynamic subtest: vcs1
[138.358453] Dynamic subtest vcs1: SUCCESS (0.024s)
[138.366538] Starting dynamic subtest: vecs0
[138.382570] Dynamic subtest vecs0: SUCCESS (0.024s)
[138.390745] Starting dynamic subtest: ccs0
[138.412928] Dynamic subtest ccs0: SUCCESS (0.030s)
[138.415227] Subtest lateslice: SUCCESS (0.156s)
[140.000010] [012/133] (881s left) gem_tiling_max_stride
[140.122779] [013/133] (881s left) kms_psr (psr-dpms)
[140.222497] Starting subtest: psr-dpms
[140.224885] Starting dynamic subtest: eDP-1
[143.240726] Dynamic subtest eDP-1: SUCCESS (3.019s)
[143.243062] Subtest psr-dpms: SUCCESS (3.020s)
[144.103520] [014/133] (877s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[144.206963] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[145.320780] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.115s)
[145.470399] [015/133] (876s left) gen9_exec_parse (basic-rejected-ctx-param)
[145.535645] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[145.612979] [016/133] (876s left) gem_ctx_persistence (legacy-engines-cleanup)
[145.674462] Starting subtest: legacy-engines-cleanup
[145.676405] Starting dynamic subtest: render
[145.756134] Dynamic subtest render: SUCCESS (0.081s)
[145.766458] Starting dynamic subtest: bsd1
[145.790310] Dynamic subtest bsd1: SUCCESS (0.032s)
[145.799096] Starting dynamic subtest: bsd2
[145.840293] Dynamic subtest bsd2: SUCCESS (0.049s)
[145.850973] Starting dynamic subtest: blt
[145.885406] Dynamic subtest blt: SUCCESS (0.044s)
[145.895610] Starting dynamic subtest: vebox
[145.920227] Dynamic subtest vebox: SUCCESS (0.034s)
[145.922288] Subtest legacy-engines-cleanup: SUCCESS (0.246s)
[145.995237] [017/133] (875s left) kms_getfb (getfb2-handle-protection)
[146.093973] Starting subtest: getfb2-handle-protection
[146.117518] Subtest getfb2-handle-protection: SUCCESS (0.025s)
[146.235113] [018/133] (875s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[146.334455] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[146.336444] Starting dynamic subtest: pipe-A
[146.356308] Dynamic subtest pipe-A: SKIP (0.017s)
[146.365614] Starting dynamic subtest: pipe-B
[146.385660] Dynamic subtest pipe-B: SKIP (0.033s)
[146.394057] Starting dynamic subtest: pipe-C
[146.423658] Dynamic subtest pipe-C: SKIP (0.037s)
[146.431667] Starting dynamic subtest: pipe-D
[146.459807] Dynamic subtest pipe-D: SKIP (0.035s)
[146.463256] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.124s)
[146.556904] [019/133] (875s left) syncobj_wait (single-wait-for-submit-submitted)
[146.627460] Starting subtest: single-wait-for-submit-submitted
[146.738139] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[146.810120] [020/133] (875s left) syncobj_wait (wait-any-interrupted)
[146.862586] Starting subtest: wait-any-interrupted
[146.965299] Subtest wait-any-interrupted: SUCCESS (0.102s)
[147.042700] [021/133] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[147.141397] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[154.393665] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.254s)
[154.518955] [022/133] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[154.623522] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[154.627917] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[154.725428] [023/133] (867s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[154.829632] Starting subtest: yf-tiled-32bpp-rotate-0
[154.833816] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[154.924637] [024/133] (867s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[154.987971] Starting subtest: etime-multi-wait-for-submit-submitted
[155.098181] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.109s)
[155.171319] [025/133] (867s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[155.267077] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[159.430711] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.168s)
[160.614608] [026/133] (861s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[160.698158] Starting subtest: fbc-psr-cursor-mmap-cpu
[160.700489] Starting dynamic subtest: eDP-1
[160.704755] Dynamic subtest eDP-1: SKIP (0.000s)
[160.709263] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[160.767625] [027/133] (861s left) prime_vgem (coherency-blt)
[160.919470] Starting subtest: coherency-blt
[162.043452] Subtest coherency-blt: SUCCESS (1.122s)
[162.155238] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[162.158339] [028/133] (860s left) perf_pmu (frequency)
[162.197224] Starting subtest: frequency
[162.199502] Starting dynamic subtest: gt0
[164.369631] Dynamic subtest gt0: SUCCESS (2.165s)
[164.381049] Starting dynamic subtest: idle-gt0
[164.875516] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[164.886865] Starting dynamic subtest: gt1
[169.919831] Dynamic subtest gt1: SUCCESS (5.041s)
[169.929636] Starting dynamic subtest: idle-gt1
[170.445072] Dynamic subtest idle-gt1: SUCCESS (0.526s)
[170.447490] Subtest frequency: SUCCESS (8.250s)
[170.546098] [029/133] (851s left) kms_cursor_legacy (single-bo)
[170.658996] Starting subtest: single-bo
[170.661158] Starting dynamic subtest: pipe-A
[176.094554] Dynamic subtest pipe-A: SUCCESS (5.380s)
[176.105630] Starting dynamic subtest: pipe-B
[181.423731] Dynamic subtest pipe-B: SUCCESS (5.380s)
[181.434168] Starting dynamic subtest: pipe-C
[186.858718] Dynamic subtest pipe-C: SUCCESS (5.381s)
[186.869813] Starting dynamic subtest: pipe-D
[192.238076] Dynamic subtest pipe-D: SUCCESS (5.380s)
[192.249558] Starting dynamic subtest: all-pipes
[197.575404] Dynamic subtest all-pipes: SUCCESS (5.388s)
[197.577576] Subtest single-bo: SUCCESS (26.914s)
[197.727610] [030/133] (824s left) kms_flip (2x-absolute-wf_vblank)
[197.825177] Starting subtest: 2x-absolute-wf_vblank
[197.833957] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[197.923579] [031/133] (824s left) kms_prop_blob (invalid-get-prop-any)
[197.985822] Starting subtest: invalid-get-prop-any
[197.988087] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[198.079965] [032/133] (824s left) kms_invalid_mode (zero-vdisplay)
[198.182716] Starting subtest: zero-vdisplay
[198.185262] Starting dynamic subtest: pipe-A-eDP-1
[198.469970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[198.479131] Starting dynamic subtest: pipe-B-eDP-1
[198.481599] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[198.489632] Starting dynamic subtest: pipe-C-eDP-1
[198.491983] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[198.499899] Starting dynamic subtest: pipe-D-eDP-1
[198.502105] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[198.504236] Subtest zero-vdisplay: SUCCESS (0.291s)
[199.332815] [033/133] (823s left) gem_render_copy (linear)
[199.393950] Starting subtest: linear
[199.396343] Starting dynamic subtest: smem
[199.431602] Dynamic subtest smem: SUCCESS (0.038s)
[199.434050] Subtest linear: SUCCESS (0.038s)
[199.665169] [034/133] (822s left) kms_async_flips (crc-atomic)
[199.755349] Starting subtest: crc-atomic
[200.132145] Starting dynamic subtest: pipe-A-eDP-1
[203.070520] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.920s)
[203.436055] Starting dynamic subtest: pipe-B-eDP-1
[206.408742] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.952s)
[206.755715] Starting dynamic subtest: pipe-C-eDP-1
[209.630926] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.852s)
[209.961661] Starting dynamic subtest: pipe-D-eDP-1
[212.855432] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s)
[212.857684] Subtest crc-atomic: SUCCESS (13.071s)
[214.011358] [035/133] (808s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[214.402965] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[215.211589] [036/133] (807s left) kms_pipe_crc_basic (read-crc)
[215.309505] Starting subtest: read-crc
[215.311875] Starting dynamic subtest: pipe-A-eDP-1
[216.025221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[216.033884] Starting dynamic subtest: pipe-B-eDP-1
[217.434201] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[217.458796] Starting dynamic subtest: pipe-C-eDP-1
[218.790335] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s)
[218.802168] Starting dynamic subtest: pipe-D-eDP-1
[220.127645] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[220.130017] Subtest read-crc: SUCCESS (4.818s)
[220.969527] [037/133] (801s left) gem_mmap_gtt (cpuset-medium-copy)
[221.031435] Subtest cpuset-medium-copy: SKIP (0.000s)
[221.094204] [038/133] (801s left) gem_exec_fence (keep-in-fence)
[221.274096] Starting subtest: keep-in-fence
[221.276555] Starting dynamic subtest: rcs0
[221.338049] Dynamic subtest rcs0: SUCCESS (0.063s)
[221.348950] Starting dynamic subtest: bcs0
[221.391973] Dynamic subtest bcs0: SUCCESS (0.052s)
[221.405428] Starting dynamic subtest: vcs0
[222.934942] Dynamic subtest vcs0: SUCCESS (1.540s)
[222.946412] Starting dynamic subtest: vcs1
[224.918319] Dynamic subtest vcs1: SUCCESS (1.981s)
[224.930128] Starting dynamic subtest: vecs0
[226.955487] Dynamic subtest vecs0: SUCCESS (1.983s)
[226.966246] Starting dynamic subtest: ccs0
[227.140943] Dynamic subtest ccs0: SUCCESS (0.237s)
[227.143141] Subtest keep-in-fence: SUCCESS (5.868s)
[228.979019] [039/133] (793s left) sysfs_heartbeat_interval (invalid)
[229.041453] Starting subtest: invalid
[229.043688] Starting dynamic subtest: vecs0
[229.046049] Dynamic subtest vecs0: SUCCESS (0.000s)
[229.054772] Starting dynamic subtest: ccs0
[229.056632] Dynamic subtest ccs0: SUCCESS (0.000s)
[229.064644] Starting dynamic subtest: vcs0
[229.066549] Dynamic subtest vcs0: SUCCESS (0.000s)
[229.074841] Starting dynamic subtest: bcs0
[229.077074] Dynamic subtest bcs0: SUCCESS (0.000s)
[229.084806] Starting dynamic subtest: rcs0
[229.087081] Dynamic subtest rcs0: SUCCESS (0.000s)
[229.095340] Starting dynamic subtest: vcs1
[229.097460] Dynamic subtest vcs1: SUCCESS (0.000s)
[229.099582] Subtest invalid: SUCCESS (0.005s)
[229.146502] [040/133] (793s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[229.245887] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[229.248242] Starting dynamic subtest: pipe-A-eDP-1
[229.271107] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[229.280397] Starting dynamic subtest: pipe-B-eDP-1
[229.299368] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[229.308126] Starting dynamic subtest: pipe-C-eDP-1
[229.328232] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[229.337447] Starting dynamic subtest: pipe-D-eDP-1
[229.358072] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[229.362129] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[231.520035] [041/133] (791s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[231.568900] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[231.571063] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[231.660802] [042/133] (791s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[231.750135] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[231.754079] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[231.844165] [043/133] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[231.938499] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[231.942775] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[232.013921] [044/133] (791s left) kms_draw_crc (draw-method-mmap-cpu)
[232.117765] Starting subtest: draw-method-mmap-cpu
[232.119791] Starting dynamic subtest: xrgb8888-untiled
[232.361718] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[232.370266] Starting dynamic subtest: rgb565-untiled
[232.572461] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[232.582095] Starting dynamic subtest: xrgb2101010-untiled
[232.794825] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[232.805822] Starting dynamic subtest: xbgr16161616f-untiled
[233.005844] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[233.014846] Starting dynamic subtest: xrgb8888-xtiled
[233.128348] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[233.138160] Starting dynamic subtest: rgb565-xtiled
[233.249730] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[233.258760] Starting dynamic subtest: xrgb2101010-xtiled
[233.361172] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[233.369895] Starting dynamic subtest: xbgr16161616f-xtiled
[233.494499] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[233.503207] Starting dynamic subtest: xrgb8888-4tiled
[233.627638] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[233.636376] Starting dynamic subtest: rgb565-4tiled
[233.772317] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[233.782606] Starting dynamic subtest: xrgb2101010-4tiled
[233.905548] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[233.914282] Starting dynamic subtest: xbgr16161616f-4tiled
[234.050233] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[234.052175] Subtest draw-method-mmap-cpu: SUCCESS (1.934s)
[234.149949] [045/133] (788s left) sw_sync (sync_merge)
[234.183090] Starting subtest: sync_merge
[234.185129] Subtest sync_merge: SUCCESS (0.000s)
[234.239292] [046/133] (788s left) kms_content_protection (mei-interface)
[234.385324] Starting subtest: mei-interface
[234.389290] Subtest mei-interface: SKIP (0.001s)
[234.494944] [047/133] (788s left) prime_mmap (test_correct_cpu_write)
[234.555062] Starting subtest: test_correct_cpu_write
[234.556624] Starting dynamic subtest: test_correct_cpu_write-smem
[234.558213] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[234.559757] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[234.656541] [048/133] (788s left) kms_plane (plane-position-hole)
[234.752142] Starting subtest: plane-position-hole
[235.266173] Starting dynamic subtest: pipe-A-plane-1
[236.517785] Dynamic subtest pipe-A-plane-1: SUCCESS (1.250s)
[236.527742] Starting dynamic subtest: pipe-A-plane-2
[237.828845] Dynamic subtest pipe-A-plane-2: SUCCESS (1.311s)
[237.837426] Starting dynamic subtest: pipe-A-plane-3
[239.073538] Dynamic subtest pipe-A-plane-3: SUCCESS (1.244s)
[239.084251] Starting dynamic subtest: pipe-A-plane-4
[240.443274] Dynamic subtest pipe-A-plane-4: SUCCESS (1.369s)
[240.453095] Starting dynamic subtest: pipe-A-plane-5
[240.469327] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[241.632708] Starting dynamic subtest: pipe-B-plane-1
[242.858477] Dynamic subtest pipe-B-plane-1: SUCCESS (1.234s)
[242.868611] Starting dynamic subtest: pipe-B-plane-2
[244.092319] Dynamic subtest pipe-B-plane-2: SUCCESS (1.230s)
[244.101498] Starting dynamic subtest: pipe-B-plane-3
[245.323080] Dynamic subtest pipe-B-plane-3: SUCCESS (1.230s)
[245.333209] Starting dynamic subtest: pipe-B-plane-4
[246.559659] Dynamic subtest pipe-B-plane-4: SUCCESS (1.237s)
[246.569612] Starting dynamic subtest: pipe-B-plane-5
[246.584122] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[246.586428] Subtest plane-position-hole: SUCCESS (11.831s)
[247.382242] [049/133] (775s left) gem_exec_flush (basic-uc-pro-default)
[247.446092] Starting subtest: basic-uc-pro-default
[252.931770] Subtest basic-uc-pro-default: SUCCESS (5.465s)
[253.092782] [050/133] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[253.197259] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[253.201571] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[253.295405] [051/133] (770s left) gem_eio (hibernate)
[253.510463] Starting subtest: hibernate
[268.243784] Subtest hibernate: SUCCESS (14.731s)
[277.412318] [052/133] (754s left) gem_pread (display)
[277.543976] Subtest display: SKIP (0.000s)
[277.594068] [053/133] (754s left) gem_render_copy (linear-to-vebox-yf-tiled)
[277.669165] Starting subtest: linear-to-vebox-yf-tiled
[277.673612] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[277.855348] [054/133] (754s left) perf (blocking-parameterized)
[278.008138] Starting subtest: blocking-parameterized
[298.082640] Subtest blocking-parameterized: SUCCESS (20.021s)
[298.121673] [055/133] (734s left) kms_lease (multimaster-lease)
[298.227705] Starting subtest: multimaster-lease
[298.230129] Subtest multimaster-lease: SUCCESS (0.003s)
[298.345673] [056/133] (734s left) gem_exec_balancer (sliced)
[298.398822] Starting subtest: sliced
[298.403301] Subtest sliced: SKIP (0.000s)
[298.733391] [057/133] (733s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[298.797873] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[298.800083] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[298.904164] [058/133] (733s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[298.998387] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[299.002277] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[299.105155] [059/133] (733s left) gem_softpin (allocator-evict)
[299.177095] Starting subtest: allocator-evict
[299.179412] Starting dynamic subtest: rcs0
[322.554039] Dynamic subtest rcs0: SUCCESS (23.378s)
[322.564787] Starting dynamic subtest: bcs0
[346.803491] Dynamic subtest bcs0: SUCCESS (24.247s)
[346.815849] Starting dynamic subtest: vcs0
[370.460165] Dynamic subtest vcs0: SUCCESS (23.655s)
[370.473761] Starting dynamic subtest: vcs1
[394.356449] Dynamic subtest vcs1: SUCCESS (23.893s)
[394.369235] Starting dynamic subtest: vecs0
[418.005667] Dynamic subtest vecs0: SUCCESS (23.648s)
[418.018059] Starting dynamic subtest: ccs0
[441.726780] Dynamic subtest ccs0: SUCCESS (23.719s)
[441.729603] Subtest allocator-evict: SUCCESS (142.551s)
[441.828864] [060/133] (590s left) gem_ctx_create (basic)
[441.951160] Starting subtest: basic
[441.953588] Subtest basic: SUCCESS (0.000s)
[442.151609] [061/133] (590s left) kms_chamelium_audio (dp-audio)
[442.544254] Subtest dp-audio: SKIP (0.000s)
[443.390668] [062/133] (589s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[443.481218] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[443.485403] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[443.569590] [063/133] (589s left) gem_exec_await (wide-contexts)
[443.804909] Starting subtest: wide-contexts
[466.575076] Subtest wide-contexts: SUCCESS (22.756s)
[466.765473] [064/133] (566s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[466.915505] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[466.919530] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[467.020588] [065/133] (565s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[467.073369] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[467.077664] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[467.256439] [066/133] (565s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[467.345373] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[467.347763] Starting dynamic subtest: pipe-A-default-mode
[468.468701] Dynamic subtest pipe-A-default-mode: SKIP (1.121s)
[468.473093] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.122s)
[468.595239] [067/133] (564s left) i915_pm_rpm (gem-execbuf)
[470.145952] Starting subtest: gem-execbuf
[470.148276] Starting dynamic subtest: smem0
[472.520088] Dynamic subtest smem0: SUCCESS (2.377s)
[472.522494] Subtest gem-execbuf: SUCCESS (2.378s)
[472.647510] [068/133] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[472.743248] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[472.747522] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[472.849645] [069/133] (560s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[472.907069] Starting subtest: multi-wait-available-submitted-signaled
[472.909806] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[473.037529] [070/133] (560s left) prime_mmap (test_userptr)
[473.094924] Starting subtest: test_userptr
[473.097282] Starting dynamic subtest: test_userptr-smem
[473.099245] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[473.101202] Subtest test_userptr: SUCCESS (0.001s)
[473.196140] [071/133] (560s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[473.306416] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[473.310614] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[473.400881] [072/133] (559s left) core_getstats (basic)
[473.455696] Starting subtest: basic
[473.457677] Subtest basic: SUCCESS (0.000s)
[473.542327] [073/133] (559s left) gem_exec_schedule (semaphore-noskip)
[473.611533] Starting subtest: semaphore-noskip
[474.035356] Subtest semaphore-noskip: SUCCESS (0.428s)
[474.392298] [074/133] (558s left) gen9_exec_parse (shadow-peek)
[474.450246] Subtest shadow-peek: SKIP (0.000s)
[474.510389] [075/133] (558s left) api_intel_allocator (reopen-fork)
[474.564063] Starting subtest: reopen-fork
[477.911252] Subtest reopen-fork: SUCCESS (3.293s)
[477.955533] [076/133] (555s left) kms_async_flips (alternate-sync-async-flip)
[478.044016] Starting subtest: alternate-sync-async-flip
[478.432082] Starting dynamic subtest: pipe-A-eDP-1
[481.182050] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.750s)
[481.565647] Starting dynamic subtest: pipe-B-eDP-1
[484.302989] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.746s)
[484.673348] Starting dynamic subtest: pipe-C-eDP-1
[487.436312] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.773s)
[487.814960] Starting dynamic subtest: pipe-D-eDP-1
[490.575102] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[490.577110] Subtest alternate-sync-async-flip: SUCCESS (12.533s)
[491.748270] [077/133] (541s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[491.879350] Starting subtest: flip-vs-cursor-busy-crc-atomic
[492.700961] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.822s)
[493.588348] [078/133] (539s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[493.688754] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[503.007271] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.320s)
[503.153774] [079/133] (530s left) kms_frontbuffer_tracking (fbc-suspend)
[503.253761] Starting subtest: fbc-suspend
[541.739072] Subtest fbc-suspend: SUCCESS (7.479s)
[542.990937] [080/133] (490s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[543.098484] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[543.101175] Starting dynamic subtest: pipe-A-eDP-1
[543.123264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[543.134857] Starting dynamic subtest: pipe-B-eDP-1
[543.157440] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[543.169171] Starting dynamic subtest: pipe-C-eDP-1
[543.190928] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[543.200490] Starting dynamic subtest: pipe-D-eDP-1
[543.223083] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[543.225223] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[545.382029] [081/133] (488s left) kms_pm_rpm (legacy-planes-dpms)
[547.117515] Starting subtest: legacy-planes-dpms
[547.120298] Starting dynamic subtest: plane-65
[555.511045] Dynamic subtest plane-65: SUCCESS (8.396s)
[555.524735] Starting dynamic subtest: plane-95
[563.798850] Dynamic subtest plane-95: SUCCESS (8.285s)
[563.812476] Starting dynamic subtest: plane-125
[572.499799] Dynamic subtest plane-125: SUCCESS (8.697s)
[572.515005] Starting dynamic subtest: plane-135
[581.106589] Dynamic subtest plane-135: SUCCESS (8.604s)
[581.109468] Subtest legacy-planes-dpms: SUCCESS (33.994s)
[581.497199] [082/133] (452s left) kms_pm_dc (dc5-retention-flops)
[582.602337] Starting subtest: dc5-retention-flops
[582.607467] Subtest dc5-retention-flops: SKIP (0.000s)
[582.687821] [083/133] (451s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[582.780484] Starting subtest: psr-rgb101010-draw-render
[589.948807] Subtest psr-rgb101010-draw-render: SUCCESS (7.170s)
[590.078227] [084/133] (443s left) syncobj_timeline (single-wait-available-submitted)
[590.141395] Starting subtest: single-wait-available-submitted
[590.144496] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[590.254648] [085/133] (443s left) gem_pxp (create-valid-protected-context)
[590.370358] Starting subtest: create-valid-protected-context
[590.373265] Subtest create-valid-protected-context: SUCCESS (0.002s)
[590.482293] [086/133] (443s left) kms_vblank (query-forked-busy)
[590.579833] Starting subtest: query-forked-busy
[590.581905] Starting dynamic subtest: pipe-A-eDP-1
[593.251359] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.667s)
[593.270482] Starting dynamic subtest: pipe-D-eDP-1
[595.329461] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.076s)
[595.332502] Subtest query-forked-busy: SUCCESS (4.752s)
[596.130227] [087/133] (437s left) gem_mmap_gtt (fault-concurrent)
[596.185573] Subtest fault-concurrent: SKIP (0.000s)
[596.243812] [088/133] (437s left) template (b)
[596.298366] Starting subtest: B
[596.300558] Subtest B: SUCCESS (0.000s)
[596.392786] [089/133] (437s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[596.488173] Starting subtest: plane-lut1d-post-ctm3x4
[596.611810] Starting dynamic subtest: pipe-A-plane-0
[596.768243] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[596.778915] Starting dynamic subtest: pipe-A-plane-1
[596.924074] Dynamic subtest pipe-A-plane-1: SUCCESS (0.154s)
[596.934600] Starting dynamic subtest: pipe-A-plane-2
[597.056076] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[598.273094] Starting dynamic subtest: pipe-B-plane-0
[598.464426] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[598.477913] Starting dynamic subtest: pipe-B-plane-1
[598.653090] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[598.663907] Starting dynamic subtest: pipe-B-plane-2
[598.832215] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[600.064312] Starting dynamic subtest: pipe-C-plane-0
[600.200502] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[600.211563] Starting dynamic subtest: pipe-C-plane-1
[600.344992] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[600.355630] Starting dynamic subtest: pipe-C-plane-2
[600.488775] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[601.685807] Starting dynamic subtest: pipe-D-plane-0
[601.832903] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[601.844645] Starting dynamic subtest: pipe-D-plane-1
[601.988640] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[601.999253] Starting dynamic subtest: pipe-D-plane-2
[602.133086] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[602.420140] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.933s)
[603.264716] [090/133] (430s left) gem_mmap_gtt (hang-user)
[603.338145] Subtest hang-user: SKIP (0.000s)
[603.406915] [091/133] (430s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[603.512621] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[604.158377] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[604.309730] [092/133] (429s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[604.419027] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[611.271816] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.858s)
[611.390975] [093/133] (422s left) kms_flip (2x-dpms-vs-vblank-race)
[611.485499] Starting subtest: 2x-dpms-vs-vblank-race
[611.495854] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[611.593156] [094/133] (422s left) dumb_buffer (create-valid-dumb)
[611.657439] Starting subtest: create-valid-dumb
[611.660328] Subtest create-valid-dumb: SUCCESS (0.000s)
[611.755863] [095/133] (422s left) gem_compute (compute-square)
[611.807290] Starting subtest: compute-square
[611.812621] Subtest compute-square: SUCCESS (0.007s)
[611.924978] [096/133] (422s left) kms_frontbuffer_tracking (psr-slowdraw)
[612.012294] Starting subtest: psr-slowdraw
[637.239976] Subtest psr-slowdraw: SUCCESS (25.231s)
[637.371884] [097/133] (397s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[637.493063] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[638.482476] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.990s)
[639.303671] [098/133] (395s left) kms_psr (pr-sprite-blt)
[639.397025] Starting subtest: pr-sprite-blt
[639.402177] Subtest pr-sprite-blt: SKIP (0.000s)
[639.470644] [099/133] (395s left) gem_userptr_blits (create-destroy-unsync)
[639.536992] Subtest create-destroy-unsync: SKIP (0.000s)
[639.652948] [100/133] (394s left) kms_selftest (drm_format_helper)
[639.699684] Starting subtest: drm_format_helper
[639.728327] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[639.811056] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.081s)
[639.822296] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[639.903558] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.090s)
[639.915584] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[639.995555] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.094s)
[640.005623] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[640.091836] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.095s)
[640.102139] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[640.183317] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.089s)
[640.193579] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[640.265797] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.082s)
[640.275138] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[640.369835] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.102s)
[640.379941] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[640.465279] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.096s)
[640.475325] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[640.551954] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.087s)
[640.563053] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[640.642685] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.090s)
[640.652590] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[640.733221] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.090s)
[640.743337] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[640.827823] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.092s)
[640.837111] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[640.920125] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.091s)
[640.929971] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[641.007284] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.089s)
[641.017346] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[641.104308] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.094s)
[641.114427] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[641.204129] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.100s)
[641.213746] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[641.299937] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.096s)
[641.302316] Subtest drm_format_helper: SUCCESS (1.601s)
[641.446001] [101/133] (393s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[641.503426] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[641.611670] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[641.691902] [102/133] (392s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[641.790250] Starting subtest: y-tiled-8bpp-rotate-270
[641.795312] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[641.894361] [103/133] (392s left) kms_cursor_crc (cursor-offscreen-32x10)
[642.064849] Starting subtest: cursor-offscreen-32x10
[642.110555] Subtest cursor-offscreen-32x10: SKIP (0.040s)
[642.395982] [104/133] (392s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[642.487270] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[642.489805] Starting dynamic subtest: pipe-A-eDP-1
[642.516612] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[642.527678] Starting dynamic subtest: pipe-B-eDP-1
[642.552690] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[642.562402] Starting dynamic subtest: pipe-C-eDP-1
[642.587502] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[642.597080] Starting dynamic subtest: pipe-D-eDP-1
[642.622493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[642.627581] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[644.761940] [105/133] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[644.856591] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[644.861495] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[644.955542] [106/133] (389s left) kms_cursor_edge_walk (128x128-right-edge)
[645.042241] Starting subtest: 128x128-right-edge
[645.045097] Starting dynamic subtest: pipe-A-eDP-1
[648.531650] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[648.541712] Starting dynamic subtest: pipe-D-eDP-1
[651.659504] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[651.662053] Subtest 128x128-right-edge: SUCCESS (6.620s)
[652.477023] [107/133] (382s left) kms_psr (fbc-pr-primary-render)
[652.574452] Starting subtest: fbc-pr-primary-render
[652.579318] Subtest fbc-pr-primary-render: SKIP (0.000s)
[652.661384] [108/133] (382s left) gem_exec_whisper (basic-sync-all)
[652.723961] Starting subtest: basic-sync-all
[660.010579] Subtest basic-sync-all: SUCCESS (7.283s)
[660.212687] [109/133] (374s left) syncobj_basic (create-signaled)
[660.267844] Starting subtest: create-signaled
[660.270515] Subtest create-signaled: SUCCESS (0.000s)
[660.376793] [110/133] (374s left) gem_request_retire (retire-vma-not-inactive)
[660.447332] Starting subtest: retire-vma-not-inactive
[660.513427] Subtest retire-vma-not-inactive: SUCCESS (0.064s)
[660.632810] [111/133] (374s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[660.735150] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[660.740078] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[661.890838] [112/133] (373s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[661.994312] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[661.997085] Starting dynamic subtest: pipe-A-eDP-1
[673.325008] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.335s)
[673.336559] Starting dynamic subtest: pipe-B-eDP-1
[685.318253] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.993s)
[685.320959] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.331s)
[686.144201] [113/133] (348s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[686.240227] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[686.245187] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[686.314878] [114/133] (348s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[686.416412] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[686.421161] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[686.504264] [115/133] (348s left) syncobj_wait (invalid-signal-bad-pad)
[686.561804] Starting subtest: invalid-signal-bad-pad
[686.564420] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[686.654171] [116/133] (348s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[686.746504] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[686.750950] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[686.853255] [117/133] (348s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[687.229843] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[688.095828] [118/133] (347s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[688.180840] Starting subtest: plane-all-transition-nonblocking-fencing
[688.183401] Starting dynamic subtest: pipe-A-eDP-1
[690.673589] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[690.992355] Starting dynamic subtest: pipe-B-eDP-1
[694.208451] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.226s)
[694.516344] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.338s)
[695.337217] [119/133] (340s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[695.401499] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[695.403928] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[695.497465] [120/133] (339s left) gem_ccs (ctrl-surf-copy)
[695.552418] Starting subtest: ctrl-surf-copy
[695.557305] Subtest ctrl-surf-copy: SKIP (0.000s)
[695.647155] [121/133] (339s left) i915_pm_rps (thresholds-idle-park)
[695.704498] Starting subtest: thresholds-idle-park
[695.710052] Subtest thresholds-idle-park: SKIP (0.000s)
[695.812240] [122/133] (339s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[695.909172] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[702.487392] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.582s)
[702.592923] [123/133] (333s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[702.703920] Starting subtest: basic-flip-after-cursor-legacy
[703.621858] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.917s)
[704.506841] [124/133] (331s left) i915_module_load (reload-no-display)
[704.543579] Starting subtest: reload-no-display
[711.318943] Subtest reload-no-display: SUCCESS (6.778s)
[711.350461] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[711.351261] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[711.355871] [125/133] (324s left) gem_exec_balancer (bonded-pair)
[713.736457] Starting subtest: bonded-pair
[713.742479] Subtest bonded-pair: SKIP (0.000s)
[714.003921] [FACT gem_exec_balancer (bonded-pair)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[714.005111] [FACT gem_exec_balancer (bonded-pair)] new: kernel.kmod_is_loaded.i915: true
[714.010389] [126/133] (321s left) kms_flip (plain-flip-fb-recreate)
[714.106172] Starting subtest: plain-flip-fb-recreate
[714.108616] Starting dynamic subtest: A-eDP1
[722.964265] Dynamic subtest A-eDP1: SUCCESS (8.857s)
[722.974564] Starting dynamic subtest: B-eDP1
[731.793109] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[731.804576] Starting dynamic subtest: C-eDP1
[740.620876] Dynamic subtest C-eDP1: SUCCESS (8.825s)
[740.630121] Starting dynamic subtest: D-eDP1
[749.450366] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[749.455739] Subtest plain-flip-fb-recreate: SUCCESS (35.351s)
[750.649957] [127/133] (285s left) gem_ctx_param (invalid-get-no-zeromap)
[750.709358] Starting subtest: invalid-get-no-zeromap
[750.712194] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[750.802818] [128/133] (285s left) kms_cursor_crc (cursor-size-hints)
[750.925572] Starting subtest: cursor-size-hints
[750.928271] Starting dynamic subtest: pipe-A-eDP-1
[751.554450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.628s)
[751.564401] Starting dynamic subtest: pipe-D-eDP-1
[752.794959] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[752.797346] Subtest cursor-size-hints: SUCCESS (1.871s)
[753.601513] [129/133] (282s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[753.709580] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[753.714921] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[753.807312] [130/133] (282s left) prime_vgem (basic-fence-read)
[753.874270] Starting subtest: basic-fence-read
[753.893024] Subtest basic-fence-read: SKIP (0.016s)
[753.984781] [131/133] (281s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[754.079513] Starting subtest: pr-cursor-plane-move-continuous-sf
[754.084396] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[754.155794] [132/133] (281s left) gem_eio (in-flight-internal-immediate)
[754.328048] Starting subtest: in-flight-internal-immediate
[755.942577] Subtest in-flight-internal-immediate: SUCCESS (1.614s)
[756.077365] [133/133] (279s left) perf_pmu (init-sema)
[756.128396] Starting subtest: init-sema
[756.131242] Starting dynamic subtest: rcs0
[756.133938] Dynamic subtest rcs0: SUCCESS (0.001s)
[756.144507] Starting dynamic subtest: bcs0
[756.146801] Dynamic subtest bcs0: SUCCESS (0.000s)
[756.155818] Starting dynamic subtest: vcs0
[756.158032] Dynamic subtest vcs0: SUCCESS (0.000s)
[756.167141] Starting dynamic subtest: vcs1
[756.169352] Dynamic subtest vcs1: SUCCESS (0.000s)
[756.179449] Starting dynamic subtest: vecs0
[756.182385] Dynamic subtest vecs0: SUCCESS (0.000s)
[756.192125] Starting dynamic subtest: ccs0
[756.194294] Dynamic subtest ccs0: SUCCESS (0.000s)
[756.196692] Subtest init-sema: SUCCESS (0.006s)
[756.236724] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: gem_exec_alignment
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: gem_exec_gttfill
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: gem_tiling_max_stride
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gen9_exec_parse
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: prime_vgem
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_prop_blob
results: parsing output: 31/ for test: kms_invalid_mode
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: sysfs_heartbeat_interval
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_draw_crc
results: parsing output: 44/ for test: sw_sync
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: prime_mmap
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: gem_exec_flush
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: gem_pread
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_ctx_create
results: parsing output: 60/ for test: kms_chamelium_audio
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: gem_exec_await
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: prime_mmap
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: core_getstats
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_async_flips
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_pm_rpm
results: parsing output: 81/ for test: kms_pm_dc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: template
results: parsing output: 88/ for test: kms_color_pipeline
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: dumb_buffer
results: parsing output: 94/ for test: gem_compute
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_selftest
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_cursor_edge_walk
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: syncobj_basic
results: parsing output: 109/ for test: gem_request_retire
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_chamelium_frames
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: gem_ccs
results: parsing output: 120/ for test: i915_pm_rps
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: i915_module_load
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: prime_vgem
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: perf_pmu
Done.