[47.376666] Initializing watchdogs
[47.376722]   /dev/watchdog0
[47.392387] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.398032] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.400747] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.402803] [001/130] (960s left) kms_psr (fbc-pr-sprite-plane-onoff)
[47.496321] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[47.533832] [002/130] (960s left) kms_cursor_legacy (single-bo)
[47.618802] Starting subtest: single-bo
[47.619490] Starting dynamic subtest: pipe-A
[52.968015] Dynamic subtest pipe-A: SUCCESS (5.380s)
[52.973925] Starting dynamic subtest: pipe-B
[58.362524] Dynamic subtest pipe-B: SUCCESS (5.379s)
[58.367498] Starting dynamic subtest: pipe-C
[63.732708] Dynamic subtest pipe-C: SUCCESS (5.378s)
[63.737701] Starting dynamic subtest: pipe-D
[69.107657] Dynamic subtest pipe-D: SUCCESS (5.378s)
[69.112710] Starting dynamic subtest: all-pipes
[74.485053] Dynamic subtest all-pipes: SUCCESS (5.379s)
[74.485896] Subtest single-bo: SUCCESS (26.896s)
[74.520277] [003/130] (933s left) kms_psr (psr-sprite-render)
[74.608054] Subtest psr-sprite-render: SKIP (0.000s)
[74.648417] [004/130] (933s left) gem_userptr_blits (access-control)
[74.702319] Starting subtest: access-control
[74.703686] Subtest access-control: SKIP (0.000s)
[74.828912] [005/130] (933s left) kms_cursor_crc (cursor-random-256x85)
[74.919728] Starting subtest: cursor-random-256x85
[74.934379] Starting dynamic subtest: pipe-A-HDMI-A-1
[76.864802] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.931s)
[76.898969] Starting dynamic subtest: pipe-D-HDMI-A-1
[78.774747] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.881s)
[78.775471] Subtest cursor-random-256x85: SUCCESS (3.856s)
[78.912334] [006/130] (929s left) gem_mmap_offset (mmap-boundaries)
[78.948655] Starting subtest: mmap-boundaries
[78.949333] Starting dynamic subtest: smem0
[79.222905] Dynamic subtest smem0: SUCCESS (0.275s)
[79.223624] Subtest mmap-boundaries: SUCCESS (0.275s)
[79.331630] [007/130] (928s left) kms_plane (pixel-format-4-tiled-modifier)
[79.417539] Starting subtest: pixel-format-4-tiled-modifier
[79.418973] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[79.468528] [008/130] (928s left) kms_big_fb (linear-8bpp-rotate-270)
[79.566633] Starting subtest: linear-8bpp-rotate-270
[79.649858] Subtest linear-8bpp-rotate-270: SKIP (0.082s)
[79.749934] [009/130] (928s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[79.787334] Starting subtest: basic-wc-cpu-noreloc
[79.792102] Subtest basic-wc-cpu-noreloc: SUCCESS (0.005s)
[79.895362] [010/130] (928s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[79.979711] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[79.980431] Starting dynamic subtest: pipe-A-HDMI-A-1
[79.987228] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[79.993940] Starting dynamic subtest: pipe-B-HDMI-A-1
[80.000801] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[80.007385] Starting dynamic subtest: pipe-C-HDMI-A-1
[80.014149] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[80.020574] Starting dynamic subtest: pipe-D-HDMI-A-1
[80.027645] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[80.029035] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[80.205246] [011/130] (928s left) gem_exec_balancer (indices)
[80.248675] Starting subtest: indices
[81.592587] Subtest indices: SUCCESS (1.344s)
[81.773248] [012/130] (926s left) gem_render_copy (yf-tiled-ccs-to-linear)
[81.811469] Starting subtest: yf-tiled-ccs-to-linear
[81.812185] Starting dynamic subtest: smem
[81.880945] Dynamic subtest smem: SUCCESS (0.069s)
[81.881741] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.070s)
[82.058044] [013/130] (926s left) i915_pm_rps (reset)
[82.096215] Starting subtest: reset
[86.658877] Subtest reset: SUCCESS (4.533s)
[86.733628] [014/130] (921s left) perf (polling)
[86.809007] Starting subtest: polling
[86.809682] Starting dynamic subtest: 0-rcs0
[96.867869] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[96.868902] Subtest polling: SUCCESS (10.026s)
[96.927316] [015/130] (911s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[97.027395] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[97.028101] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.045369] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[97.051074] Starting dynamic subtest: pipe-B-HDMI-A-1
[97.068732] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[97.074286] Starting dynamic subtest: pipe-C-HDMI-A-1
[97.091397] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[97.097502] Starting dynamic subtest: pipe-D-HDMI-A-1
[97.115129] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[97.116467] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.011s)
[97.267855] [016/130] (911s left) perf_pmu (interrupts)
[97.305942] Starting subtest: interrupts
[98.413502] Subtest interrupts: SUCCESS (1.098s)
[98.497809] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[98.502188] [017/130] (910s left) fbdev (unaligned-write)
[98.541741] Starting subtest: unaligned-write
[98.668011] Subtest unaligned-write: SUCCESS (0.118s)
[98.720576] [018/130] (909s left) perf (gen12-mi-rpc)
[98.799945] Starting subtest: gen12-mi-rpc
[98.800658] Starting dynamic subtest: rcs0
[98.811102] Dynamic subtest rcs0: SUCCESS (0.011s)
[98.811810] Subtest gen12-mi-rpc: SUCCESS (0.011s)
[98.848973] [019/130] (909s left) gem_pwrite_snooped
[98.997163] [020/130] (909s left) kms_psr (fbc-psr-cursor-blt)
[99.084967] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[99.128061] [021/130] (909s left) syncobj_timeline (reset-multiple-signaled)
[99.161610] Starting subtest: reset-multiple-signaled
[99.163037] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[99.218404] [022/130] (909s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[99.251718] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[99.252396] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[99.311163] [023/130] (909s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[99.395371] Starting subtest: basic-flip-before-cursor-atomic
[99.899383] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.504s)
[100.021792] [024/130] (908s left) gem_exec_schedule (preempt-other-chain)
[100.070512] Starting subtest: preempt-other-chain
[100.071227] Starting dynamic subtest: rcs0
[100.111239] Dynamic subtest rcs0: SUCCESS (0.040s)
[100.118128] Starting dynamic subtest: bcs0
[100.149592] Dynamic subtest bcs0: SUCCESS (0.038s)
[100.156430] Starting dynamic subtest: vcs0
[100.188766] Dynamic subtest vcs0: SUCCESS (0.039s)
[100.195829] Starting dynamic subtest: vcs1
[100.226916] Dynamic subtest vcs1: SUCCESS (0.038s)
[100.234461] Starting dynamic subtest: vecs0
[100.266444] Dynamic subtest vecs0: SUCCESS (0.039s)
[100.267198] Subtest preempt-other-chain: SUCCESS (0.196s)
[100.573828] [025/130] (908s left) gem_exec_capture (capture-invisible)
[100.611466] Starting subtest: capture-invisible
[100.612175] Starting dynamic subtest: smem0
[100.613503] Dynamic subtest smem0: SKIP (0.000s)
[100.614843] Subtest capture-invisible: SKIP (0.000s)
[100.704924] [026/130] (908s left) i915_drm_fdinfo (idle)
[100.741461] Starting subtest: idle
[100.742150] Starting dynamic subtest: rcs0
[101.252113] Dynamic subtest rcs0: SUCCESS (0.503s)
[101.261811] Starting dynamic subtest: bcs0
[101.757196] Dynamic subtest bcs0: SUCCESS (0.504s)
[101.766773] Starting dynamic subtest: vcs0
[102.262114] Dynamic subtest vcs0: SUCCESS (0.504s)
[102.271741] Starting dynamic subtest: vcs1
[102.765890] Dynamic subtest vcs1: SUCCESS (0.503s)
[102.775659] Starting dynamic subtest: vecs0
[103.270337] Dynamic subtest vecs0: SUCCESS (0.504s)
[103.271347] Subtest idle: SUCCESS (2.521s)
[103.327396] [027/130] (905s left) i915_selftest (live)
[104.199030] Starting subtest: live
[104.199826] Starting dynamic subtest: sanitycheck
[105.369696] Dynamic subtest sanitycheck: SUCCESS (1.170s)
[105.379803] Starting dynamic subtest: uncore
[106.553663] Dynamic subtest uncore: SUCCESS (1.183s)
[106.563767] Starting dynamic subtest: workarounds
[108.069653] Dynamic subtest workarounds: SUCCESS (1.515s)
[108.083712] Starting dynamic subtest: gt_engines
[109.819633] Dynamic subtest gt_engines: SUCCESS (1.749s)
[109.829478] Starting dynamic subtest: gt_timelines
[118.223660] Dynamic subtest gt_timelines: SUCCESS (8.403s)
[118.232231] Starting dynamic subtest: gt_contexts
[119.545694] Dynamic subtest gt_contexts: SUCCESS (1.321s)
[119.552118] Starting dynamic subtest: gt_lrc
[123.667708] Dynamic subtest gt_lrc: SUCCESS (4.121s)
[123.673655] Starting dynamic subtest: gt_mocs
[124.990663] Dynamic subtest gt_mocs: SUCCESS (1.322s)
[124.997253] Starting dynamic subtest: gt_pm
[146.394495] Dynamic subtest gt_pm: SUCCESS (21.404s)
[146.404425] Starting dynamic subtest: gt_heartbeat
[147.584807] Dynamic subtest gt_heartbeat: SUCCESS (1.190s)
[147.593208] Starting dynamic subtest: gt_tlb
[151.033633] Dynamic subtest gt_tlb: SUCCESS (3.449s)
[151.043637] Starting dynamic subtest: requests
[159.625616] Dynamic subtest requests: SUCCESS (8.593s)
[159.635682] Starting dynamic subtest: migrate
[163.897511] Dynamic subtest migrate: SUCCESS (4.272s)
[163.903852] Starting dynamic subtest: active
[165.057712] Dynamic subtest active: SUCCESS (1.166s)
[165.069648] Starting dynamic subtest: objects
[166.736629] Dynamic subtest objects: SUCCESS (1.671s)
[166.743019] Starting dynamic subtest: mman
[171.346489] Dynamic subtest mman: SUCCESS (4.610s)
[171.356233] Starting dynamic subtest: dmabuf
[172.569469] Dynamic subtest dmabuf: SUCCESS (1.222s)
[172.576023] Starting dynamic subtest: vma
[173.746511] Dynamic subtest vma: SUCCESS (1.176s)
[173.752752] Starting dynamic subtest: coherency
[176.598606] Dynamic subtest coherency: SUCCESS (2.851s)
[176.608983] Starting dynamic subtest: gtt
[185.363566] Dynamic subtest gtt: SUCCESS (8.765s)
[185.369695] Starting dynamic subtest: gem
[187.461390] Dynamic subtest gem: SUCCESS (2.097s)
[187.467365] Starting dynamic subtest: evict
[189.630481] Dynamic subtest evict: SUCCESS (2.168s)
[189.636506] Starting dynamic subtest: hugepages
[197.269309] Dynamic subtest hugepages: SUCCESS (7.638s)
[197.278974] Starting dynamic subtest: gem_contexts
[212.661279] Dynamic subtest gem_contexts: SUCCESS (15.392s)
[212.667202] Starting dynamic subtest: client
[213.877603] Dynamic subtest client: SUCCESS (1.215s)
[213.887268] Starting dynamic subtest: gem_migrate
[215.024993] Dynamic subtest gem_migrate: SUCCESS (1.146s)
[215.031158] Starting dynamic subtest: reset
[219.949771] Dynamic subtest reset: SUCCESS (4.924s)
[219.956272] Starting dynamic subtest: memory_region
[221.128767] Dynamic subtest memory_region: SUCCESS (1.177s)
[221.134789] Starting dynamic subtest: hangcheck
[251.044686] Dynamic subtest hangcheck: SUCCESS (29.916s)
[251.053180] Starting dynamic subtest: execlists
[264.713507] Dynamic subtest execlists: SUCCESS (13.668s)
[264.720136] Starting dynamic subtest: ring_submission
[265.873797] Dynamic subtest ring_submission: SUCCESS (1.158s)
[265.882215] Starting dynamic subtest: perf
[267.119666] Dynamic subtest perf: SUCCESS (1.244s)
[267.130029] Starting dynamic subtest: slpc
[268.318638] Dynamic subtest slpc: SUCCESS (1.197s)
[268.330521] Starting dynamic subtest: guc
[269.483532] Dynamic subtest guc: SUCCESS (1.163s)
[269.489663] Starting dynamic subtest: guc_multi_lrc
[270.668683] Dynamic subtest guc_multi_lrc: SUCCESS (1.183s)
[270.674849] Starting dynamic subtest: guc_hang
[271.842612] Dynamic subtest guc_hang: SUCCESS (1.172s)
[271.849023] Starting dynamic subtest: late_gt_pm
[273.069687] Dynamic subtest late_gt_pm: SUCCESS (1.225s)
[273.070670] Subtest live: SUCCESS (168.887s)
[273.102611] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[273.103598] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[273.106588] [028/130] (735s left) kms_rotation_crc (sprite-rotation-270)
[274.177951] Starting subtest: sprite-rotation-270
[278.905045] Subtest sprite-rotation-270: SUCCESS (4.727s)
[279.095830] [FACT kms_rotation_crc (sprite-rotation-270)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[279.097179] [FACT kms_rotation_crc (sprite-rotation-270)] new: kernel.kmod_is_loaded.i915: true
[279.099510] [029/130] (729s left) perf (whitelisted-registers-userspace-config)
[279.192643] Starting subtest: whitelisted-registers-userspace-config
[279.193343] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[279.237092] [030/130] (729s left) kms_invalid_mode (bad-vsync-end)
[279.326533] Starting subtest: bad-vsync-end
[279.327226] Starting dynamic subtest: pipe-A-HDMI-A-1
[279.378322] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.051s)
[279.385760] Starting dynamic subtest: pipe-B-HDMI-A-1
[279.386443] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[279.392746] Starting dynamic subtest: pipe-C-HDMI-A-1
[279.393421] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[279.399441] Starting dynamic subtest: pipe-D-HDMI-A-1
[279.400120] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[279.400781] Subtest bad-vsync-end: SUCCESS (0.060s)
[279.513229] [031/130] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[279.603709] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[279.605055] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[279.694863] [032/130] (729s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[279.784764] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[279.786114] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[279.889321] [033/130] (729s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[279.923331] Starting subtest: etime-multi-wait-all-for-submit-submitted
[280.031831] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[280.104819] [034/130] (729s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[280.193696] Starting subtest: fbcpsr-slowdraw
[280.195031] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[280.293110] [035/130] (728s left) kms_draw_crc (draw-method-blt)
[280.380055] Starting subtest: draw-method-blt
[280.380761] Starting dynamic subtest: xrgb8888-untiled
[280.542483] Dynamic subtest xrgb8888-untiled: SUCCESS (0.163s)
[280.557056] Starting dynamic subtest: rgb565-untiled
[280.700879] Dynamic subtest rgb565-untiled: SUCCESS (0.156s)
[280.714970] Starting dynamic subtest: xrgb2101010-untiled
[280.842629] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.139s)
[280.857386] Starting dynamic subtest: xbgr16161616f-untiled
[281.009249] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.164s)
[281.023910] Starting dynamic subtest: xrgb8888-xtiled
[281.092803] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.081s)
[281.107732] Starting dynamic subtest: rgb565-xtiled
[281.175967] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[281.190236] Starting dynamic subtest: xrgb2101010-xtiled
[281.259415] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[281.281521] Starting dynamic subtest: xbgr16161616f-xtiled
[281.351020] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.089s)
[281.365449] Starting dynamic subtest: xrgb8888-ytiled
[281.450691] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.097s)
[281.462576] Starting dynamic subtest: rgb565-ytiled
[281.534242] Dynamic subtest rgb565-ytiled: SUCCESS (0.082s)
[281.548172] Starting dynamic subtest: xrgb2101010-ytiled
[281.609234] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.073s)
[281.623690] Starting dynamic subtest: xbgr16161616f-ytiled
[281.700872] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.089s)
[281.705183] Subtest draw-method-blt: SUCCESS (1.323s)
[281.813020] [036/130] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[281.909191] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[281.910628] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[282.005410] [037/130] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[282.094868] Starting subtest: fbcpsr-2p-rte
[282.096284] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[282.188087] [038/130] (727s left) kms_chamelium_frames (hdmi-frame-dump)
[282.326414] Subtest hdmi-frame-dump: SKIP (0.000s)
[282.411128] [039/130] (726s left) gem_mmap_wc (read)
[282.444692] Starting subtest: read
[282.452490] Subtest read: SUCCESS (0.009s)
[282.538808] [040/130] (726s left) prime_vgem (fence-flip-hang)
[282.605460] Subtest fence-flip-hang: SKIP (0.000s)
[282.700893] [041/130] (726s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[282.787050] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[282.788513] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[282.848748] [042/130] (726s left) gem_busy (close-race)
[282.891381] Starting subtest: close-race
[304.961877] Subtest close-race: SUCCESS (22.070s)
[305.329728] [043/130] (704s left) kms_atomic (plane-cursor-legacy)
[305.476354] Starting subtest: plane-cursor-legacy
[305.478577] Starting dynamic subtest: pipe-A-HDMI-A-1
[305.639970] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.161s)
[305.640739] Subtest plane-cursor-legacy: SUCCESS (0.164s)
[305.758110] [044/130] (703s left) gem_exec_fence (nb-await)
[305.926135] Starting subtest: nb-await
[305.927255] Starting dynamic subtest: rcs0
[305.989849] Dynamic subtest rcs0: SUCCESS (0.063s)
[306.006395] Starting dynamic subtest: bcs0
[306.055245] Dynamic subtest bcs0: SUCCESS (0.063s)
[306.072944] Starting dynamic subtest: vcs0
[306.120534] Dynamic subtest vcs0: SUCCESS (0.063s)
[306.138019] Starting dynamic subtest: vcs1
[306.185980] Dynamic subtest vcs1: SUCCESS (0.063s)
[306.203073] Starting dynamic subtest: vecs0
[306.251216] Dynamic subtest vecs0: SUCCESS (0.063s)
[306.252227] Subtest nb-await: SUCCESS (0.326s)
[306.707575] [045/130] (702s left) gem_ctx_engines (none)
[306.749273] Starting subtest: none
[306.751087] Subtest none: SUCCESS (0.001s)
[306.934605] [046/130] (702s left) kms_psr (pr-primary-mmap-gtt)
[307.022417] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[307.068139] [047/130] (702s left) gem_mmap_wc (invalid-flags)
[307.102520] Starting subtest: invalid-flags
[307.103270] Subtest invalid-flags: SUCCESS (0.000s)
[307.198242] [048/130] (702s left) gem_mmap_wc (write-prefaulted)
[307.230850] Starting subtest: write-prefaulted
[307.263594] Subtest write-prefaulted: SUCCESS (0.033s)
[307.367617] [049/130] (702s left) drm_read (short-buffer-block)
[307.481451] Starting subtest: short-buffer-block
[307.482225] Subtest short-buffer-block: SUCCESS (0.000s)
[307.590109] [050/130] (702s left) gem_ctx_persistence (file)
[307.626537] Starting subtest: file
[307.706843] Subtest file: SUCCESS (0.080s)
[307.801475] [051/130] (702s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[307.886738] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[307.887470] Starting dynamic subtest: pipe-A
[308.987173] Dynamic subtest pipe-A: SUCCESS (1.100s)
[309.005878] Starting dynamic subtest: pipe-B
[310.170765] Dynamic subtest pipe-B: SUCCESS (1.182s)
[310.182860] Starting dynamic subtest: pipe-C
[310.372436] Dynamic subtest pipe-C: SUCCESS (0.200s)
[310.384426] Starting dynamic subtest: pipe-D
[310.573272] Dynamic subtest pipe-D: SUCCESS (0.200s)
[310.573997] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.687s)
[310.749126] [052/130] (699s left) core_getclient (basic)
[310.784558] Starting subtest: basic
[310.785265] Subtest basic: SUCCESS (0.000s)
[310.844707] [053/130] (699s left) vgem_basic (bad-handle)
[310.884007] Starting subtest: bad-handle
[310.884738] Subtest bad-handle: SUCCESS (0.000s)
[310.933430] [054/130] (699s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[311.021985] Starting subtest: 2x-long-flip-vs-cursor-legacy
[311.023961] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[311.084026] [055/130] (698s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[311.170029] Starting subtest: basic-busy-flip-before-cursor-varying-size
[311.171333] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[311.225522] [056/130] (698s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[311.315873] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[311.317238] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[311.421253] [057/130] (698s left) perf_pmu (rc6)
[311.457493] Starting subtest: rc6
[311.458200] Starting dynamic subtest: gt0
[317.829130] Dynamic subtest gt0: SUCCESS (6.337s)
[317.835831] Starting dynamic subtest: runtime-pm-gt0
[335.377554] Dynamic subtest runtime-pm-gt0: SUCCESS (17.572s)
[335.387462] Starting dynamic subtest: runtime-pm-long-gt0
[357.895037] Dynamic subtest runtime-pm-long-gt0: SUCCESS (22.516s)
[357.903839] Starting dynamic subtest: other-idle-gt0
[357.905195] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[357.905866] Subtest rc6: SUCCESS (46.433s)
[358.197135] [058/130] (651s left) gem_mmap (bad-offset)
[358.230457] Starting subtest: bad-offset
[358.231195] Subtest bad-offset: SUCCESS (0.000s)
[358.306160] [059/130] (651s left) kms_chamelium_color (ctm-0-25)
[358.394643] Subtest ctm-0-25: SKIP (0.000s)
[358.434155] [060/130] (651s left) kms_lease (implicit-plane-lease)
[358.520292] Starting subtest: implicit-plane-lease
[358.522234] Subtest implicit-plane-lease: SUCCESS (0.002s)
[358.564109] [061/130] (651s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[358.653119] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[358.654476] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[358.719956] [062/130] (651s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[358.811327] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[358.820934] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[358.861804] [063/130] (651s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[358.949374] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[358.991936] [064/130] (651s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[359.078204] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[361.188411] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.111s)
[361.300728] [065/130] (649s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[361.341360] Starting subtest: rel-constants-invalid-rel-gen5
[361.342071] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[361.398507] [066/130] (648s left) gem_exec_fence (basic-wait-all)
[361.438422] Starting subtest: basic-wait-all
[361.475549] Subtest basic-wait-all: SUCCESS (0.037s)
[362.034763] [067/130] (648s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[362.127083] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[362.136695] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[362.180720] [068/130] (648s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[362.268309] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[362.269050] Starting dynamic subtest: pipe-A-HDMI-A-1
[362.275204] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[362.282471] Starting dynamic subtest: pipe-B-HDMI-A-1
[362.288589] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[362.295808] Starting dynamic subtest: pipe-C-HDMI-A-1
[362.301879] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[362.308826] Starting dynamic subtest: pipe-D-HDMI-A-1
[362.314651] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[362.315320] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.010s)
[362.487947] [069/130] (648s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[362.531316] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[362.532105] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[362.574699] [070/130] (647s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[362.661445] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[362.706808] [071/130] (647s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[362.803295] Starting subtest: x-tiled-32bpp-rotate-180
[364.116659] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.313s)
[364.230907] [072/130] (646s left) gem_exec_reloc (basic-write-cpu)
[364.268808] Starting subtest: basic-write-cpu
[364.278012] Subtest basic-write-cpu: SUCCESS (0.005s)
[364.376048] [073/130] (646s left) kms_flip (2x-flip-vs-panning)
[364.461636] Starting subtest: 2x-flip-vs-panning
[364.470837] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[364.516296] [074/130] (646s left) core_sysfs (read-all-entries)
[364.549869] Starting subtest: read-all-entries
[364.554089] Subtest read-all-entries: SUCCESS (0.004s)
[364.591639] [075/130] (646s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[364.687727] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[364.999418] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.312s)
[365.106637] [076/130] (645s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[365.202375] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[365.203744] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[365.260323] [077/130] (645s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[365.349426] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[365.350823] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[365.424229] [078/130] (645s left) gem_exec_schedule (deep)
[365.589769] Starting subtest: deep
[365.590749] Starting dynamic subtest: rcs0
[373.493572] Dynamic subtest rcs0: SUCCESS (7.887s)
[373.507507] Starting dynamic subtest: bcs0
[381.591297] Dynamic subtest bcs0: SUCCESS (8.104s)
[381.599115] Starting dynamic subtest: vcs0
[389.718364] Dynamic subtest vcs0: SUCCESS (8.126s)
[389.730964] Starting dynamic subtest: vcs1
[397.970878] Dynamic subtest vcs1: SUCCESS (8.252s)
[397.983176] Starting dynamic subtest: vecs0
[406.183352] Dynamic subtest vecs0: SUCCESS (8.211s)
[406.184165] Subtest deep: SUCCESS (40.589s)
[406.749213] [079/130] (604s left) syncobj_timeline (etime-single-wait-submitted)
[406.785030] Starting subtest: etime-single-wait-submitted
[406.887776] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[406.943453] [080/130] (603s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[407.035794] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[407.037164] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[407.107579] [081/130] (603s left) api_intel_bb (blit-reloc-purge-cache)
[407.140917] Starting subtest: blit-reloc-purge-cache
[407.148037] Subtest blit-reloc-purge-cache: SUCCESS (0.007s)
[407.236971] [082/130] (603s left) syncobj_timeline (signal)
[407.270864] Starting subtest: signal
[407.271527] Subtest signal: SUCCESS (0.000s)
[407.315600] [083/130] (603s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[407.403381] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[407.444463] [084/130] (603s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[407.542074] Starting subtest: y-tiled-32bpp-rotate-180
[408.738199] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.196s)
[408.826143] [085/130] (602s left) kms_pm_dc (dc9-dpms)
[419.970169] Starting subtest: dc9-dpms
[423.286468] Subtest dc9-dpms: SKIP (3.282s)
[423.333013] [086/130] (587s left) gem_exercise_blt (fast-copy-emit)
[423.371208] Starting subtest: fast-copy-emit
[423.371908] Starting dynamic subtest: linear-smem-smem-emit
[423.391702] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.020s)
[423.400214] Starting dynamic subtest: ymajor-smem-smem-emit
[423.409122] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.016s)
[423.417653] Starting dynamic subtest: tile4-smem-smem-emit
[423.425906] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[423.434446] Starting dynamic subtest: tile64-smem-smem-emit
[423.442838] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[423.443595] Subtest fast-copy-emit: SUCCESS (0.072s)
[423.524365] [087/130] (587s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[423.562952] Starting subtest: y-tiled-to-vebox-x-tiled
[423.563720] Starting dynamic subtest: smem
[423.659541] Dynamic subtest smem: SUCCESS (0.096s)
[423.660269] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.097s)
[423.831929] [088/130] (587s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[423.921890] Starting subtest: cursorB-vs-flipB-varying-size
[423.923264] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[423.965265] [089/130] (587s left) perf_pmu (idle)
[424.001251] Starting subtest: idle
[424.001992] Starting dynamic subtest: rcs0
[424.538877] Dynamic subtest rcs0: SUCCESS (0.528s)
[424.550138] Starting dynamic subtest: bcs0
[425.047525] Dynamic subtest bcs0: SUCCESS (0.514s)
[425.059817] Starting dynamic subtest: vcs0
[425.572438] Dynamic subtest vcs0: SUCCESS (0.514s)
[425.583452] Starting dynamic subtest: vcs1
[426.088151] Dynamic subtest vcs1: SUCCESS (0.513s)
[426.099133] Starting dynamic subtest: vecs0
[426.607188] Dynamic subtest vecs0: SUCCESS (0.514s)
[426.608233] Subtest idle: SUCCESS (2.596s)
[426.653179] [090/130] (584s left) gem_userptr_blits (stress-purge)
[426.697884] Starting subtest: stress-purge
[432.102626] Subtest stress-purge: SUCCESS (5.405s)
[432.213180] [091/130] (579s left) kms_plane_multiple (2x-tiling-yf)
[432.356879] Starting subtest: 2x-tiling-yf
[432.358256] Subtest 2x-tiling-yf: SKIP (0.000s)
[432.399676] [092/130] (578s left) kms_psr (psr2-cursor-plane-move)
[432.487722] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[432.531186] [093/130] (578s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[432.573338] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[432.574058] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[432.615999] [094/130] (578s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[432.702969] Starting subtest: nonblocking-crc-frame-sequence
[432.704082] Starting dynamic subtest: pipe-A-HDMI-A-1
[433.073328] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.369s)
[433.081914] Starting dynamic subtest: pipe-B-HDMI-A-1
[433.394031] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.318s)
[433.403300] Starting dynamic subtest: pipe-C-HDMI-A-1
[433.720699] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.325s)
[433.729426] Starting dynamic subtest: pipe-D-HDMI-A-1
[434.046853] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.323s)
[434.047579] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.344s)
[434.133801] [095/130] (577s left) gem_exec_reloc (basic-cpu-read)
[434.173305] Starting subtest: basic-cpu-read
[434.178316] Subtest basic-cpu-read: SUCCESS (0.005s)
[434.274011] [096/130] (577s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[434.359984] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[434.360675] Starting dynamic subtest: pipe-A
[435.623202] Dynamic subtest pipe-A: SUCCESS (1.264s)
[435.637433] Starting dynamic subtest: pipe-B
[436.925375] Dynamic subtest pipe-B: SUCCESS (1.301s)
[436.935035] Starting dynamic subtest: pipe-C
[437.127049] Dynamic subtest pipe-C: SUCCESS (0.201s)
[437.146556] Starting dynamic subtest: pipe-D
[437.347055] Dynamic subtest pipe-D: SUCCESS (0.218s)
[437.347818] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (2.989s)
[437.511352] [097/130] (574s left) kms_chamelium_hpd (vga-hpd)
[437.658183] Subtest vga-hpd: SKIP (0.000s)
[437.740021] [098/130] (573s left) gem_exec_schedule (preempt-queue-contexts-chain)
[437.785298] Starting subtest: preempt-queue-contexts-chain
[437.786020] Starting dynamic subtest: rcs0
[438.162116] Dynamic subtest rcs0: SUCCESS (0.368s)
[438.172779] Starting dynamic subtest: bcs0
[438.516756] Dynamic subtest bcs0: SUCCESS (0.353s)
[438.525278] Starting dynamic subtest: vcs0
[438.873555] Dynamic subtest vcs0: SUCCESS (0.355s)
[438.881894] Starting dynamic subtest: vcs1
[439.223637] Dynamic subtest vcs1: SUCCESS (0.349s)
[439.231837] Starting dynamic subtest: vecs0
[439.569895] Dynamic subtest vecs0: SUCCESS (0.345s)
[439.570726] Subtest preempt-queue-contexts-chain: SUCCESS (1.777s)
[439.846385] [099/130] (571s left) kms_cursor_crc (cursor-onscreen-64x21)
[439.938363] Starting subtest: cursor-onscreen-64x21
[439.943484] Starting dynamic subtest: pipe-A-HDMI-A-1
[440.834757] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.709s)
[440.844310] Starting dynamic subtest: pipe-D-HDMI-A-1
[441.919126] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.230s)
[441.920121] Subtest cursor-onscreen-64x21: FAIL (1.981s)
[442.039187] [100/130] (569s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[442.077874] Starting subtest: no-spare-fences-interruptible
[444.230498] Subtest no-spare-fences-interruptible: SUCCESS (2.152s)
[444.314569] [101/130] (567s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[444.414405] Starting subtest: yf-tiled-64bpp-rotate-0
[444.415826] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[444.482495] [102/130] (567s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[444.572806] Starting subtest: fbcpsr-indfb-scaledprimary
[444.574201] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[444.649333] [103/130] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[444.738797] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[444.740202] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[444.806934] [104/130] (567s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[444.895044] Starting subtest: async-flip-with-page-flip-events-linear
[445.021754] Starting dynamic subtest: pipe-A-HDMI-A-1
[447.100534] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.070s)
[447.227614] Starting dynamic subtest: pipe-B-HDMI-A-1
[449.284743] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.057s)
[449.404043] Starting dynamic subtest: pipe-C-HDMI-A-1
[451.465421] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.060s)
[451.579943] Starting dynamic subtest: pipe-D-HDMI-A-1
[453.649019] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.069s)
[453.649754] Subtest async-flip-with-page-flip-events-linear: SUCCESS (8.748s)
[453.829752] [105/130] (558s left) gem_mmap_gtt (basic-write)
[453.866874] Starting subtest: basic-write
[453.995822] Subtest basic-write: SUCCESS (0.121s)
[454.057831] [106/130] (557s left) kms_scaling_modes (scaling-mode-none)
[454.146818] Starting subtest: scaling-mode-none
[454.150735] Subtest scaling-mode-none: SKIP (0.001s)
[454.192841] [107/130] (557s left) kms_vblank (ts-continuation-modeset-hang)
[454.279435] Starting subtest: ts-continuation-modeset-hang
[454.281702] Starting dynamic subtest: pipe-A-HDMI-A-1
[468.629702] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.349s)
[468.640025] Starting dynamic subtest: pipe-D-HDMI-A-1
[482.435410] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.803s)
[482.436147] Subtest ts-continuation-modeset-hang: SUCCESS (28.158s)
[482.577325] [108/130] (529s left) kms_flip_event_leak (basic)
[482.670518] Starting subtest: basic
[482.672603] Starting dynamic subtest: pipe-A-HDMI-A-1
[482.848341] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.176s)
[482.856940] Starting dynamic subtest: pipe-B-HDMI-A-1
[483.001763] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.152s)
[483.010548] Starting dynamic subtest: pipe-C-HDMI-A-1
[483.163982] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.160s)
[483.172668] Starting dynamic subtest: pipe-D-HDMI-A-1
[483.324741] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.159s)
[483.325417] Subtest basic: SUCCESS (0.655s)
[483.432713] [109/130] (528s left) gem_tiled_partial_pwrite_pread (writes)
[483.469962] Starting subtest: writes
[484.108124] Subtest writes: SUCCESS (0.638s)
[484.204318] [110/130] (527s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[484.292892] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[484.293582] Starting dynamic subtest: pipe-A-HDMI-A-1
[484.296208] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[484.303883] Starting dynamic subtest: pipe-B-HDMI-A-1
[484.306522] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[484.314178] Starting dynamic subtest: pipe-C-HDMI-A-1
[484.316816] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[484.324559] Starting dynamic subtest: pipe-D-HDMI-A-1
[484.327227] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[484.328544] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[484.511163] [111/130] (527s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[484.599012] Starting subtest: cursorB-vs-flipA-atomic-transitions
[484.601575] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[484.641928] [112/130] (527s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[484.731478] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[485.835098] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.104s)
[485.929903] [113/130] (526s left) kms_color (legacy-gamma)
[486.020028] Starting subtest: legacy-gamma
[486.020720] Starting dynamic subtest: pipe-A-HDMI-A-1
[486.340529] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.320s)
[486.349402] Starting dynamic subtest: pipe-B-HDMI-A-1
[486.636992] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.294s)
[486.647092] Starting dynamic subtest: pipe-C-HDMI-A-1
[486.950778] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.314s)
[486.959392] Starting dynamic subtest: pipe-D-HDMI-A-1
[487.250955] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.298s)
[487.251754] Subtest legacy-gamma: SUCCESS (1.231s)
[487.368972] [114/130] (524s left) gem_userptr_blits (forbidden-operations)
[487.408143] Starting subtest: forbidden-operations
[487.408853] Subtest forbidden-operations: SUCCESS (0.001s)
[487.514677] [115/130] (524s left) gem_ctx_param (invalid-get-engines)
[487.549268] Starting subtest: invalid-get-engines
[487.549988] Subtest invalid-get-engines: SUCCESS (0.000s)
[487.590792] [116/130] (524s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[487.686212] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[487.687644] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[487.751380] [117/130] (524s left) syncobj_wait (single-wait-all-submitted)
[487.786144] Starting subtest: single-wait-all-submitted
[487.887724] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[487.946410] [118/130] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[488.035625] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[488.037073] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[488.100095] [119/130] (524s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[488.190738] Starting subtest: psr-rgb565-draw-mmap-gtt
[488.192095] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[488.267218] [120/130] (524s left) kms_content_protection (dp-mst-type-1)
[488.357231] Starting subtest: dp-mst-type-1
[488.358593] Subtest dp-mst-type-1: SKIP (0.000s)
[488.430194] [121/130] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[488.520920] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[488.522344] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[488.587643] [122/130] (523s left) gem_exec_schedule (wide)
[488.748120] Starting subtest: wide
[488.749560] Starting dynamic subtest: rcs0
[499.001909] Dynamic subtest rcs0: SUCCESS (10.222s)
[499.009881] Starting dynamic subtest: bcs0
[510.796881] Dynamic subtest bcs0: SUCCESS (11.794s)
[510.804943] Starting dynamic subtest: vcs0
[522.071823] Dynamic subtest vcs0: SUCCESS (11.271s)
[522.082730] Starting dynamic subtest: vcs1
[533.455582] Dynamic subtest vcs1: SUCCESS (11.384s)
[533.463789] Starting dynamic subtest: vecs0
[545.115282] Dynamic subtest vecs0: SUCCESS (11.656s)
[545.116117] Subtest wide: SUCCESS (56.335s)
[547.175671] [123/130] (465s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[547.273834] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[547.860169] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.586s)
[547.955612] [124/130] (464s left) prime_self_import (basic-llseek-bad)
[547.986850] Starting subtest: basic-llseek-bad
[547.988193] Subtest basic-llseek-bad: SUCCESS (0.002s)
[548.061200] [125/130] (464s left) gem_softpin (zero)
[548.097102] Starting subtest: zero
[548.099898] Subtest zero: SUCCESS (0.003s)
[548.190801] [126/130] (464s left) i915_getparams_basic (basic-subslice-total)
[548.224888] Starting subtest: basic-subslice-total
[548.226274] Subtest basic-subslice-total: SUCCESS (0.000s)
[548.267778] [127/130] (464s left) gem_exec_params (dr4-dirt)
[548.305361] Starting subtest: DR4-dirt
[548.306105] Subtest DR4-dirt: SUCCESS (0.000s)
[548.377415] [128/130] (464s left) prime_busy (hang)
[548.416905] Starting subtest: hang
[548.417682] Starting dynamic subtest: rcs0
[562.810748] Dynamic subtest rcs0: SUCCESS (14.356s)
[562.818305] Starting dynamic subtest: bcs0
[569.594795] Dynamic subtest bcs0: SUCCESS (6.781s)
[569.601953] Starting dynamic subtest: vcs0
[576.570497] Dynamic subtest vcs0: SUCCESS (6.973s)
[576.577705] Starting dynamic subtest: vcs1
[583.611191] Dynamic subtest vcs1: SUCCESS (7.038s)
[583.618427] Starting dynamic subtest: vecs0
[590.587353] Dynamic subtest vecs0: SUCCESS (6.974s)
[590.588317] Subtest hang: SUCCESS (42.130s)
[590.647468] [129/130] (422s left) gem_exec_flush (basic-wb-rw-before-default)
[590.687917] Starting subtest: basic-wb-rw-before-default
[596.116734] Subtest basic-wb-rw-before-default: SUCCESS (5.428s)
[596.314835] [130/130] (416s left) gen9_exec_parse (basic-rejected)
[596.351133] Subtest basic-rejected: SKIP (0.000s)
[596.387225] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: i915_pm_rps
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: gem_pwrite_snooped
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: gem_exec_capture
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: i915_selftest
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: prime_vgem
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_busy
results: parsing output: 42/ for test: kms_atomic
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: gem_ctx_engines
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: drm_read
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: core_getclient
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_mmap
results: parsing output: 58/ for test: kms_chamelium_color
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: core_sysfs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: gem_exercise_blt
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_pipe_crc_basic
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: gem_fenced_exec_thrash
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_async_flips
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_scaling_modes
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_flip_event_leak
results: parsing output: 108/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_color
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: i915_getparams_basic
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: prime_busy
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: gen9_exec_parse
Done.