[57.092536] Initializing watchdogs
[57.092584]   /dev/watchdog0
[57.107242] [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.111790] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.114566] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.118106] [001/155] (960s left) gem_exec_create (madvise)
[57.201997] Starting subtest: madvise
[57.204286] Starting dynamic subtest: smem
[77.375247] Dynamic subtest smem: SUCCESS (20.311s)
[77.377592] Subtest madvise: SUCCESS (20.311s)
[78.121307] [002/155] (939s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[78.245792] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[78.250360] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[78.338966] [003/155] (939s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[78.434674] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[87.155403] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.731s)
[87.284179] [004/155] (930s left) gem_exec_flush (basic-wb-rw-before-default)
[87.347603] Starting subtest: basic-wb-rw-before-default
[92.805766] Subtest basic-wb-rw-before-default: SUCCESS (5.457s)
[93.001586] [005/155] (924s left) kms_cursor_crc (cursor-sliding-64x64)
[93.189407] Starting subtest: cursor-sliding-64x64
[93.194139] Starting dynamic subtest: pipe-A-eDP-1
[96.451773] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.256s)
[96.483738] Starting dynamic subtest: pipe-D-eDP-1
[100.367745] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.888s)
[100.370166] Subtest cursor-sliding-64x64: SUCCESS (7.175s)
[101.230514] [006/155] (916s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[101.331248] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[101.333647] Starting dynamic subtest: pipe-A-eDP-1
[101.356814] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.366449] Starting dynamic subtest: pipe-B-eDP-1
[101.388060] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.397675] Starting dynamic subtest: pipe-C-eDP-1
[101.418649] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.429319] Starting dynamic subtest: pipe-D-eDP-1
[101.451831] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.456298] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[103.604752] [007/155] (914s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[103.723902] Starting subtest: flip-vs-cursor-crc-legacy
[104.425687] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.702s)
[105.225193] [008/155] (912s left) kms_pm_rpm (drm-resources-equal)
[107.463197] Starting subtest: drm-resources-equal
[112.512230] Subtest drm-resources-equal: SUCCESS (5.050s)
[112.594136] [009/155] (905s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[112.645086] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[112.649460] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[112.825618] [010/155] (905s left) i915_selftest (perf)
[114.585847] Starting subtest: perf
[114.588363] Starting dynamic subtest: engine_cs
[117.391111] Dynamic subtest engine_cs: SUCCESS (2.805s)
[117.400296] Starting dynamic subtest: request
[122.780935] Dynamic subtest request: SUCCESS (5.389s)
[122.790244] Starting dynamic subtest: migrate
[125.660864] Dynamic subtest migrate: SUCCESS (2.879s)
[125.670656] Starting dynamic subtest: region
[131.429323] Dynamic subtest region: SUCCESS (5.767s)
[131.432143] Subtest perf: SUCCESS (16.844s)
[131.460528] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[131.463570] [011/155] (886s left) core_hotunplug (unbind-rebind)
[133.028411] Starting subtest: unbind-rebind
[139.007505] Subtest unbind-rebind: SUCCESS (5.980s)
[139.041015] [FACT core_hotunplug (unbind-rebind)] new: kernel.kmod_is_loaded.i915: true
[139.044826] [012/155] (879s left) gem_mmap_gtt (coherency)
[140.269051] Subtest coherency: SKIP (0.000s)
[140.364922] [013/155] (877s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[140.461886] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[140.466206] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[140.552099] [014/155] (877s left) prime_mmap (test_correct)
[140.608928] Starting subtest: test_correct
[140.610839] Starting dynamic subtest: test_correct-smem
[140.641598] Dynamic subtest test_correct-smem: SUCCESS (0.034s)
[140.644153] Subtest test_correct: SUCCESS (0.034s)
[140.748337] [015/155] (877s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[140.798671] Starting subtest: y-tiled-ccs-to-y-tiled
[140.803279] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[140.982473] [016/155] (877s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[141.089835] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[141.094311] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[141.176489] [017/155] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[141.276519] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[141.280973] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[141.385202] [018/155] (876s left) kms_psr (fbc-psr2-sprite-plane-move)
[141.476163] Starting subtest: fbc-psr2-sprite-plane-move
[141.478526] Starting dynamic subtest: eDP-1
[141.483066] Dynamic subtest eDP-1: SKIP (0.000s)
[141.487632] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[141.548640] [019/155] (876s left) kms_dsc (dsc-with-output-formats)
[141.635833] Starting subtest: dsc-with-output-formats
[141.657599] Subtest dsc-with-output-formats: SKIP (0.001s)
[141.707122] [020/155] (876s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[141.804546] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[145.986798] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.189s)
[147.143648] [021/155] (871s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[147.235219] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[153.954845] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.722s)
[154.092958] [022/155] (864s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[154.197507] Starting subtest: yf-tiled-64bpp-rotate-180
[154.201717] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[154.307964] [023/155] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[154.397199] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[160.967173] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.575s)
[161.078899] [024/155] (857s left) kms_invalid_mode (bad-vsync-end)
[161.179076] Starting subtest: bad-vsync-end
[161.181317] Starting dynamic subtest: pipe-A-eDP-1
[161.470943] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[161.480598] Starting dynamic subtest: pipe-B-eDP-1
[161.482912] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[161.491721] Starting dynamic subtest: pipe-C-eDP-1
[161.494092] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[161.502784] Starting dynamic subtest: pipe-D-eDP-1
[161.505153] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[161.507499] Subtest bad-vsync-end: SUCCESS (0.299s)
[162.355252] [025/155] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[162.456418] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[162.460746] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[162.559210] [026/155] (856s left) gem_ctx_isolation (preservation-s3)
[162.620743] Starting subtest: preservation-S3
[162.622968] Starting dynamic subtest: rcs0
[179.304734] Dynamic subtest rcs0: SUCCESS (1.446s)
[179.314884] Starting dynamic subtest: bcs0
[195.265856] Dynamic subtest bcs0: SUCCESS (1.348s)
[195.276798] Starting dynamic subtest: vcs0
[211.275170] Dynamic subtest vcs0: SUCCESS (3.080s)
[211.288006] Starting dynamic subtest: vcs1
[229.275116] Dynamic subtest vcs1: SUCCESS (5.116s)
[229.285847] Starting dynamic subtest: vecs0
[247.269677] Dynamic subtest vecs0: SUCCESS (5.078s)
[247.279752] Starting dynamic subtest: ccs0
[265.279207] Dynamic subtest ccs0: SUCCESS (3.304s)
[265.281431] Subtest preservation-S3: SUCCESS (19.377s)
[265.515051] [027/155] (753s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[265.620255] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[265.624208] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[265.713971] [028/155] (752s left) gem_exec_params (rel-constants-invalid-ring)
[265.770007] Starting subtest: rel-constants-invalid-ring
[265.772325] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[265.880957] [029/155] (752s left) perf (polling)
[265.995878] Starting subtest: polling
[265.997938] Starting dynamic subtest: 0-rcs0
[276.098789] Dynamic subtest 0-rcs0: FAIL (10.188s)
[276.110636] Starting dynamic subtest: 1-vecs0
[286.070607] Dynamic subtest 1-vecs0: SUCCESS (10.057s)
[286.073688] Subtest polling: FAIL (20.247s)
[286.121186] [030/155] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[286.231894] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[286.236135] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[286.338694] [031/155] (732s left) kms_big_fb (linear-8bpp-rotate-90)
[286.437660] Starting subtest: linear-8bpp-rotate-90
[286.459554] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[286.572828] [032/155] (732s left) gem_exec_fence (nb-await)
[286.755233] Starting subtest: nb-await
[286.757810] Starting dynamic subtest: rcs0
[286.826646] Dynamic subtest rcs0: SUCCESS (0.072s)
[286.838630] Starting dynamic subtest: bcs0
[286.884391] Dynamic subtest bcs0: SUCCESS (0.057s)
[286.896555] Starting dynamic subtest: vcs0
[286.943490] Dynamic subtest vcs0: SUCCESS (0.057s)
[286.954771] Starting dynamic subtest: vcs1
[287.003705] Dynamic subtest vcs1: SUCCESS (0.058s)
[287.016928] Starting dynamic subtest: vecs0
[287.063391] Dynamic subtest vecs0: SUCCESS (0.058s)
[287.079332] Starting dynamic subtest: ccs0
[287.124701] Dynamic subtest ccs0: SUCCESS (0.059s)
[287.127635] Subtest nb-await: SUCCESS (0.372s)
[289.094796] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[289.098141] [033/155] (729s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[289.200992] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[289.205026] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[289.284871] [034/155] (729s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[289.369387] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[289.371492] Starting dynamic subtest: pipe-A-eDP-1
[289.391817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[289.402053] Starting dynamic subtest: pipe-B-eDP-1
[289.421945] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[289.431492] Starting dynamic subtest: pipe-C-eDP-1
[289.451051] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[289.461883] Starting dynamic subtest: pipe-D-eDP-1
[289.481689] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[289.483948] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[291.650113] [035/155] (727s left) i915_getparams_basic (basic-eu-total)
[291.711006] Starting subtest: basic-eu-total
[291.715154] Subtest basic-eu-total: SUCCESS (0.000s)
[291.816327] [036/155] (727s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[291.951898] Starting subtest: flip-vs-cursor-busy-crc-atomic
[292.676895] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.724s)
[293.486446] [037/155] (725s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[293.586969] Starting subtest: 4-tiled-64bpp-rotate-0
[295.153629] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.567s)
[295.316324] [038/155] (723s left) gem_flink_basic (bad-open)
[295.366111] Starting subtest: bad-open
[295.368498] Subtest bad-open: SUCCESS (0.000s)
[295.492487] [039/155] (723s left) gem_exec_schedule (fairslice-all)
[295.557638] Starting subtest: fairslice-all
[297.621668] Subtest fairslice-all: SUCCESS (2.074s)
[299.030648] [040/155] (720s left) kms_prop_blob (invalid-get-prop-any)
[299.085932] Starting subtest: invalid-get-prop-any
[299.088036] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[299.174182] [041/155] (720s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt)
[299.289504] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt
[299.293797] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[299.398539] [042/155] (719s left) gem_render_linear_blits (basic)
[299.458334] Starting subtest: basic
[299.481835] Subtest basic: SUCCESS (0.023s)
[299.579892] [043/155] (719s left) gem_mmap_wc (bad-size)
[299.632255] Subtest bad-size: SKIP (0.000s)
[299.698794] [044/155] (719s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[299.754866] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[299.862279] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[299.952109] [045/155] (719s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[300.044623] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[300.046832] Starting dynamic subtest: pipe-A-eDP-1
[300.980351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.933s)
[300.991328] Starting dynamic subtest: pipe-B-eDP-1
[302.693990] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.719s)
[302.705898] Starting dynamic subtest: pipe-C-eDP-1
[304.269060] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.579s)
[304.279084] Starting dynamic subtest: pipe-D-eDP-1
[305.807975] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.541s)
[305.810241] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.776s)
[306.961016] [046/155] (712s left) gem_mmap_gtt (cpuset-medium-copy)
[307.025998] Subtest cpuset-medium-copy: SKIP (0.000s)
[307.091364] [047/155] (712s left) sw_sync (alloc_fence_invalid_timeline)
[307.125590] Starting subtest: alloc_fence_invalid_timeline
[307.128084] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[307.176991] [048/155] (712s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[307.279252] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[307.283261] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[307.386257] [049/155] (712s left) kms_fbcon_fbt (psr)
[307.446428] Starting subtest: psr
[314.879086] Subtest psr: SUCCESS (7.439s)
[314.960187] [050/155] (704s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[315.021940] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[315.024364] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[315.141545] [051/155] (704s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[315.229332] Starting subtest: stress-xrgb8888-4tiled
[321.199105] Subtest stress-xrgb8888-4tiled: SUCCESS (5.975s)
[321.264524] [052/155] (698s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[321.368182] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[321.371576] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[321.471994] [053/155] (698s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[321.519950] Starting subtest: single-wait-all-for-submit-signaled
[321.521946] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[321.633135] [054/155] (698s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[321.730532] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[321.734087] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[321.835795] [055/155] (697s left) gen9_exec_parse (bb-secure)
[321.897993] Subtest bb-secure: SKIP (0.000s)
[321.986829] [056/155] (697s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[322.082102] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[322.086101] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[322.171180] [057/155] (697s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[322.269855] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[322.295888] Starting dynamic subtest: pipe-A-plane-0
[322.595485] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[322.607646] Starting dynamic subtest: pipe-A-plane-3
[322.828497] Dynamic subtest pipe-A-plane-3: SUCCESS (0.230s)
[322.838675] Starting dynamic subtest: pipe-A-plane-5
[322.843378] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[323.964859] Starting dynamic subtest: pipe-B-plane-0
[324.256415] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[324.266873] Starting dynamic subtest: pipe-B-plane-3
[324.488875] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[324.499075] Starting dynamic subtest: pipe-B-plane-5
[324.504088] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[324.808470] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.540s)
[325.640136] [058/155] (694s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[325.738707] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[325.743472] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[325.836551] [059/155] (694s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[325.949232] Starting subtest: cursorA-vs-flipA-toggle
[337.083392] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.132s)
[337.965148] [060/155] (682s left) vgem_basic (create)
[338.005893] Starting subtest: create
[338.007819] Subtest create: SUCCESS (0.000s)
[338.065374] [061/155] (681s left) gem_exec_params (secure-non-root)
[338.117691] Starting subtest: secure-non-root
[338.122156] Subtest secure-non-root: SKIP (0.000s)
[338.211020] [062/155] (681s left) gem_ctx_persistence (legacy-engines-hang)
[338.259563] Starting subtest: legacy-engines-hang
[338.261880] Starting dynamic subtest: render
[338.344088] Dynamic subtest render: SUCCESS (0.083s)
[338.356628] Starting dynamic subtest: bsd1
[338.445490] Dynamic subtest bsd1: SUCCESS (0.099s)
[338.461475] Starting dynamic subtest: bsd2
[338.570390] Dynamic subtest bsd2: SUCCESS (0.122s)
[338.586000] Starting dynamic subtest: blt
[338.667449] Dynamic subtest blt: SUCCESS (0.094s)
[338.681082] Starting dynamic subtest: vebox
[338.746424] Dynamic subtest vebox: SUCCESS (0.076s)
[338.748870] Subtest legacy-engines-hang: SUCCESS (0.488s)
[338.871459] [063/155] (681s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[338.972524] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[338.976226] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[339.085654] [064/155] (681s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[339.175126] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[340.011261] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[340.167501] [065/155] (680s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[340.227124] Starting subtest: multi-wait-for-submit-available-submitted
[340.229013] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[340.324687] [066/155] (679s left) gem_exec_async (forked-writes)
[340.388299] Starting subtest: forked-writes
[340.390627] Starting dynamic subtest: rcs0
[340.415964] Dynamic subtest rcs0: SUCCESS (0.027s)
[340.430552] Starting dynamic subtest: bcs0
[340.444491] Dynamic subtest bcs0: SUCCESS (0.028s)
[340.454885] Starting dynamic subtest: vcs0
[340.466462] Dynamic subtest vcs0: SUCCESS (0.021s)
[340.477435] Starting dynamic subtest: vcs1
[340.490160] Dynamic subtest vcs1: SUCCESS (0.023s)
[340.501619] Starting dynamic subtest: vecs0
[340.517307] Dynamic subtest vecs0: SUCCESS (0.026s)
[340.528240] Starting dynamic subtest: ccs0
[340.541873] Dynamic subtest ccs0: SUCCESS (0.024s)
[340.544045] Subtest forked-writes: SUCCESS (0.154s)
[340.767695] [067/155] (679s left) gem_exec_fence (basic-wait-all)
[340.822684] Starting subtest: basic-wait-all
[340.910530] Subtest basic-wait-all: SUCCESS (0.088s)
[343.118128] [068/155] (677s left) gem_create (create-ext-placement-all)
[343.290394] Starting subtest: create-ext-placement-all
[343.292620] Subtest create-ext-placement-all: SUCCESS (0.000s)
[343.390022] [069/155] (676s left) kms_busy (extended-modeset-hang-newfb)
[343.496839] Starting subtest: extended-modeset-hang-newfb
[343.499275] Starting dynamic subtest: pipe-A
[377.966050] Dynamic subtest pipe-A: SUCCESS (34.475s)
[377.977420] Starting dynamic subtest: pipe-D
[400.911571] Dynamic subtest pipe-D: SUCCESS (22.943s)
[400.914649] Subtest extended-modeset-hang-newfb: SUCCESS (57.423s)
[401.804898] [070/155] (618s left) gem_mmap_offset (isolation)
[401.860544] Starting subtest: isolation
[401.877493] Subtest isolation: SUCCESS (0.007s)
[401.963566] [071/155] (618s left) gen9_exec_parse (unaligned-jump)
[402.009448] Subtest unaligned-jump: SKIP (0.000s)
[402.075391] [072/155] (618s left) kms_psr (psr-cursor-plane-onoff)
[402.168259] Starting subtest: psr-cursor-plane-onoff
[402.170416] Starting dynamic subtest: eDP-1
[403.915808] Dynamic subtest eDP-1: SUCCESS (1.745s)
[403.918046] Subtest psr-cursor-plane-onoff: SUCCESS (1.746s)
[404.773541] [073/155] (615s left) kms_hdr (invalid-metadata-sizes)
[404.866618] Starting subtest: invalid-metadata-sizes
[404.868947] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[404.873539] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[404.884407] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[404.888605] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[404.892828] Subtest invalid-metadata-sizes: SKIP (0.003s)
[404.948439] [074/155] (615s left) gem_exec_reloc (basic-gtt)
[405.013385] Subtest basic-gtt: SKIP (0.000s)
[405.089332] [075/155] (615s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[405.185032] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[405.189351] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[405.285242] [076/155] (615s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[405.387820] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[405.392034] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[405.481801] [077/155] (615s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[405.539477] Starting subtest: invalid-bsd2-flag-on-blt
[405.541690] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[405.662683] [078/155] (615s left) kms_content_protection (dp-mst-lic-type-0)
[405.807527] Starting subtest: dp-mst-lic-type-0
[405.811935] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[405.947350] [079/155] (614s left) prime_self_import (basic-with_two_bos)
[405.983619] Starting subtest: basic-with_two_bos
[406.011319] Subtest basic-with_two_bos: SUCCESS (0.029s)
[406.123168] [080/155] (614s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[406.175243] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[406.179020] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[406.365290] [081/155] (614s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[406.458958] Starting subtest: fbc-rgb565-draw-render
[410.706896] Subtest fbc-rgb565-draw-render: SUCCESS (4.252s)
[411.879129] [082/155] (609s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[411.980986] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[411.985557] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[412.083279] [083/155] (608s left) gem_userptr_blits (userfault)
[412.152053] Starting subtest: userfault
[412.154492] Subtest userfault: SUCCESS (0.007s)
[412.283858] [084/155] (608s left) gem_exec_whisper (basic-contexts-priority)
[412.345615] Starting subtest: basic-contexts-priority
[435.698810] Subtest basic-contexts-priority: SUCCESS (23.350s)
[435.891464] [085/155] (585s left) i915_pm_rps (min-max-config-loaded)
[435.959484] Starting subtest: min-max-config-loaded
[435.964415] Subtest min-max-config-loaded: SKIP (0.002s)
[436.094361] [086/155] (585s left) kms_psr (fbc-pr-basic)
[436.196748] Starting subtest: fbc-pr-basic
[436.201224] Subtest fbc-pr-basic: SKIP (0.000s)
[436.274224] [087/155] (584s left) gem_partial_pwrite_pread (reads-snoop)
[436.329086] Subtest reads-snoop: SKIP (0.000s)
[436.419825] [088/155] (584s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[436.808752] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[437.669236] [089/155] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[437.782030] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[437.786263] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[437.871209] [090/155] (583s left) gem_softpin (evict-single-offset)
[437.932647] Starting subtest: evict-single-offset
[466.002222] Subtest evict-single-offset: SUCCESS (28.071s)
[466.107086] [091/155] (555s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[466.276843] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[466.280951] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[466.349343] [092/155] (555s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[466.443172] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[466.447264] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[466.545962] [093/155] (554s left) kms_cursor_crc (cursor-offscreen-256x256)
[466.780385] Starting subtest: cursor-offscreen-256x256
[466.786239] Starting dynamic subtest: pipe-A-eDP-1
[468.767980] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.984s)
[468.803264] Starting dynamic subtest: pipe-D-eDP-1
[471.382529] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[471.384933] Subtest cursor-offscreen-256x256: SUCCESS (4.603s)
[472.240832] [094/155] (549s left) kms_plane (plane-panning-bottom-right-suspend)
[472.330367] Starting subtest: plane-panning-bottom-right-suspend
[472.332659] Starting dynamic subtest: pipe-A
[490.628524] Dynamic subtest pipe-A: SUCCESS (2.834s)
[490.639788] Starting dynamic subtest: pipe-B
[508.637799] Dynamic subtest pipe-B: SUCCESS (3.516s)
[508.640350] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.353s)
[509.451128] [095/155] (512s left) gem_exec_balancer (nop)
[509.520927] Starting subtest: nop
[556.127065] Subtest nop: SUCCESS (46.836s)
[556.428834] [096/155] (465s left) fbdev (unaligned-write)
[556.466149] Starting subtest: unaligned-write
[556.567511] Subtest unaligned-write: SUCCESS (0.101s)
[556.637278] [097/155] (464s left) kms_selftest (drm_format)
[556.684236] Starting subtest: drm_format
[556.741520] Starting dynamic subtest: drm_test_format_block_width_invalid
[556.829823] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.091s)
[556.841425] Starting dynamic subtest: drm_test_format_block_width_one_plane
[556.911688] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.080s)
[556.924275] Starting dynamic subtest: drm_test_format_block_width_two_plane
[556.994339] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.081s)
[557.005920] Starting dynamic subtest: drm_test_format_block_width_three_plane
[557.100626] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.105s)
[557.112868] Starting dynamic subtest: drm_test_format_block_width_tiled
[557.196916] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.096s)
[557.210006] Starting dynamic subtest: drm_test_format_block_height_invalid
[557.291521] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.091s)
[557.302692] Starting dynamic subtest: drm_test_format_block_height_one_plane
[557.377604] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.088s)
[557.389462] Starting dynamic subtest: drm_test_format_block_height_two_plane
[557.468080] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.088s)
[557.478944] Starting dynamic subtest: drm_test_format_block_height_three_plane
[557.558893] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.089s)
[557.569723] Starting dynamic subtest: drm_test_format_block_height_tiled
[557.644855] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.084s)
[557.656068] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[557.741798] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.093s)
[557.753004] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[557.834530] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.092s)
[557.846931] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[557.922513] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.088s)
[557.933788] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[558.017758] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.094s)
[558.029832] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[558.104916] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.083s)
[558.115594] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[558.190051] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.083s)
[558.201268] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[558.273181] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.084s)
[558.286561] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[558.365287] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.091s)
[558.367706] Subtest drm_format: SUCCESS (1.682s)
[558.514796] [098/155] (463s left) kms_atomic (atomic-plane-damage)
[558.618168] Starting subtest: atomic-plane-damage
[558.667790] Starting dynamic subtest: pipe-A-eDP-1
[559.229893] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[559.233020] Subtest atomic-plane-damage: SUCCESS (0.614s)
[560.043130] [099/155] (461s left) kms_flip (2x-flip-vs-dpms)
[560.142280] Starting subtest: 2x-flip-vs-dpms
[560.149838] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[560.250081] [100/155] (461s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[560.354614] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[560.359742] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[560.451922] [101/155] (461s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[560.512869] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[560.576002] [102/155] (461s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[560.635043] Starting subtest: invalid-signal-one-illegal-handle
[560.637453] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[560.741305] [103/155] (461s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[560.836880] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[565.941061] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.108s)
[566.055429] [104/155] (455s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[566.154839] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[566.159871] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[566.228370] [105/155] (455s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[566.317513] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[566.319950] Starting dynamic subtest: pipe-A
[566.339031] Dynamic subtest pipe-A: SKIP (0.018s)
[566.350747] Starting dynamic subtest: pipe-B
[566.372541] Dynamic subtest pipe-B: SKIP (0.032s)
[566.383589] Starting dynamic subtest: pipe-C
[566.405698] Dynamic subtest pipe-C: SKIP (0.034s)
[566.417041] Starting dynamic subtest: pipe-D
[566.440866] Dynamic subtest pipe-D: SKIP (0.033s)
[566.446032] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.120s)
[566.547767] [106/155] (455s left) kms_flip (wf_vblank-ts-check-interruptible)
[566.648295] Starting subtest: wf_vblank-ts-check-interruptible
[566.650894] Starting dynamic subtest: A-eDP1
[575.583621] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[575.595220] Starting dynamic subtest: B-eDP1
[584.515050] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[584.526722] Starting dynamic subtest: C-eDP1
[593.435002] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[593.447887] Starting dynamic subtest: D-eDP1
[602.367092] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[602.369593] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.728s)
[603.589843] [107/155] (418s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[603.717508] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[622.365271] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.640s)
[623.249229] [108/155] (398s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[623.358824] Starting subtest: fbc-rgb101010-draw-mmap-wc
[625.830797] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.477s)
[626.958486] [109/155] (395s left) gem_exec_reloc (basic-cpu-read)
[627.013650] Subtest basic-cpu-read: SKIP (0.000s)
[627.083698] [110/155] (395s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[627.179851] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[627.184927] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[627.282192] [111/155] (394s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[627.378779] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[627.383941] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[627.488909] [112/155] (394s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[627.585660] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[627.590584] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[627.693360] [113/155] (394s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[627.787880] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[627.790338] Starting dynamic subtest: pipe-A-eDP-1
[628.222910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[628.236949] Starting dynamic subtest: pipe-B-eDP-1
[628.258737] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[628.272809] Starting dynamic subtest: pipe-C-eDP-1
[628.293637] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[628.304177] Starting dynamic subtest: pipe-D-eDP-1
[628.324360] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[628.326368] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.452s)
[630.516172] [114/155] (391s left) prime_busy (before)
[630.584445] Starting subtest: before
[630.589945] Starting dynamic subtest: rcs0
[630.623779] Dynamic subtest rcs0: SUCCESS (0.035s)
[630.636364] Starting dynamic subtest: bcs0
[630.664907] Dynamic subtest bcs0: SUCCESS (0.041s)
[630.676318] Starting dynamic subtest: vcs0
[630.707872] Dynamic subtest vcs0: SUCCESS (0.043s)
[630.719421] Starting dynamic subtest: vcs1
[630.751295] Dynamic subtest vcs1: SUCCESS (0.042s)
[630.762945] Starting dynamic subtest: vecs0
[630.792314] Dynamic subtest vecs0: SUCCESS (0.040s)
[630.804606] Starting dynamic subtest: ccs0
[630.832638] Dynamic subtest ccs0: SUCCESS (0.040s)
[630.941585] Subtest before: SUCCESS (0.355s)
[631.024029] [115/155] (391s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[631.120396] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[631.125051] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[632.245349] [116/155] (390s left) perf (non-system-wide-paranoid)
[632.365372] Starting subtest: non-system-wide-paranoid
[632.390077] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[632.436870] [117/155] (390s left) kms_color_pipeline (plane-lut1d-lut1d)
[632.527744] Starting subtest: plane-lut1d-lut1d
[632.684817] Starting dynamic subtest: pipe-A-plane-0
[632.862587] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[632.874028] Starting dynamic subtest: pipe-A-plane-1
[633.029177] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[633.040831] Starting dynamic subtest: pipe-A-plane-2
[633.220652] Dynamic subtest pipe-A-plane-2: SUCCESS (0.189s)
[634.479837] Starting dynamic subtest: pipe-B-plane-0
[634.646571] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[634.660780] Starting dynamic subtest: pipe-B-plane-1
[634.814735] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[634.827017] Starting dynamic subtest: pipe-B-plane-2
[634.982015] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[636.196939] Starting dynamic subtest: pipe-C-plane-0
[636.343432] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[636.355288] Starting dynamic subtest: pipe-C-plane-1
[636.499038] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[636.510885] Starting dynamic subtest: pipe-C-plane-2
[636.654640] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[637.825855] Starting dynamic subtest: pipe-D-plane-0
[637.960001] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[637.972790] Starting dynamic subtest: pipe-D-plane-1
[638.126426] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[638.138055] Starting dynamic subtest: pipe-D-plane-2
[638.282025] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[638.580963] Subtest plane-lut1d-lut1d: SUCCESS (6.054s)
[639.405534] [118/155] (383s left) core_auth (getclient-master-drop)
[639.444815] Starting subtest: getclient-master-drop
[639.460189] Subtest getclient-master-drop: SUCCESS (0.017s)
[639.581086] [119/155] (383s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[639.645506] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[639.744405] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[639.826110] [120/155] (382s left) kms_psr (psr2-basic)
[639.924007] Starting subtest: psr2-basic
[639.926709] Starting dynamic subtest: eDP-1
[642.359825] Dynamic subtest eDP-1: SUCCESS (2.433s)
[642.362654] Subtest psr2-basic: SUCCESS (2.434s)
[642.735858] [121/155] (379s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[642.843490] Starting subtest: y-tiled-32bpp-rotate-180
[642.848738] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[642.934897] [122/155] (379s left) kms_chamelium_frames (vga-frame-dump)
[643.325524] Subtest vga-frame-dump: SKIP (0.000s)
[644.142943] [123/155] (378s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[644.244435] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[651.242008] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.002s)
[651.381690] [124/155] (371s left) kms_vblank (wait-forked)
[651.476892] Starting subtest: wait-forked
[651.479257] Starting dynamic subtest: pipe-A-eDP-1
[653.309121] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.832s)
[653.325613] Starting dynamic subtest: pipe-D-eDP-1
[655.802196] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.491s)
[655.804997] Subtest wait-forked: SUCCESS (4.328s)
[656.668148] [125/155] (366s left) gem_exec_fence (invalid-fence-array)
[657.091006] Starting subtest: invalid-fence-array
[657.094045] Subtest invalid-fence-array: SUCCESS (0.003s)
[658.178323] [126/155] (364s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[658.280674] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[661.959321] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.687s)
[663.157316] [127/155] (359s left) kms_psr (pr-cursor-mmap-cpu)
[663.257837] Starting subtest: pr-cursor-mmap-cpu
[663.262540] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[663.344962] [128/155] (359s left) perf_pmu (busy)
[663.387087] Starting subtest: busy
[663.390057] Starting dynamic subtest: rcs0
[663.973626] Dynamic subtest rcs0: SUCCESS (0.589s)
[663.989064] Starting dynamic subtest: bcs0
[664.544894] Dynamic subtest bcs0: SUCCESS (0.569s)
[664.560279] Starting dynamic subtest: vcs0
[666.109044] Dynamic subtest vcs0: SUCCESS (1.561s)
[666.124636] Starting dynamic subtest: vcs1
[668.092556] Dynamic subtest vcs1: SUCCESS (1.981s)
[668.107749] Starting dynamic subtest: vecs0
[670.077197] Dynamic subtest vecs0: SUCCESS (1.982s)
[670.092787] Starting dynamic subtest: ccs0
[670.649924] Dynamic subtest ccs0: SUCCESS (0.571s)
[670.653010] Subtest busy: SUCCESS (7.268s)
[670.754661] [129/155] (352s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[670.853837] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[670.858825] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[670.929270] [130/155] (352s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[671.040864] Starting subtest: fbcpsrhdr-tiling-4
[671.045811] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[671.137679] [131/155] (351s left) gem_exec_schedule (u-submit-golden-slice)
[671.212020] Starting subtest: u-submit-golden-slice
[671.214569] Starting dynamic subtest: rcs0
[671.235550] Dynamic subtest rcs0: SUCCESS (0.034s)
[671.254868] Starting dynamic subtest: bcs0
[671.269932] Dynamic subtest bcs0: SUCCESS (0.032s)
[671.282331] Starting dynamic subtest: vcs0
[671.307927] Dynamic subtest vcs0: SUCCESS (0.037s)
[671.320165] Starting dynamic subtest: vcs1
[671.336111] Dynamic subtest vcs1: SUCCESS (0.027s)
[671.348602] Starting dynamic subtest: vecs0
[671.363439] Dynamic subtest vecs0: SUCCESS (0.027s)
[671.375589] Starting dynamic subtest: ccs0
[671.393862] Dynamic subtest ccs0: SUCCESS (0.029s)
[671.397025] Subtest u-submit-golden-slice: SUCCESS (0.193s)
[673.182322] [132/155] (349s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[673.297892] Starting subtest: short-busy-flip-before-cursor-toggle
[673.302995] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[673.449211] [133/155] (349s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[673.545053] Starting subtest: primary-y-tiled-reflect-x-90
[673.550174] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[673.624841] [134/155] (349s left) gem_exec_await (wide-contexts)
[673.803957] Starting subtest: wide-contexts
[696.767368] Subtest wide-contexts: SUCCESS (22.967s)
[696.982449] [135/155] (326s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-render)
[697.126070] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-render
[697.131568] Subtest psrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[697.211059] [136/155] (326s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render)
[697.312281] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render
[697.317549] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[697.410697] [137/155] (325s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[697.515879] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[697.520621] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[697.636824] [138/155] (325s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[697.733788] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[697.738912] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[697.832687] [139/155] (325s left) kms_cursor_crc (cursor-random-512x512)
[698.118458] Starting subtest: cursor-random-512x512
[698.122374] Subtest cursor-random-512x512: SKIP (0.001s)
[698.285197] [140/155] (325s left) kms_pipe_crc_basic (hang-read-crc)
[698.379771] Starting subtest: hang-read-crc
[698.381672] Starting dynamic subtest: pipe-A-eDP-1
[700.534937] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.154s)
[700.547796] Starting dynamic subtest: pipe-B-eDP-1
[704.184022] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.648s)
[704.197964] Starting dynamic subtest: pipe-C-eDP-1
[706.388731] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.204s)
[706.401881] Starting dynamic subtest: pipe-D-eDP-1
[709.052024] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s)
[709.054931] Subtest hang-read-crc: SUCCESS (10.675s)
[709.902228] [141/155] (313s left) gem_readwrite (write-bad-handle)
[709.959910] Subtest write-bad-handle: SKIP (0.000s)
[710.024091] [142/155] (313s left) testdisplay
[710.348877] [143/155] (313s left) kms_plane_multiple (2x-tiling-4)
[710.446915] Starting subtest: 2x-tiling-4
[710.451779] Subtest 2x-tiling-4: SKIP (0.000s)
[710.521722] [144/155] (313s left) api_intel_allocator (reopen)
[710.577814] Starting subtest: reopen
[710.580837] Subtest reopen: SUCCESS (0.004s)
[710.686831] [145/155] (313s left) perf_pmu (render-node-busy-idle)
[710.748207] Starting subtest: render-node-busy-idle
[710.750916] Starting dynamic subtest: rcs0
[711.427317] Dynamic subtest rcs0: SUCCESS (0.679s)
[711.443817] Starting dynamic subtest: bcs0
[712.091591] Dynamic subtest bcs0: SUCCESS (0.662s)
[712.107225] Starting dynamic subtest: vcs0
[714.108715] Dynamic subtest vcs0: SUCCESS (2.014s)
[714.125359] Starting dynamic subtest: vcs1
[716.093663] Dynamic subtest vcs1: SUCCESS (1.982s)
[716.109022] Starting dynamic subtest: vecs0
[718.077344] Dynamic subtest vecs0: SUCCESS (1.981s)
[718.093173] Starting dynamic subtest: ccs0
[718.740228] Dynamic subtest ccs0: SUCCESS (0.661s)
[718.743226] Subtest render-node-busy-idle: SUCCESS (7.995s)
[718.823803] [146/155] (304s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[718.925646] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[718.930700] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[719.020412] [147/155] (304s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[719.126654] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[719.131468] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[719.221506] [148/155] (304s left) gem_exec_reloc (basic-cpu-wc)
[719.287959] Subtest basic-cpu-wc: SKIP (0.000s)
[719.359373] [149/155] (304s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[719.471800] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[719.518288] [150/155] (304s left) gem_gpgpu_fill (offset-16x16)
[719.579029] Starting subtest: offset-16x16
[719.585779] Subtest offset-16x16: SUCCESS (0.008s)
[719.732019] [151/155] (304s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[719.835860] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[719.840739] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[719.944588] [152/155] (304s left) gem_exec_schedule (pi-common)
[720.137955] Starting subtest: pi-common
[720.145180] Starting dynamic subtest: rcs0
[720.161557] Dynamic subtest rcs0: SUCCESS (0.029s)
[720.179071] Starting dynamic subtest: bcs0
[720.192955] Dynamic subtest bcs0: SUCCESS (0.031s)
[720.210051] Starting dynamic subtest: vcs0
[720.222693] Dynamic subtest vcs0: SUCCESS (0.029s)
[720.239640] Starting dynamic subtest: vcs1
[720.251257] Dynamic subtest vcs1: SUCCESS (0.028s)
[720.267610] Starting dynamic subtest: vecs0
[720.277617] Dynamic subtest vecs0: SUCCESS (0.025s)
[720.294078] Starting dynamic subtest: ccs0
[720.304745] Dynamic subtest ccs0: SUCCESS (0.026s)
[720.307306] Subtest pi-common: SUCCESS (0.173s)
[720.536631] [153/155] (303s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[720.633899] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[720.733239] [154/155] (303s left) kms_flip (2x-flip-vs-fences)
[720.836961] Starting subtest: 2x-flip-vs-fences
[720.841804] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[720.947998] [155/155] (303s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[721.003740] Starting subtest: map-fixed-invalidate-overlap-busy
[721.009347] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[721.122745] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_create
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_flush
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_pm_rpm
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: i915_selftest
results: parsing output: 10/ for test: core_hotunplug
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: prime_mmap
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_dsc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_invalid_mode
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_ctx_isolation
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: i915_getparams_basic
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_flink_basic
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_prop_blob
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_render_linear_blits
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: sw_sync
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_fbcon_fbt
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_pipe_stress
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: gem_ctx_persistence
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_exec_async
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: gem_mmap_offset
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_hdr
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_content_protection
results: parsing output: 78/ for test: prime_self_import
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_exec_whisper
results: parsing output: 84/ for test: i915_pm_rps
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_partial_pwrite_pread
results: parsing output: 87/ for test: kms_chamelium_hpd
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_softpin
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: fbdev
results: parsing output: 96/ for test: kms_selftest
results: parsing output: 97/ for test: kms_atomic
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_wc
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: prime_busy
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_color_pipeline
results: parsing output: 117/ for test: core_auth
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_chamelium_frames
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_rotation_crc
results: parsing output: 133/ for test: gem_exec_await
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_cursor_crc
results: parsing output: 139/ for test: kms_pipe_crc_basic
results: parsing output: 140/ for test: gem_readwrite
results: parsing output: 141/ for test: testdisplay
results: parsing output: 142/ for test: kms_plane_multiple
results: parsing output: 143/ for test: api_intel_allocator
results: parsing output: 144/ for test: perf_pmu
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_exec_reloc
results: parsing output: 148/ for test: kms_tiled_display
results: parsing output: 149/ for test: gem_gpgpu_fill
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_exec_schedule
results: parsing output: 152/ for test: kms_addfb_basic
results: parsing output: 153/ for test: kms_flip
results: parsing output: 154/ for test: gem_userptr_blits
Done.