[73.238832] Initializing watchdogs
[73.238968]   /dev/watchdog0
[73.277352] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[73.284809] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.288438] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.291462] [001/133] (960s left) gem_exec_params (invalid-bsd-ring)
[73.362154] Starting subtest: invalid-bsd-ring
[73.363271] Subtest invalid-bsd-ring: SUCCESS (0.001s)
[73.504532] [002/133] (960s left) kms_lease (simple-lease)
[74.001688] Starting subtest: simple-lease
[74.002837] Starting dynamic subtest: pipe-A-HDMI-A-1
[74.340162] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.338s)
[74.350223] Starting dynamic subtest: pipe-B-HDMI-A-1
[74.646338] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.305s)
[74.647401] Subtest simple-lease: SUCCESS (0.646s)
[75.362475] [003/133] (958s left) kms_rotation_crc (sprite-rotation-90)
[75.855605] Starting subtest: sprite-rotation-90
[75.857868] Subtest sprite-rotation-90: SKIP (0.001s)
[76.429665] [004/133] (957s left) kms_big_fb (linear-16bpp-rotate-180)
[76.931406] Starting subtest: linear-16bpp-rotate-180
[78.281315] Subtest linear-16bpp-rotate-180: SUCCESS (1.349s)
[78.924794] [005/133] (955s left) kms_color_pipeline (plane-lut1d-lut1d)
[79.424182] Starting subtest: plane-lut1d-lut1d
[79.674315] Subtest plane-lut1d-lut1d: SKIP (0.248s)
[80.380077] [006/133] (953s left) kms_psr (pr-primary-page-flip)
[80.875017] Subtest pr-primary-page-flip: SKIP (0.000s)
[81.172212] [007/133] (952s left) kms_cursor_edge_walk (64x64-left-edge)
[81.666518] Starting subtest: 64x64-left-edge
[81.667578] Starting dynamic subtest: pipe-A-HDMI-A-1
[85.071933] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.405s)
[85.082296] Starting dynamic subtest: pipe-B-HDMI-A-1
[88.405844] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.333s)
[88.406929] Subtest 64x64-left-edge: SUCCESS (6.740s)
[89.113685] [008/133] (944s left) kms_vblank (query-forked-hang)
[89.609541] Starting subtest: query-forked-hang
[89.610816] Starting dynamic subtest: pipe-A-HDMI-A-1
[95.939623] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.329s)
[95.950176] Starting dynamic subtest: pipe-B-HDMI-A-1
[101.955687] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.015s)
[101.957099] Subtest query-forked-hang: SUCCESS (12.348s)
[102.703250] [009/133] (931s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[103.210154] Starting subtest: extended-modeset-hang-newfb-with-reset
[103.211248] Starting dynamic subtest: pipe-A
[115.667357] Dynamic subtest pipe-A: SUCCESS (12.457s)
[115.677402] Starting dynamic subtest: pipe-B
[127.455547] Dynamic subtest pipe-B: SUCCESS (11.786s)
[127.459239] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (24.246s)
[128.155342] [010/133] (906s left) kms_psr (fbc-pr-cursor-plane-move)
[128.649719] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[128.945990] [011/133] (905s left) gem_exec_create (basic)
[129.012354] Starting subtest: basic
[129.013460] Starting dynamic subtest: smem
[131.060192] Dynamic subtest smem: SUCCESS (2.048s)
[131.061360] Subtest basic: SUCCESS (2.049s)
[131.296780] [012/133] (902s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[131.352903] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[131.407225] [013/133] (902s left) gem_partial_pwrite_pread (writes-after-reads-display)
[131.466349] Starting subtest: writes-after-reads-display
[136.317282] Subtest writes-after-reads-display: SUCCESS (4.852s)
[136.487059] [014/133] (897s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[136.994356] Starting subtest: y-tiled-64bpp-rotate-270
[136.996421] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[137.599857] [015/133] (896s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[138.089729] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[138.377279] [016/133] (896s left) gem_mmap_wc (write-prefaulted)
[138.432751] Starting subtest: write-prefaulted
[138.582937] Subtest write-prefaulted: SUCCESS (0.150s)
[138.719071] [017/133] (895s left) gem_exec_reloc (basic-write-wc-noreloc)
[138.776540] Starting subtest: basic-write-wc-noreloc
[138.780549] Subtest basic-write-wc-noreloc: SUCCESS (0.002s)
[139.796359] [018/133] (894s left) gem_reg_read (timestamp-monotonic)
[139.852450] Starting subtest: timestamp-monotonic
[144.578336] Subtest timestamp-monotonic: SUCCESS (4.725s)
[144.701192] [019/133] (889s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[145.201903] Starting subtest: 4-tiled-16bpp-rotate-0
[145.204070] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[145.815829] [020/133] (888s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[146.322361] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[147.386245] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.063s)
[148.033236] [021/133] (886s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[148.533960] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[148.536211] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[149.127910] [022/133] (885s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[149.622835] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[149.665242] Starting dynamic subtest: pipe-A-plane-0
[149.667823] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[149.681368] Starting dynamic subtest: pipe-A-plane-1
[149.683929] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[149.697559] Starting dynamic subtest: pipe-A-plane-2
[149.699841] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[149.908353] Starting dynamic subtest: pipe-B-plane-0
[149.910464] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[149.921665] Starting dynamic subtest: pipe-B-plane-1
[149.923821] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[149.934826] Starting dynamic subtest: pipe-B-plane-2
[149.936837] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[149.980546] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.358s)
[150.693218] [023/133] (884s left) kms_psr (fbc-psr-cursor-plane-move)
[151.183340] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[151.494954] [024/133] (883s left) gem_ctx_engines (execute-one)
[151.559422] Starting subtest: execute-one
[151.901210] Subtest execute-one: SUCCESS (0.342s)
[152.121623] [025/133] (882s left) kms_plane_multiple (tiling-yf)
[152.609519] Starting subtest: tiling-yf
[152.611676] Subtest tiling-yf: SKIP (0.000s)
[153.202912] [026/133] (881s left) gen9_exec_parse (batch-invalid-length)
[153.262638] Subtest batch-invalid-length: SKIP (0.000s)
[153.327238] [027/133] (881s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[153.382961] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[153.384157] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[153.503710] [028/133] (881s left) kms_cursor_crc (cursor-random-128x128)
[153.998442] Starting subtest: cursor-random-128x128
[154.001195] Starting dynamic subtest: pipe-A-HDMI-A-1
[157.667564] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.666s)
[157.715074] Starting dynamic subtest: pipe-B-HDMI-A-1
[161.387609] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.691s)
[161.388689] Subtest cursor-random-128x128: SUCCESS (7.390s)
[162.119752] [029/133] (872s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[162.177977] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[162.179126] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[162.303826] [030/133] (872s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[162.797248] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[163.099525] [031/133] (872s left) prime_mmap (test_map_unmap)
[163.155790] Starting subtest: test_map_unmap
[163.156869] Starting dynamic subtest: test_map_unmap-smem
[163.159287] Dynamic subtest test_map_unmap-smem: SUCCESS (0.003s)
[163.160435] Subtest test_map_unmap: SUCCESS (0.004s)
[163.302144] [032/133] (871s left) kms_addfb_basic (too-wide)
[163.794798] Starting subtest: too-wide
[163.795907] Subtest too-wide: SUCCESS (0.000s)
[164.397518] [033/133] (870s left) gem_pxp (reject-modify-context-protection-off-3)
[166.969761] Starting subtest: reject-modify-context-protection-off-3
[166.972186] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[167.091741] [034/133] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[167.583716] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[167.585919] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[168.172273] [035/133] (867s left) prime_mmap (test_reprime)
[168.227712] Starting subtest: test_reprime
[168.228766] Starting dynamic subtest: test_reprime-smem
[168.231341] Dynamic subtest test_reprime-smem: SUCCESS (0.003s)
[168.232427] Subtest test_reprime: SUCCESS (0.004s)
[168.378344] [036/133] (867s left) gem_request_retire (retire-vma-not-inactive)
[168.434866] Starting subtest: retire-vma-not-inactive
[168.439191] Subtest retire-vma-not-inactive: SUCCESS (0.004s)
[168.588151] [037/133] (866s left) gem_wait (write-wait)
[168.657903] Starting subtest: write-wait
[168.658962] Starting dynamic subtest: all-engines
[169.719698] Dynamic subtest all-engines: SUCCESS (1.061s)
[169.732794] Starting dynamic subtest: rcs0
[170.746556] Dynamic subtest rcs0: SUCCESS (1.025s)
[170.759368] Starting dynamic subtest: bcs0
[171.775732] Dynamic subtest bcs0: SUCCESS (1.027s)
[171.788452] Starting dynamic subtest: vcs0
[172.801645] Dynamic subtest vcs0: SUCCESS (1.024s)
[172.803033] Subtest write-wait: SUCCESS (4.145s)
[173.051409] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[173.055061] [038/133] (862s left) gem_exec_schedule (implicit-boths)
[173.120429] Starting subtest: implicit-boths
[173.121434] Starting dynamic subtest: rcs0
[173.151970] Dynamic subtest rcs0: SUCCESS (0.031s)
[173.164508] Starting dynamic subtest: bcs0
[173.182225] Dynamic subtest bcs0: SUCCESS (0.029s)
[173.183275] Subtest implicit-boths: SUCCESS (0.062s)
[173.453448] [039/133] (862s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[173.945890] Starting subtest: addfb25-x-tiled-mismatch-legacy
[173.946995] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[174.549458] [040/133] (861s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[175.049545] Starting subtest: fbc-modesetfrombusy
[175.966965] Subtest fbc-modesetfrombusy: SUCCESS (0.920s)
[176.583195] [041/133] (859s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[177.151510] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[177.553852] [042/133] (858s left) kms_vblank (accuracy-idle)
[178.044343] Starting subtest: accuracy-idle
[178.045540] Starting dynamic subtest: pipe-A-HDMI-A-1
[180.271155] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.224s)
[180.281945] Starting dynamic subtest: pipe-B-HDMI-A-1
[182.510491] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.239s)
[182.511602] Subtest accuracy-idle: SUCCESS (4.468s)
[183.225236] [043/133] (852s left) prime_vgem (shrink)
[183.292843] Starting subtest: shrink
[183.302488] Subtest shrink: SUCCESS (0.009s)
[183.452678] [044/133] (852s left) gem_ppgtt (blt-vs-render-ctx0)
[183.511561] Starting subtest: blt-vs-render-ctx0
[216.491143] Subtest blt-vs-render-ctx0: SUCCESS (32.979s)
[216.659969] [045/133] (819s left) api_intel_allocator (reserve-simple)
[216.798152] Starting subtest: reserve-simple
[216.801175] Subtest reserve-simple: SUCCESS (0.005s)
[216.939647] [046/133] (819s left) kms_flip (flip-vs-panning-interruptible)
[217.445152] Starting subtest: flip-vs-panning-interruptible
[217.446254] Starting dynamic subtest: A-VGA1
[225.236805] Dynamic subtest A-VGA1: SUCCESS (7.792s)
[225.250998] Starting dynamic subtest: B-VGA1
[232.945565] Dynamic subtest B-VGA1: SUCCESS (7.706s)
[232.958850] Starting dynamic subtest: A-HDMI-A1
[240.722724] Dynamic subtest A-HDMI-A1: SUCCESS (7.774s)
[240.738351] Starting dynamic subtest: B-HDMI-A1
[248.524566] Dynamic subtest B-HDMI-A1: SUCCESS (7.799s)
[248.527652] Subtest flip-vs-panning-interruptible: SUCCESS (31.083s)
[249.314181] [047/133] (786s left) syncobj_eventfd (invalid-bad-pad)
[249.381485] Starting subtest: invalid-bad-pad
[249.382501] Subtest invalid-bad-pad: SUCCESS (0.000s)
[249.481231] [048/133] (786s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[249.538276] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[249.609329] [049/133] (786s left) gem_eio (banned)
[249.672898] Starting subtest: banned
[249.745382] Subtest banned: SUCCESS (0.072s)
[250.793599] [050/133] (785s left) gem_exec_alignment (pi-isolated)
[250.852972] Starting subtest: pi-isolated
[250.855325] Subtest pi-isolated: SKIP (0.000s)
[251.008858] [051/133] (785s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[251.063896] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[251.127410] [052/133] (785s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[251.188068] Starting subtest: multi-wait-for-submit-available-submitted
[251.189200] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[251.291557] [053/133] (785s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[251.785256] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[251.788649] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[252.391547] [054/133] (783s left) gem_exec_schedule (u-semaphore-codependency)
[252.462596] Subtest u-semaphore-codependency: SKIP (0.000s)
[252.692549] [055/133] (783s left) gem_exec_fence (nb-await)
[252.868549] Subtest nb-await: SKIP (0.000s)
[253.293360] [056/133] (783s left) perf_pmu (busy-accuracy-98)
[253.350790] Starting subtest: busy-accuracy-98
[253.351889] Starting dynamic subtest: rcs0
[253.354094] Dynamic subtest rcs0: SKIP (0.000s)
[253.369726] Starting dynamic subtest: bcs0
[253.372337] Dynamic subtest bcs0: SKIP (0.000s)
[253.390915] Starting dynamic subtest: vcs0
[253.393410] Dynamic subtest vcs0: SKIP (0.000s)
[253.395687] Subtest busy-accuracy-98: SKIP (0.004s)
[253.490416] [057/133] (783s left) gem_madvise (dontneed-before-exec)
[253.543041] Starting subtest: dontneed-before-exec
[253.545647] Subtest dontneed-before-exec: SUCCESS (0.004s)
[253.704648] [058/133] (782s left) kms_draw_crc (draw-method-render)
[254.190012] Starting subtest: draw-method-render
[254.191177] Starting dynamic subtest: xrgb8888-untiled
[254.484610] Dynamic subtest xrgb8888-untiled: SUCCESS (0.296s)
[254.500934] Starting dynamic subtest: rgb565-untiled
[254.767648] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[254.785335] Starting dynamic subtest: xrgb2101010-untiled
[255.083701] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.313s)
[255.098637] Starting dynamic subtest: xbgr16161616f-untiled
[255.433090] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.346s)
[255.447175] Starting dynamic subtest: xrgb8888-xtiled
[255.599405] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.164s)
[255.613746] Starting dynamic subtest: rgb565-xtiled
[255.749253] Dynamic subtest rgb565-xtiled: SUCCESS (0.147s)
[255.766531] Starting dynamic subtest: xrgb2101010-xtiled
[255.915545] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.163s)
[255.930948] Starting dynamic subtest: xbgr16161616f-xtiled
[256.099966] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s)
[256.101126] Subtest draw-method-render: SUCCESS (1.911s)
[256.731967] [059/133] (779s left) gem_exec_balancer (bonded-true-hang)
[256.791307] Subtest bonded-true-hang: SKIP (0.000s)
[256.913805] [060/133] (779s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[256.970346] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.000s)
[257.025896] [061/133] (779s left) kms_pm_lpsp (screens-disabled)
[268.550472] Starting subtest: screens-disabled
[268.695117] Subtest screens-disabled: SKIP (0.143s)
[269.404114] [062/133] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[269.894598] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[269.896760] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[270.502852] [063/133] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[270.990174] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[270.992300] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[271.601632] [064/133] (765s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[272.105022] Starting subtest: x-tiled-16bpp-rotate-180
[273.379450] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.275s)
[274.040342] [065/133] (762s left) perf (invalid-open-flags)
[274.202415] Subtest invalid-open-flags: SKIP (0.000s)
[274.255673] [066/133] (762s left) syncobj_wait (single-wait-for-submit-submitted)
[274.313822] Starting subtest: single-wait-for-submit-submitted
[274.417109] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[274.549292] [067/133] (762s left) gem_softpin (allocator-basic-reserve)
[274.605423] Subtest allocator-basic-reserve: SKIP (0.000s)
[274.729417] [068/133] (762s left) gen9_exec_parse (unaligned-jump)
[274.789869] Subtest unaligned-jump: SKIP (0.000s)
[274.855834] [069/133] (762s left) kms_dp_linktrain_fallback (dsc-fallback)
[275.348141] Starting subtest: dsc-fallback
[275.351439] Subtest dsc-fallback: SKIP (0.000s)
[275.959507] [070/133] (761s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[276.454465] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[276.456628] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[277.056412] [071/133] (760s left) kms_prop_blob (invalid-get-prop-any)
[277.116432] Starting subtest: invalid-get-prop-any
[277.117449] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[277.221729] [072/133] (760s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[277.717547] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[277.719518] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[278.305583] [073/133] (759s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[278.797373] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[278.798379] Starting dynamic subtest: pipe-A
[278.801396] Dynamic subtest pipe-A: SKIP (0.001s)
[278.813062] Starting dynamic subtest: pipe-B
[278.816338] Dynamic subtest pipe-B: SKIP (0.001s)
[278.818440] Subtest planes-unity-scaling-downscale-factor-0-75: SKIP (0.006s)
[279.427860] [074/133] (758s left) vgem_slow (nohang)
[279.486634] Starting subtest: nohang
[289.890545] Subtest nohang: SUCCESS (10.405s)
[289.978661] [075/133] (747s left) gem_mmap_gtt (basic-read)
[290.033981] Starting subtest: basic-read
[290.070127] Subtest basic-read: SUCCESS (0.037s)
[290.256200] [076/133] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[290.758322] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[292.260298] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (1.504s)
[292.910809] [077/133] (744s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[293.404379] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[293.407374] Starting dynamic subtest: AB-VGA1-HDMI-A1
[324.112753] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.706s)
[324.117746] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SUCCESS (30.710s)
[324.935770] [078/133] (712s left) sysfs_heartbeat_interval (invalid)
[324.996042] Starting subtest: invalid
[324.999125] Starting dynamic subtest: vcs0
[325.000150] Dynamic subtest vcs0: SUCCESS (0.000s)
[325.014712] Starting dynamic subtest: bcs0
[325.015819] Dynamic subtest bcs0: SUCCESS (0.000s)
[325.034194] Starting dynamic subtest: rcs0
[325.035408] Dynamic subtest rcs0: SUCCESS (0.001s)
[325.036603] Subtest invalid: SUCCESS (0.010s)
[325.132261] [079/133] (712s left) gem_mmap_gtt (medium-copy)
[325.186336] Starting subtest: medium-copy
[326.070394] Subtest medium-copy: SUCCESS (0.884s)
[326.233743] [080/133] (711s left) i915_suspend (forcewake)
[326.383346] Starting subtest: forcewake
[360.010926] Subtest forcewake: SUCCESS (1.186s)
[375.143384] [081/133] (677s left) kms_chamelium_frames (hdmi-frame-dump)
[375.733129] Subtest hdmi-frame-dump: SKIP (0.000s)
[376.155496] [082/133] (676s left) i915_module_load (reload-no-display)
[376.213745] Starting subtest: reload-no-display
[381.998065] Subtest reload-no-display: SUCCESS (5.642s)
[382.034941] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[382.036654] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[382.039165] [083/133] (670s left) syncobj_wait (wait-all-interrupted)
[384.139029] Starting subtest: wait-all-interrupted
[384.247468] Subtest wait-all-interrupted: SUCCESS (0.107s)
[384.317302] [FACT syncobj_wait (wait-all-interrupted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[384.318965] [FACT syncobj_wait (wait-all-interrupted)] new: kernel.kmod_is_loaded.i915: true
[384.323425] [084/133] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[384.824006] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[384.826075] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[385.450358] [085/133] (667s left) gem_workarounds (basic-read)
[385.522117] Starting subtest: basic-read
[385.530601] Subtest basic-read: SUCCESS (0.008s)
[385.703181] [086/133] (667s left) gem_exec_params (invalid-flag)
[385.764421] Starting subtest: invalid-flag
[385.765494] Subtest invalid-flag: SUCCESS (0.000s)
[385.902294] [087/133] (667s left) gem_ccs (block-copy-compressed)
[385.957251] Subtest block-copy-compressed: SKIP (0.000s)
[386.018531] [088/133] (667s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[386.513075] Starting subtest: fbc-rgb101010-draw-render
[389.138716] Subtest fbc-rgb101010-draw-render: SUCCESS (2.607s)
[389.778932] [089/133] (663s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[389.835323] Starting subtest: etime-multi-wait-all-submitted-signaled
[389.943916] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[390.080186] [090/133] (663s left) kms_chamelium_color (ctm-limited-range)
[390.567981] Subtest ctm-limited-range: SKIP (0.000s)
[390.897652] [091/133] (662s left) gem_ctx_persistence (legacy-engines-mixed)
[390.954885] Subtest legacy-engines-mixed: SKIP (0.000s)
[391.029363] [092/133] (662s left) drm_buddy (drm_buddy)
[391.088667] Starting subtest: drm_buddy
[391.092455] Subtest drm_buddy: SKIP (0.001s)
[391.184148] [093/133] (662s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[391.675855] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[391.677935] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[392.286259] [094/133] (661s left) api_intel_bb (reset-flags)
[392.340876] Starting subtest: reset-flags
[392.347578] Subtest reset-flags: SUCCESS (0.007s)
[392.503911] [095/133] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[392.996007] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[392.998244] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[393.607933] [096/133] (660s left) kms_content_protection (dp-mst-type-0)
[394.118741] Starting subtest: dp-mst-type-0
[394.120863] Subtest dp-mst-type-0: SKIP (0.000s)
[394.738873] [097/133] (659s left) perf_pmu (rc6-all-gts)
[394.802255] Starting subtest: rc6-all-gts
[394.804433] Subtest rc6-all-gts: SKIP (0.000s)
[394.947647] [098/133] (658s left) syncobj_wait (invalid-reset-bad-pad)
[395.007661] Starting subtest: invalid-reset-bad-pad
[395.008896] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[395.144371] [099/133] (658s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[395.203500] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[395.272270] [100/133] (658s left) gem_huc_copy (huc-copy)
[395.327014] Subtest huc-copy: SKIP (0.000s)
[395.385423] [101/133] (658s left) syncobj_timeline (wait-all-for-submit-complex)
[395.442807] Starting subtest: wait-all-for-submit-complex
[395.659073] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[395.792911] [102/133] (658s left) kms_plane (pixel-format-linear-modifier)
[396.281267] Starting subtest: pixel-format-linear-modifier
[396.324451] Starting dynamic subtest: pipe-A-plane-0
[397.524178] Dynamic subtest pipe-A-plane-0: SUCCESS (1.196s)
[397.542241] Starting dynamic subtest: pipe-A-plane-1
[398.457959] Dynamic subtest pipe-A-plane-1: SUCCESS (0.928s)
[398.475757] Starting dynamic subtest: pipe-A-plane-2
[398.675273] Dynamic subtest pipe-A-plane-2: SUCCESS (0.214s)
[398.929914] Starting dynamic subtest: pipe-B-plane-0
[400.087751] Dynamic subtest pipe-B-plane-0: SUCCESS (1.180s)
[400.104583] Starting dynamic subtest: pipe-B-plane-1
[401.021338] Dynamic subtest pipe-B-plane-1: SUCCESS (0.930s)
[401.039863] Starting dynamic subtest: pipe-B-plane-2
[401.237818] Dynamic subtest pipe-B-plane-2: SUCCESS (0.213s)
[401.337911] Subtest pixel-format-linear-modifier: SUCCESS (5.046s)
[402.080541] [103/133] (652s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[402.572190] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[402.574284] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[403.174465] [104/133] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[403.673030] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[403.675176] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[404.271472] [105/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[404.763000] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[404.765185] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[405.354949] [106/133] (648s left) kms_atomic_interruptible (legacy-dpms)
[405.843165] Starting subtest: legacy-dpms
[405.846362] Starting dynamic subtest: pipe-A-HDMI-A-1
[412.136793] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.286s)
[412.137864] Subtest legacy-dpms: SUCCESS (6.289s)
[412.841597] [107/133] (641s left) kms_pm_rpm (modeset-pc8-residency-stress)
[424.671087] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[424.966440] [108/133] (629s left) kms_cursor_crc (cursor-onscreen-512x170)
[425.465673] Starting subtest: cursor-onscreen-512x170
[425.467811] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[426.070004] [109/133] (628s left) gem_mmap (bad-offset)
[426.133894] Starting subtest: bad-offset
[426.134947] Subtest bad-offset: SUCCESS (0.001s)
[426.268527] [110/133] (628s left) gem_mmap_gtt (hang-busy)
[426.324845] Starting subtest: hang-busy
[432.099468] Subtest hang-busy: SUCCESS (5.773s)
[432.240520] [111/133] (622s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[432.738562] Starting subtest: 4-tiled-64bpp-rotate-0
[432.740660] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[433.354981] [112/133] (621s left) i915_query (query-topology-kernel-writes)
[433.411094] Starting subtest: query-topology-kernel-writes
[433.413279] Subtest query-topology-kernel-writes: SKIP (0.000s)
[433.541575] [113/133] (621s left) gem_userptr_blits (map-fixed-invalidate-busy)
[433.612486] Starting subtest: map-fixed-invalidate-busy
[433.613603] Starting dynamic subtest: gtt
[434.592395] Dynamic subtest gtt: SUCCESS (0.979s)
[434.606496] Starting dynamic subtest: wb
[435.547833] Dynamic subtest wb: SUCCESS (0.953s)
[435.561687] Starting dynamic subtest: wc
[436.513709] Dynamic subtest wc: SUCCESS (0.964s)
[436.527917] Starting dynamic subtest: uc
[437.478270] Dynamic subtest uc: SUCCESS (0.962s)
[437.479405] Subtest map-fixed-invalidate-busy: SUCCESS (3.866s)
[437.668161] [114/133] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[438.156764] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[438.158802] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[438.770574] [115/133] (616s left) i915_pm_rps (min-max-config-idle)
[438.833378] Starting subtest: min-max-config-idle
[439.037548] Subtest min-max-config-idle: SUCCESS (0.204s)
[439.199184] [116/133] (615s left) kms_psr (psr-no-drrs)
[439.692930] Subtest psr-no-drrs: SKIP (0.000s)
[439.995448] [117/133] (614s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[440.486830] Starting subtest: invalid-modeset-force-ultra-joiner
[440.488936] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[441.080920] [118/133] (613s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[441.573457] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[441.575954] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[442.179411] [119/133] (612s left) gem_exec_schedule (preempt-queue-chain)
[442.246236] Subtest preempt-queue-chain: SKIP (0.000s)
[442.478960] [120/133] (612s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[442.544865] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[442.547375] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[442.795309] [121/133] (612s left) gem_exec_whisper (basic-contexts)
[442.860196] Starting subtest: basic-contexts
[444.588392] Subtest basic-contexts: SUCCESS (1.726s)
[444.827100] [122/133] (610s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[445.317313] Starting subtest: basic-flip-after-cursor-atomic
[446.318041] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.000s)
[447.033331] [123/133] (608s left) gem_ctx_persistence (engines-mixed)
[447.091731] Subtest engines-mixed: SKIP (0.000s)
[447.180367] [124/133] (608s left) gem_exec_balancer (semaphore)
[447.242352] Subtest semaphore: SKIP (0.000s)
[447.368567] [125/133] (607s left) perf_pmu (all-busy-idle-check-all)
[447.423834] Starting subtest: all-busy-idle-check-all
[448.043292] Subtest all-busy-idle-check-all: SUCCESS (0.619s)
[448.181247] [126/133] (607s left) kms_psr (psr2-sprite-render)
[448.664612] Subtest psr2-sprite-render: SKIP (0.000s)
[448.973231] [127/133] (606s left) kms_pipe_crc_basic (suspend-read-crc)
[449.466698] Starting subtest: suspend-read-crc
[449.467823] Starting dynamic subtest: pipe-A-HDMI-A-1
[467.456322] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.630s)
[467.471314] Starting dynamic subtest: pipe-B-HDMI-A-1
[485.405428] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.627s)
[485.408274] Subtest suspend-read-crc: SUCCESS (3.263s)
[499.155744] [128/133] (569s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[499.214442] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[499.281987] [129/133] (569s left) gem_close (basic)
[499.339507] Starting subtest: basic
[499.340639] Subtest basic: SUCCESS (0.000s)
[499.483151] [130/133] (569s left) vgem_basic (unload)
[499.535860] Starting subtest: unload
[528.605381] Subtest unload: SUCCESS (28.775s)
[528.777853] [131/133] (539s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[529.267474] Starting subtest: psr-2p-primscrn-spr-indfb-move
[529.269549] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[529.871991] [132/133] (538s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[529.926896] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[529.999821] [133/133] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[530.490115] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[530.493359] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[531.083198] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_color_pipeline
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: kms_busy
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_exec_create
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gem_partial_pwrite_pread
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: gem_reg_read
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_ctx_engines
results: parsing output: 24/ for test: kms_plane_multiple
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: prime_mmap
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: gem_request_retire
results: parsing output: 36/ for test: gem_wait
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: gem_ppgtt
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: syncobj_eventfd
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_eio
results: parsing output: 49/ for test: gem_exec_alignment
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: gem_madvise
results: parsing output: 57/ for test: kms_draw_crc
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_pm_lpsp
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_dp_linktrain_fallback
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_prop_blob
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: vgem_slow
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: sysfs_heartbeat_interval
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: i915_suspend
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: i915_module_load
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_workarounds
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: gem_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_chamelium_color
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: drm_buddy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_huc_copy
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_atomic_interruptible
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_mmap
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: i915_query
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: i915_pm_rps
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_joiner
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: gem_exec_whisper
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_pipe_crc_basic
results: parsing output: 127/ for test: kms_pipe_b_c_ivb
results: parsing output: 128/ for test: gem_close
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.