[57.158222] Initializing watchdogs
[57.158272]   /dev/watchdog0
[57.172558] [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]
[57.177037] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.179359] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.182612] [001/131] (960s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[57.295513] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[57.298305] Starting dynamic subtest: pipe-A-eDP-1
[57.318659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[57.326277] Starting dynamic subtest: pipe-B-eDP-1
[57.346163] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[57.352495] Starting dynamic subtest: pipe-C-eDP-1
[57.371588] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[57.379863] Starting dynamic subtest: pipe-D-eDP-1
[57.399866] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[57.401912] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[59.603958] [002/131] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[59.710232] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[66.852391] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.182s)
[67.541248] [003/131] (950s left) kms_pipe_crc_basic (nonblocking-crc)
[67.670371] Starting subtest: nonblocking-crc
[67.672790] Starting dynamic subtest: pipe-A-eDP-1
[68.428704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s)
[68.438155] Starting dynamic subtest: pipe-B-eDP-1
[69.851975] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[69.858998] Starting dynamic subtest: pipe-C-eDP-1
[71.255663] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s)
[71.265399] Starting dynamic subtest: pipe-D-eDP-1
[72.591827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[72.594146] Subtest nonblocking-crc: SUCCESS (4.931s)
[73.407090] [004/131] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[73.520288] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[73.524607] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[73.655569] [005/131] (944s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[73.755161] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[73.759318] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[73.877757] [006/131] (944s left) i915_drm_fdinfo (virtual-busy-all)
[73.919266] Starting subtest: virtual-busy-all
[73.923510] Subtest virtual-busy-all: SKIP (0.000s)
[74.007889] [007/131] (943s left) gem_gpgpu_fill (offset-16x16)
[74.076646] Starting subtest: offset-16x16
[74.085712] Subtest offset-16x16: SUCCESS (0.009s)
[74.249724] [008/131] (943s left) perf_pmu (busy-accuracy-98)
[74.288578] Starting subtest: busy-accuracy-98
[74.290519] Starting dynamic subtest: rcs0
[77.324923] Dynamic subtest rcs0: SUCCESS (3.037s)
[77.334463] Starting dynamic subtest: bcs0
[80.377694] Dynamic subtest bcs0: SUCCESS (3.053s)
[80.387823] Starting dynamic subtest: vcs0
[83.420047] Dynamic subtest vcs0: SUCCESS (3.041s)
[83.429743] Starting dynamic subtest: vcs1
[86.463556] Dynamic subtest vcs1: SUCCESS (3.042s)
[86.473021] Starting dynamic subtest: vecs0
[89.504890] Dynamic subtest vecs0: SUCCESS (3.040s)
[89.514724] Starting dynamic subtest: ccs0
[92.556281] Dynamic subtest ccs0: SUCCESS (3.050s)
[92.558793] Subtest busy-accuracy-98: SUCCESS (18.268s)
[92.694434] [009/131] (925s left) gem_exec_flush (basic-wb-pro-default)
[92.756265] Starting subtest: basic-wb-pro-default
[98.229249] Subtest basic-wb-pro-default: SUCCESS (5.472s)
[98.438142] [010/131] (919s left) kms_rotation_crc (primary-rotation-90)
[98.549085] Starting subtest: primary-rotation-90
[98.553319] Subtest primary-rotation-90: SKIP (0.001s)
[98.645177] [011/131] (919s left) gem_exec_schedule (fifo)
[98.727641] Starting subtest: fifo
[98.729622] Starting dynamic subtest: rcs0
[98.820861] Dynamic subtest rcs0: SUCCESS (0.102s)
[98.831080] Starting dynamic subtest: vcs0
[98.897165] Dynamic subtest vcs0: SUCCESS (0.076s)
[98.907533] Starting dynamic subtest: vcs1
[98.971564] Dynamic subtest vcs1: SUCCESS (0.074s)
[98.983239] Starting dynamic subtest: vecs0
[99.041971] Dynamic subtest vecs0: SUCCESS (0.070s)
[99.051792] Starting dynamic subtest: ccs0
[99.126936] Dynamic subtest ccs0: SUCCESS (0.084s)
[99.129827] Subtest fifo: SUCCESS (0.408s)
[100.061388] [012/131] (918s left) kms_plane_scaling (invalid-parameters)
[100.180882] Starting subtest: invalid-parameters
[100.183262] Starting dynamic subtest: less-than-1-height-src
[100.208714] Dynamic subtest less-than-1-height-src: SUCCESS (0.027s)
[100.217749] Starting dynamic subtest: less-than-1-width-src
[100.237085] Dynamic subtest less-than-1-width-src: SUCCESS (0.026s)
[100.239328] Subtest invalid-parameters: SUCCESS (0.055s)
[100.368347] [013/131] (917s left) kms_pm_rpm (universal-planes-dpms)
[102.019225] Starting subtest: universal-planes-dpms
[102.021272] Starting dynamic subtest: plane-33
[110.752523] Dynamic subtest plane-33: SUCCESS (8.734s)
[110.763253] Starting dynamic subtest: plane-63
[119.177700] Dynamic subtest plane-63: SUCCESS (8.424s)
[119.188163] Starting dynamic subtest: plane-93
[127.524027] Dynamic subtest plane-93: SUCCESS (8.344s)
[127.534479] Starting dynamic subtest: plane-123
[135.859746] Dynamic subtest plane-123: SUCCESS (8.334s)
[135.870360] Starting dynamic subtest: plane-133
[144.256613] Dynamic subtest plane-133: SUCCESS (8.395s)
[144.267442] Starting dynamic subtest: plane-143
[152.557312] Dynamic subtest plane-143: SUCCESS (8.298s)
[152.560370] Subtest universal-planes-dpms: SUCCESS (50.538s)
[152.974241] [014/131] (865s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[153.068702] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[153.071051] Starting dynamic subtest: pipe-A-default-mode
[153.379489] Dynamic subtest pipe-A-default-mode: SKIP (0.309s)
[153.384178] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.311s)
[154.203761] [015/131] (864s left) gem_tiled_partial_pwrite_pread (writes)
[154.266258] Subtest writes: SKIP (0.000s)
[154.332404] [016/131] (863s left) gem_userptr_blits (create-destroy-sync)
[154.411249] Starting subtest: create-destroy-sync
[159.420700] Subtest create-destroy-sync: SUCCESS (5.008s)
[159.591556] [017/131] (858s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[159.697955] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[164.327197] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.632s)
[165.495228] [018/131] (852s left) i915_pm_rpm (reg-read-ioctl)
[167.125424] Starting subtest: reg-read-ioctl
[169.404049] Subtest reg-read-ioctl: SUCCESS (2.281s)
[169.805297] [019/131] (848s left) drm_buddy (drm_buddy)
[169.839776] Starting subtest: drm_buddy
[169.853891] Starting dynamic subtest: drm_test_buddy_alloc_limit
[169.982565] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.128s)
[169.992045] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[170.092182] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.110s)
[170.099805] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[170.210489] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.116s)
[170.220134] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[170.348108] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.137s)
[170.355699] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[170.482723] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.135s)
[170.492165] Starting dynamic subtest: drm_test_buddy_alloc_clear
[170.654931] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.172s)
[170.663056] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[170.752311] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.097s)
[170.761487] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[174.894666] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.139s)
[174.896910] Subtest drm_buddy: SUCCESS (5.056s)
[175.068604] [020/131] (843s left) kms_psr2_su (frontbuffer-xrgb8888)
[175.131592] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[175.198462] [021/131] (843s left) prime_busy (hang)
[175.258708] Starting subtest: hang
[175.261100] Starting dynamic subtest: rcs0
[201.457751] Dynamic subtest rcs0: SUCCESS (26.195s)
[201.465129] Starting dynamic subtest: bcs0
[208.547650] Dynamic subtest bcs0: SUCCESS (7.087s)
[208.555384] Starting dynamic subtest: vcs0
[215.587778] Dynamic subtest vcs0: SUCCESS (7.038s)
[215.595257] Starting dynamic subtest: vcs1
[222.561863] Dynamic subtest vcs1: SUCCESS (6.974s)
[222.571681] Starting dynamic subtest: vecs0
[229.541318] Dynamic subtest vecs0: SUCCESS (6.978s)
[229.551078] Starting dynamic subtest: ccs0
[243.441235] Dynamic subtest ccs0: SUCCESS (13.899s)
[243.443396] Subtest hang: SUCCESS (68.178s)
[243.609717] [022/131] (774s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[243.716330] Starting subtest: addfb25-y-tiled-legacy
[243.718255] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[243.859374] [023/131] (774s left) gen3_render_mixed_blits
[243.990514] [024/131] (774s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[244.057923] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[244.060195] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[244.211413] [025/131] (774s left) kms_cursor_legacy (single-bo)
[244.333118] Starting subtest: single-bo
[244.335460] Starting dynamic subtest: pipe-A
[249.717276] Dynamic subtest pipe-A: SUCCESS (5.380s)
[249.727887] Starting dynamic subtest: pipe-B
[255.099328] Dynamic subtest pipe-B: SUCCESS (5.380s)
[255.109277] Starting dynamic subtest: pipe-C
[260.481063] Dynamic subtest pipe-C: SUCCESS (5.380s)
[260.491582] Starting dynamic subtest: pipe-D
[265.864238] Dynamic subtest pipe-D: SUCCESS (5.380s)
[265.875648] Starting dynamic subtest: all-pipes
[271.253956] Dynamic subtest all-pipes: SUCCESS (5.389s)
[271.256594] Subtest single-bo: SUCCESS (26.917s)
[271.417042] [026/131] (747s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[271.530066] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[271.534271] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.645860] [027/131] (747s left) gem_exec_schedule (preempt)
[271.734608] Starting subtest: preempt
[271.736614] Starting dynamic subtest: rcs0
[271.753599] Dynamic subtest rcs0: SUCCESS (0.022s)
[271.763890] Starting dynamic subtest: bcs0
[271.773486] Dynamic subtest bcs0: SUCCESS (0.020s)
[271.781302] Starting dynamic subtest: vcs0
[271.792083] Dynamic subtest vcs0: SUCCESS (0.018s)
[271.800068] Starting dynamic subtest: vcs1
[271.810789] Dynamic subtest vcs1: SUCCESS (0.018s)
[271.820539] Starting dynamic subtest: vecs0
[271.830295] Dynamic subtest vecs0: SUCCESS (0.019s)
[271.838480] Starting dynamic subtest: ccs0
[271.855704] Dynamic subtest ccs0: SUCCESS (0.025s)
[271.857938] Subtest preempt: SUCCESS (0.125s)
[273.028682] [028/131] (745s left) kms_cursor_edge_walk (128x128-top-edge)
[273.118240] Starting subtest: 128x128-top-edge
[273.120583] Starting dynamic subtest: pipe-A-eDP-1
[276.542812] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[276.551980] Starting dynamic subtest: pipe-D-eDP-1
[279.686022] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.141s)
[279.688248] Subtest 128x128-top-edge: SUCCESS (6.566s)
[280.508597] [029/131] (738s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[280.629278] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[288.091987] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.464s)
[288.271214] [030/131] (730s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[288.371056] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[288.373345] Starting dynamic subtest: pipe-A-eDP-1
[288.395990] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[288.409080] Starting dynamic subtest: pipe-B-eDP-1
[288.430410] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[288.437893] Starting dynamic subtest: pipe-C-eDP-1
[288.459372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[288.466832] Starting dynamic subtest: pipe-D-eDP-1
[288.488963] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[288.493347] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[290.694134] [031/131] (728s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[290.820441] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[291.852927] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[292.012262] [032/131] (726s left) kms_cursor_crc (cursor-random-64x21)
[292.196557] Starting subtest: cursor-random-64x21
[292.245306] Subtest cursor-random-64x21: SKIP (0.044s)
[292.518722] [033/131] (726s left) gem_exec_big (single)
[292.576403] Starting subtest: single
[294.934815] Subtest single: SUCCESS (2.336s)
[295.150920] [034/131] (723s left) kms_hdmi_inject (inject-4k)
[295.538949] Starting subtest: inject-4k
[295.860515] Subtest inject-4k: SUCCESS (0.323s)
[296.457744] [035/131] (722s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[296.566232] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[296.568490] Starting dynamic subtest: pipe-A-eDP-1
[296.590874] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[296.600225] Starting dynamic subtest: pipe-B-eDP-1
[296.620482] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[296.628586] Starting dynamic subtest: pipe-C-eDP-1
[296.649272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[296.657425] Starting dynamic subtest: pipe-D-eDP-1
[296.680201] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[296.684408] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[298.818915] [036/131] (720s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[298.937776] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[299.561780] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[299.765504] [037/131] (719s left) kms_big_fb (linear-8bpp-rotate-270)
[299.869426] Starting subtest: linear-8bpp-rotate-270
[299.891164] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[300.039414] [038/131] (719s left) kms_cursor_crc (cursor-offscreen-128x42)
[300.255948] Starting subtest: cursor-offscreen-128x42
[300.316758] Subtest cursor-offscreen-128x42: SKIP (0.056s)
[300.528727] [039/131] (718s left) gem_mmap_wc (write-gtt-read-wc)
[300.581684] Subtest write-gtt-read-wc: SKIP (0.000s)
[300.638323] [040/131] (718s left) i915_query (hwconfig_table)
[300.684266] Starting subtest: hwconfig_table
[300.926483] Subtest hwconfig_table: SUCCESS (0.001s)
[300.961854] [041/131] (718s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[301.052996] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[301.054935] Starting dynamic subtest: pipe-A-default-mode
[302.237597] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[302.241472] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.183s)
[302.404338] [042/131] (716s left) gem_exec_balancer (bonded-true-hang)
[302.668166] Starting subtest: bonded-true-hang
[302.672496] Subtest bonded-true-hang: SKIP (0.000s)
[302.790276] [043/131] (716s left) kms_getfb (getfb2-handle-not-fb)
[302.882065] Starting subtest: getfb2-handle-not-fb
[302.884398] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[303.014928] [044/131] (716s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[303.125994] Starting subtest: invalid-modeset-force-ultra-joiner
[303.130312] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[303.218618] [045/131] (716s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[303.318161] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[303.320451] Starting dynamic subtest: pipe-A-default-mode
[303.619290] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[303.624045] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.300s)
[304.434757] [046/131] (715s left) kms_draw_crc (draw-method-pwrite)
[304.528788] Starting subtest: draw-method-pwrite
[304.530649] Starting dynamic subtest: xrgb8888-untiled
[305.093813] Dynamic subtest xrgb8888-untiled: SUCCESS (0.566s)
[305.102779] Starting dynamic subtest: rgb565-untiled
[305.549460] Dynamic subtest rgb565-untiled: SUCCESS (0.455s)
[305.558450] Starting dynamic subtest: xrgb2101010-untiled
[306.093997] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[306.102821] Starting dynamic subtest: xbgr16161616f-untiled
[306.871509] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[306.880460] Starting dynamic subtest: xrgb8888-xtiled
[308.682874] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.810s)
[308.691771] Starting dynamic subtest: rgb565-xtiled
[309.838617] Dynamic subtest rgb565-xtiled: SUCCESS (1.155s)
[309.847865] Starting dynamic subtest: xrgb2101010-xtiled
[311.650487] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.811s)
[311.661633] Starting dynamic subtest: xbgr16161616f-xtiled
[314.983819] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.331s)
[314.992538] Starting dynamic subtest: xrgb8888-4tiled
[316.094331] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.110s)
[316.103165] Starting dynamic subtest: rgb565-4tiled
[316.661114] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[316.670237] Starting dynamic subtest: xrgb2101010-4tiled
[317.783227] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.121s)
[317.792211] Starting dynamic subtest: xbgr16161616f-4tiled
[320.827744] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.044s)
[320.830034] Subtest draw-method-pwrite: SUCCESS (16.300s)
[320.969349] [047/131] (698s left) perf (non-sampling-read-error)
[321.144857] Starting subtest: non-sampling-read-error
[321.154987] Subtest non-sampling-read-error: SUCCESS (0.010s)
[321.197506] [048/131] (698s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[321.262104] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[321.369319] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[321.469239] [049/131] (698s left) syncobj_timeline (invalid-query-zero-handles)
[321.537437] Starting subtest: invalid-query-zero-handles
[321.539715] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[321.688596] [050/131] (697s left) syncobj_wait (multi-wait-for-submit-signaled)
[321.744133] Starting subtest: multi-wait-for-submit-signaled
[321.746485] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[321.865489] [051/131] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[321.975356] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[321.979745] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[322.119289] [052/131] (697s left) gem_exec_params (invalid-fence-in)
[322.189875] Starting subtest: invalid-fence-in
[322.192218] Subtest invalid-fence-in: SUCCESS (0.000s)
[322.328973] [053/131] (697s left) gem_render_copy (yf-tiled-ccs-to-linear)
[322.407617] Starting subtest: yf-tiled-ccs-to-linear
[322.411260] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[322.609350] [054/131] (697s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[322.671463] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[322.777927] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[322.887222] [055/131] (696s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[322.986166] Starting subtest: fbc-indfb-scaledprimary
[325.926993] Subtest fbc-indfb-scaledprimary: SUCCESS (2.944s)
[327.129601] [056/131] (692s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[327.232910] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[327.235084] Starting dynamic subtest: pipe-A
[327.254717] Dynamic subtest pipe-A: SKIP (0.018s)
[327.263637] Starting dynamic subtest: pipe-B
[327.285184] Dynamic subtest pipe-B: SKIP (0.031s)
[327.293326] Starting dynamic subtest: pipe-C
[327.316896] Dynamic subtest pipe-C: SKIP (0.031s)
[327.325063] Starting dynamic subtest: pipe-D
[327.349962] Dynamic subtest pipe-D: SKIP (0.031s)
[327.354081] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.113s)
[327.482993] [057/131] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[327.590027] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[334.300445] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.712s)
[334.473152] [058/131] (685s left) gem_eio (in-flight-10ms)
[334.701622] Starting subtest: in-flight-10ms
[343.092516] Subtest in-flight-10ms: SUCCESS (8.390s)
[343.311683] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[343.314957] [059/131] (676s left) kms_plane_lowres (tiling-4)
[343.432050] Starting subtest: tiling-4
[343.434355] Starting dynamic subtest: pipe-A-eDP-1
[343.439288] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[343.724846] Starting dynamic subtest: pipe-B-eDP-1
[343.729510] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[343.738796] Starting dynamic subtest: pipe-C-eDP-1
[343.743451] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[343.751836] Starting dynamic subtest: pipe-D-eDP-1
[343.756344] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[343.760763] Subtest tiling-4: SKIP (0.294s)
[344.639543] [060/131] (675s left) gen9_exec_parse (bb-start-cmd)
[344.707796] Subtest bb-start-cmd: SKIP (0.000s)
[344.792940] [061/131] (675s left) kms_selftest (drm_cmdline_parser)
[344.832835] Starting subtest: drm_cmdline_parser
[344.844044] Starting dynamic subtest: drm_test_cmdline_force_d_only
[344.948738] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.103s)
[344.958663] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[345.085118] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.135s)
[345.095062] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[345.214126] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.128s)
[345.224312] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[345.356072] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.141s)
[345.366101] Starting dynamic subtest: drm_test_cmdline_force_e_only
[345.485920] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.129s)
[345.496273] Starting dynamic subtest: drm_test_cmdline_res
[345.617098] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.131s)
[345.627046] Starting dynamic subtest: drm_test_cmdline_res_vesa
[345.776154] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.158s)
[345.785825] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[345.884364] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.108s)
[345.893592] Starting dynamic subtest: drm_test_cmdline_res_rblank
[345.999489] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.113s)
[346.010044] Starting dynamic subtest: drm_test_cmdline_res_bpp
[346.103046] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.104s)
[346.112996] Starting dynamic subtest: drm_test_cmdline_res_refresh
[346.222051] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.118s)
[346.232598] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[346.337099] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.113s)
[346.347052] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[346.446304] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.111s)
[346.456668] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[346.551912] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.104s)
[346.560248] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[346.660919] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.109s)
[346.669304] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[346.783113] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.119s)
[346.793307] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[346.911084] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.127s)
[346.921175] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[347.027054] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.115s)
[347.036721] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[347.141736] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.116s)
[347.149785] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[347.248147] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.105s)
[347.257623] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[347.369680] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.120s)
[347.379395] Starting dynamic subtest: drm_test_cmdline_name
[347.443284] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.075s)
[347.451769] Starting dynamic subtest: drm_test_cmdline_name_bpp
[347.589543] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.141s)
[347.604568] Starting dynamic subtest: drm_test_cmdline_name_option
[347.724896] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.135s)
[347.733115] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[347.854292] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.130s)
[347.862255] Starting dynamic subtest: drm_test_cmdline_rotate_0
[347.993996] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.136s)
[348.003118] Starting dynamic subtest: drm_test_cmdline_rotate_90
[348.127652] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.133s)
[348.135805] Starting dynamic subtest: drm_test_cmdline_rotate_180
[348.232164] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.104s)
[348.240537] Starting dynamic subtest: drm_test_cmdline_rotate_270
[348.349836] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.115s)
[348.358538] Starting dynamic subtest: drm_test_cmdline_hmirror
[348.457116] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.107s)
[348.465536] Starting dynamic subtest: drm_test_cmdline_vmirror
[348.581091] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.123s)
[348.589198] Starting dynamic subtest: drm_test_cmdline_margin_options
[348.692060] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.111s)
[348.700443] Starting dynamic subtest: drm_test_cmdline_multiple_options
[348.792929] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.100s)
[348.801275] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[348.924993] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.130s)
[348.933665] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[349.060641] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.136s)
[349.069076] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[349.172171] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.111s)
[349.181199] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[349.289340] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.116s)
[349.298374] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[349.367422] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.077s)
[349.377337] Starting dynamic subtest: drm_test_cmdline_invalid
[349.469303] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.102s)
[349.484337] Starting dynamic subtest: drm_test_cmdline_tv_options
[349.593759] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.125s)
[349.596159] Subtest drm_cmdline_parser: SUCCESS (4.764s)
[349.821416] [062/131] (670s left) kms_content_protection (content-type-change)
[349.972657] Starting subtest: content-type-change
[349.977129] Subtest content-type-change: SKIP (0.000s)
[350.146904] [063/131] (670s left) api_intel_bb (delta-check)
[350.208621] Starting subtest: delta-check
[350.211354] Subtest delta-check: SUCCESS (0.006s)
[350.369832] [064/131] (669s left) gem_render_copy (y-tiled-ccs-to-linear)
[350.443314] Starting subtest: y-tiled-ccs-to-linear
[350.447852] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[350.653414] [065/131] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[350.750315] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[350.754774] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[350.875560] [066/131] (669s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[350.978190] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[350.982552] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[351.099388] [067/131] (669s left) kms_psr (psr2-cursor-plane-onoff)
[351.190127] Starting subtest: psr2-cursor-plane-onoff
[351.192450] Starting dynamic subtest: eDP-1
[352.939964] Dynamic subtest eDP-1: SUCCESS (1.750s)
[352.942297] Subtest psr2-cursor-plane-onoff: SUCCESS (1.751s)
[353.822339] [068/131] (666s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[353.928793] Starting subtest: extended-pageflip-modeset-hang-oldfb
[353.930976] Starting dynamic subtest: pipe-A
[361.820867] Dynamic subtest pipe-A: SUCCESS (7.891s)
[361.829922] Starting dynamic subtest: pipe-D
[370.477268] Dynamic subtest pipe-D: SUCCESS (8.652s)
[370.479539] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.548s)
[371.322063] [069/131] (649s left) gem_ctx_param (get-priority-new-ctx)
[371.373358] Starting subtest: get-priority-new-ctx
[371.375680] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[371.513627] [070/131] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[371.604557] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[371.608990] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[371.754904] [071/131] (648s left) gem_ctx_param (invalid-set-ringsize)
[371.812021] Starting subtest: invalid-set-ringsize
[371.814536] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[371.910930] [072/131] (648s left) kms_frontbuffer_tracking (fbc-stridechange)
[372.018619] Starting subtest: fbc-stridechange
[375.337338] Subtest fbc-stridechange: SUCCESS (3.321s)
[376.548456] [073/131] (644s left) i915_hangman (gt-error-state-capture)
[376.612246] Starting subtest: gt-error-state-capture
[376.614619] Starting dynamic subtest: rcs0
[386.868271] Dynamic subtest rcs0: SUCCESS (10.256s)
[386.880381] Starting dynamic subtest: bcs0
[398.836388] Dynamic subtest bcs0: SUCCESS (11.965s)
[398.847682] Starting dynamic subtest: vcs0
[409.844488] Dynamic subtest vcs0: SUCCESS (11.004s)
[409.856458] Starting dynamic subtest: vcs1
[421.813470] Dynamic subtest vcs1: SUCCESS (11.966s)
[421.827519] Starting dynamic subtest: vecs0
[431.860037] Dynamic subtest vecs0: SUCCESS (10.044s)
[431.872232] Starting dynamic subtest: ccs0
[443.892033] Dynamic subtest ccs0: SUCCESS (12.029s)
[443.894691] Subtest gt-error-state-capture: SUCCESS (67.280s)
[443.998555] [074/131] (576s left) kms_psr (psr2-sprite-blt)
[444.100045] Starting subtest: psr2-sprite-blt
[444.102397] Starting dynamic subtest: eDP-1
[445.855662] Dynamic subtest eDP-1: SUCCESS (1.755s)
[445.857912] Subtest psr2-sprite-blt: SUCCESS (1.756s)
[446.707654] [075/131] (574s left) gem_exec_reloc (basic-cpu)
[446.762581] Subtest basic-cpu: SKIP (0.000s)
[446.858089] [076/131] (573s left) gem_mmap_gtt (hang)
[446.905621] Subtest hang: SKIP (0.000s)
[446.969095] [077/131] (573s left) kms_frontbuffer_tracking (fbc-2p-rte)
[447.081367] Starting subtest: fbc-2p-rte
[447.085434] Subtest fbc-2p-rte: SKIP (0.000s)
[447.212868] [078/131] (573s left) gem_exec_reloc (basic-gtt-read-active)
[447.280690] Subtest basic-gtt-read-active: SKIP (0.000s)
[447.350371] [079/131] (573s left) gem_mmap_offset (mmap-unmap)
[447.404097] Starting subtest: mmap-unmap
[447.406025] Starting dynamic subtest: smem0
[470.384024] Dynamic subtest smem0: SUCCESS (22.980s)
[470.387058] Subtest mmap-unmap: SUCCESS (22.980s)
[470.545808] [080/131] (550s left) gem_exec_whisper (basic-contexts-priority-all)
[470.624417] Starting subtest: basic-contexts-priority-all
[494.996137] Subtest basic-contexts-priority-all: SUCCESS (24.373s)
[495.207697] [081/131] (525s left) gem_barrier_race (remote-request)
[495.278049] Starting subtest: remote-request
[495.280053] Starting dynamic subtest: rcs0
[500.459534] Dynamic subtest rcs0: SUCCESS (5.184s)
[500.461496] Subtest remote-request: SUCCESS (5.185s)
[500.676511] [082/131] (520s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[500.791303] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[500.793286] Starting dynamic subtest: pipe-A-eDP-1
[500.812308] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[500.822652] Starting dynamic subtest: pipe-B-eDP-1
[500.840245] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[500.848325] Starting dynamic subtest: pipe-C-eDP-1
[500.865740] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[500.873973] Starting dynamic subtest: pipe-D-eDP-1
[500.892147] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[500.895679] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[503.024101] [083/131] (518s left) gem_exec_reloc (basic-write-read)
[503.077518] Subtest basic-write-read: SKIP (0.000s)
[503.152694] [084/131] (517s left) api_intel_bb (blit-reloc-purge-cache)
[503.207116] Starting subtest: blit-reloc-purge-cache
[503.211518] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[503.360352] [085/131] (517s left) kms_chamelium_edid (hdmi-edid-read)
[503.745609] Subtest hdmi-edid-read: SKIP (0.000s)
[504.559986] [086/131] (516s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[509.574157] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[509.578685] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[510.406046] [087/131] (510s left) gem_ctx_engines (independent)
[510.468052] Starting subtest: independent
[510.470306] Starting dynamic subtest: rcs0
[510.612295] Dynamic subtest rcs0: SUCCESS (0.143s)
[510.625250] Starting dynamic subtest: bcs0
[510.748756] Dynamic subtest bcs0: SUCCESS (0.135s)
[510.760080] Starting dynamic subtest: vcs0
[510.890229] Dynamic subtest vcs0: SUCCESS (0.141s)
[510.901920] Starting dynamic subtest: vcs1
[511.055901] Dynamic subtest vcs1: SUCCESS (0.165s)
[511.065081] Starting dynamic subtest: vecs0
[511.219531] Dynamic subtest vecs0: SUCCESS (0.163s)
[511.229057] Starting dynamic subtest: ccs0
[511.383832] Dynamic subtest ccs0: SUCCESS (0.164s)
[511.393190] Starting dynamic subtest: all-engines
[512.193687] Dynamic subtest all-engines: SUCCESS (0.808s)
[512.196575] Subtest independent: SUCCESS (1.725s)
[514.020268] [088/131] (507s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[514.148250] Starting subtest: basic-flip-after-cursor-varying-size
[515.077984] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.930s)
[515.907494] [089/131] (505s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[516.031646] Starting subtest: yf-tiled-8bpp-rotate-0
[516.036087] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[516.170857] [090/131] (505s left) gem_eio (in-flight-internal-1us)
[516.405094] Starting subtest: in-flight-internal-1us
[517.986844] Subtest in-flight-internal-1us: SUCCESS (1.582s)
[518.129362] [091/131] (503s left) gem_spin_batch (legacy-resubmit-new)
[518.200484] Starting subtest: legacy-resubmit-new
[518.202792] Starting dynamic subtest: default
[518.208000] Dynamic subtest default: SUCCESS (0.007s)
[518.216652] Starting dynamic subtest: render
[518.218479] Dynamic subtest render: SUCCESS (0.003s)
[518.227217] Starting dynamic subtest: bsd
[518.229309] Dynamic subtest bsd: SUCCESS (0.005s)
[518.238249] Starting dynamic subtest: bsd1
[518.240310] Dynamic subtest bsd1: SUCCESS (0.003s)
[518.248912] Starting dynamic subtest: bsd2
[518.250893] Dynamic subtest bsd2: SUCCESS (0.004s)
[518.259604] Starting dynamic subtest: blt
[518.261426] Dynamic subtest blt: SUCCESS (0.004s)
[518.269806] Starting dynamic subtest: vebox
[518.271778] Dynamic subtest vebox: SUCCESS (0.005s)
[518.274192] Subtest legacy-resubmit-new: SUCCESS (0.039s)
[519.958094] [092/131] (501s left) gem_exec_params (dr1-dirt)
[520.019836] Starting subtest: DR1-dirt
[520.021782] Subtest DR1-dirt: SUCCESS (0.000s)
[520.148317] [093/131] (501s left) kms_getfb (getfb-repeated-different-handles)
[520.247514] Starting subtest: getfb-repeated-different-handles
[520.249676] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[520.397403] [094/131] (501s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[520.502269] Starting subtest: primary-x-tiled-reflect-x-180
[527.753349] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.252s)
[529.009328] [095/131] (492s left) kms_hdr (invalid-hdr)
[529.116433] Starting subtest: invalid-hdr
[531.320590] Starting dynamic subtest: pipe-A-eDP-1
[534.227400] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.912s)
[534.229810] Subtest invalid-hdr: SUCCESS (5.114s)
[534.372630] [096/131] (487s left) gem_exec_fence (syncobj-channel)
[534.829650] Starting subtest: syncobj-channel
[535.849854] Subtest syncobj-channel: SUCCESS (1.016s)
[536.160262] [097/131] (485s left) gem_ctx_persistence (processes)
[536.232138] Starting subtest: processes
[537.939464] Subtest processes: SUCCESS (1.707s)
[538.044306] [098/131] (483s left) perf_pmu (semaphore-busy)
[538.091016] Starting subtest: semaphore-busy
[538.093423] Starting dynamic subtest: rcs0
[539.715228] Dynamic subtest rcs0: SUCCESS (1.620s)
[539.726828] Starting dynamic subtest: bcs0
[540.343332] Dynamic subtest bcs0: FAIL (0.573s)
[540.353744] Starting dynamic subtest: vcs0
[544.400240] Dynamic subtest vcs0: SUCCESS (4.110s)
[544.412078] Starting dynamic subtest: vcs1
[550.416473] Dynamic subtest vcs1: SUCCESS (6.013s)
[550.428872] Starting dynamic subtest: vecs0
[556.431621] Dynamic subtest vecs0: SUCCESS (6.012s)
[556.440850] Starting dynamic subtest: ccs0
[558.495130] Dynamic subtest ccs0: FAIL (1.993s)
[558.497192] Subtest semaphore-busy: FAIL (20.333s)
[558.587206] [099/131] (463s left) kms_pm_lpsp (screens-disabled)
[559.692222] Starting subtest: screens-disabled
[559.696286] Subtest screens-disabled: SKIP (0.000s)
[559.788451] [100/131] (462s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[559.873819] Starting subtest: fbc-psr2-cursor-plane-onoff
[559.876029] Starting dynamic subtest: eDP-1
[559.880028] Dynamic subtest eDP-1: SKIP (0.000s)
[559.884230] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[559.970685] [101/131] (461s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[560.067855] Starting subtest: y-tiled-32bpp-rotate-180
[560.072110] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[560.204877] [102/131] (461s left) gem_exec_async (concurrent-writes)
[560.269133] Starting subtest: concurrent-writes
[560.271014] Starting dynamic subtest: rcs0
[560.281448] Dynamic subtest rcs0: SUCCESS (0.015s)
[560.293204] Starting dynamic subtest: bcs0
[560.295699] Dynamic subtest bcs0: SUCCESS (0.006s)
[560.304810] Starting dynamic subtest: vcs0
[560.307057] Dynamic subtest vcs0: SUCCESS (0.005s)
[560.315956] Starting dynamic subtest: vcs1
[560.318125] Dynamic subtest vcs1: SUCCESS (0.006s)
[560.326642] Starting dynamic subtest: vecs0
[560.328710] Dynamic subtest vecs0: SUCCESS (0.005s)
[560.337105] Starting dynamic subtest: ccs0
[560.339171] Dynamic subtest ccs0: SUCCESS (0.005s)
[560.341240] Subtest concurrent-writes: SUCCESS (0.046s)
[560.565860] [103/131] (461s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[560.625259] Starting subtest: single-wait-all-for-submit-signaled
[560.627594] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[560.745639] [104/131] (461s left) syncobj_timeline (signal)
[560.800247] Starting subtest: signal
[560.802207] Subtest signal: SUCCESS (0.000s)
[560.934399] [105/131] (461s left) kms_vrr (max-min)
[561.029832] Starting subtest: max-min
[561.035251] Subtest max-min: SKIP (0.000s)
[561.127455] [106/131] (460s left) sysfs_heartbeat_interval (idempotent)
[561.186670] Starting subtest: idempotent
[561.188602] Starting dynamic subtest: vecs0
[561.190586] Dynamic subtest vecs0: SUCCESS (0.001s)
[561.200615] Starting dynamic subtest: ccs0
[561.202624] Dynamic subtest ccs0: SUCCESS (0.001s)
[561.211089] Starting dynamic subtest: vcs0
[561.212905] Dynamic subtest vcs0: SUCCESS (0.001s)
[561.221239] Starting dynamic subtest: bcs0
[561.223034] Dynamic subtest bcs0: SUCCESS (0.001s)
[561.231412] Starting dynamic subtest: rcs0
[561.233360] Dynamic subtest rcs0: SUCCESS (0.001s)
[561.243952] Starting dynamic subtest: vcs1
[561.245837] Dynamic subtest vcs1: SUCCESS (0.001s)
[561.247459] Subtest idempotent: SUCCESS (0.014s)
[561.329547] [107/131] (460s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[561.420689] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[561.431502] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[561.532551] [108/131] (460s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[561.634189] Starting subtest: 4-tiled-16bpp-rotate-0
[564.053581] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (2.418s)
[564.221270] [109/131] (457s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[564.613162] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[565.457844] [110/131] (456s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[570.575239] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[570.577502] Starting dynamic subtest: pipe-A-eDP-1
[571.321905] Dynamic subtest pipe-A-eDP-1: SKIP (0.745s)
[571.331766] Starting dynamic subtest: pipe-B-eDP-1
[572.526680] Dynamic subtest pipe-B-eDP-1: SKIP (1.204s)
[572.531057] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.953s)
[573.802320] [111/131] (448s left) gem_fence_thrash (bo-write-verify-threaded-y)
[573.845053] Starting subtest: bo-write-verify-threaded-y
[573.872303] Subtest bo-write-verify-threaded-y: SKIP (0.024s)
[573.947253] [112/131] (448s left) kms_flip (basic-flip-vs-wf_vblank)
[574.042049] Starting subtest: basic-flip-vs-wf_vblank
[574.044241] Starting dynamic subtest: A-eDP1
[575.991958] Dynamic subtest A-eDP1: SUCCESS (1.949s)
[576.004075] Starting dynamic subtest: B-eDP1
[577.899135] Dynamic subtest B-eDP1: SUCCESS (1.904s)
[577.910497] Starting dynamic subtest: C-eDP1
[579.781213] Dynamic subtest C-eDP1: SUCCESS (1.880s)
[579.792353] Starting dynamic subtest: D-eDP1
[581.689635] Dynamic subtest D-eDP1: SUCCESS (1.908s)
[581.694413] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.651s)
[582.910525] [113/131] (439s left) kms_chamelium_color (ctm-green-to-red)
[583.021975] Subtest ctm-green-to-red: SKIP (0.000s)
[583.067635] [114/131] (439s left) gem_media_vme
[583.222752] [115/131] (439s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[583.323551] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[584.281036] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.959s)
[584.472122] [116/131] (437s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[584.538619] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[584.543407] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[584.753467] [117/131] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[584.858969] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[591.803256] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.947s)
[591.940563] [118/131] (430s left) kms_flip (busy-flip)
[592.043103] Starting subtest: busy-flip
[592.045390] Starting dynamic subtest: A-eDP1
[593.762058] Dynamic subtest A-eDP1: SUCCESS (1.719s)
[593.773142] Starting dynamic subtest: B-eDP1
[595.451745] Dynamic subtest B-eDP1: SUCCESS (1.688s)
[595.463142] Starting dynamic subtest: C-eDP1
[597.148597] Dynamic subtest C-eDP1: SUCCESS (1.695s)
[597.162719] Starting dynamic subtest: D-eDP1
[598.850929] Dynamic subtest D-eDP1: SUCCESS (1.701s)
[598.853347] Subtest busy-flip: SUCCESS (6.812s)
[600.114623] [119/131] (422s left) gem_exec_schedule (preempt-queue-contexts-chain)
[600.199580] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[600.506508] [120/131] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[600.610113] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[623.524348] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.916s)
[623.720087] [121/131] (398s left) syncobj_basic (bad-destroy)
[623.778464] Starting subtest: bad-destroy
[623.780294] Subtest bad-destroy: SUCCESS (0.000s)
[623.908624] [122/131] (398s left) gem_mmap (basic)
[623.971773] Subtest basic: SKIP (0.000s)
[624.039649] [123/131] (398s left) kms_flip (wf_vblank-ts-check)
[624.138842] Starting subtest: wf_vblank-ts-check
[624.140925] Starting dynamic subtest: A-eDP1
[633.089207] Dynamic subtest A-eDP1: SUCCESS (8.950s)
[633.100979] Starting dynamic subtest: B-eDP1
[641.993288] Dynamic subtest B-eDP1: SUCCESS (8.901s)
[642.002611] Starting dynamic subtest: C-eDP1
[650.976314] Dynamic subtest C-eDP1: SUCCESS (8.979s)
[650.985665] Starting dynamic subtest: D-eDP1
[659.874987] Dynamic subtest D-eDP1: SUCCESS (8.897s)
[659.880207] Subtest wf_vblank-ts-check: SUCCESS (35.740s)
[661.101971] [124/131] (361s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[661.222246] Starting subtest: fbc-psr-cursor-mmap-gtt
[661.224609] Starting dynamic subtest: eDP-1
[661.228846] Dynamic subtest eDP-1: SKIP (0.000s)
[661.233095] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[661.321667] [125/131] (361s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[661.432398] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[661.436875] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[661.564972] [126/131] (361s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[661.674954] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[661.679202] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[661.813777] [127/131] (361s left) kms_vblank (query-busy)
[661.912678] Starting subtest: query-busy
[661.915057] Starting dynamic subtest: pipe-A-eDP-1
[663.785197] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[663.801449] Starting dynamic subtest: pipe-D-eDP-1
[666.317178] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s)
[666.319447] Subtest query-busy: SUCCESS (4.407s)
[667.195998] [128/131] (355s left) gem_pwrite (basic-random)
[667.255304] Subtest basic-random: SKIP (0.000s)
[667.317210] [129/131] (355s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[667.413531] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[667.417620] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[667.541973] [130/131] (355s left) gem_userptr_blits (huge-split)
[667.620487] Starting subtest: huge-split
[667.627051] Subtest huge-split: SUCCESS (0.006s)
[667.789009] [131/131] (355s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[667.914284] Starting subtest: psr-rgb101010-draw-blt
[675.202134] Subtest psr-rgb101010-draw-blt: SUCCESS (7.287s)
[675.360578] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_pipe_crc_basic
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: gem_gpgpu_fill
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: gem_exec_flush
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: drm_buddy
results: parsing output: 19/ for test: kms_psr2_su
results: parsing output: 20/ for test: prime_busy
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gen3_render_mixed_blits
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: gem_exec_big
results: parsing output: 33/ for test: kms_hdmi_inject
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: i915_query
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_getfb
results: parsing output: 43/ for test: kms_joiner
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_draw_crc
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_plane_lowres
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: kms_selftest
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_busy
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_hangman
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: gem_mmap_offset
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: gem_barrier_race
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: gem_ctx_engines
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_getfb
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_hdr
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_pm_lpsp
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_exec_async
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_vrr
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gem_fence_thrash
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: gem_media_vme
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: syncobj_basic
results: parsing output: 121/ for test: gem_mmap
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: gem_pwrite
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.