[73.265109] Initializing watchdogs
[73.265266]   /dev/watchdog0
[73.284967] [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.292843] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.296463] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.302530] [001/132] (960s left) kms_feature_discovery (psr1)
[73.800095] Starting subtest: psr1
[73.804682] Subtest psr1: SKIP (0.000s)
[73.906855] [002/132] (959s left) gem_exec_whisper (basic-queues-priority)
[73.983771] Starting subtest: basic-queues-priority
[73.987914] Subtest basic-queues-priority: SKIP (0.001s)
[74.191256] [003/132] (959s left) gem_shrink (reclaim)
[74.256167] Starting subtest: reclaim
[76.593586] Subtest reclaim: SUCCESS (2.338s)
[76.697180] [004/132] (957s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[76.766255] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.000s)
[76.809270] [005/132] (957s left) kms_pm_dc (dc6-psr)
[87.918807] Subtest dc6-psr: SKIP (0.000s)
[87.973650] [006/132] (946s left) gem_exec_capture (userptr)
[88.042902] Subtest userptr: SKIP (0.000s)
[88.111387] [007/132] (945s left) perf_pmu (busy-accuracy-98)
[88.173873] Starting subtest: busy-accuracy-98
[88.175589] Starting dynamic subtest: rcs0
[88.178785] Dynamic subtest rcs0: SKIP (0.000s)
[88.190241] Starting dynamic subtest: bcs0
[88.193837] Dynamic subtest bcs0: SKIP (0.000s)
[88.206927] Starting dynamic subtest: vcs0
[88.210820] Dynamic subtest vcs0: SKIP (0.000s)
[88.214627] Subtest busy-accuracy-98: SKIP (0.001s)
[88.261958] [008/132] (945s left) sysfs_heartbeat_interval (nopreempt)
[88.322845] Starting subtest: nopreempt
[88.324596] Starting dynamic subtest: vcs0
[88.328014] Dynamic subtest vcs0: SKIP (0.000s)
[88.339431] Starting dynamic subtest: bcs0
[88.343382] Dynamic subtest bcs0: SKIP (0.000s)
[88.354258] Starting dynamic subtest: rcs0
[88.358291] Dynamic subtest rcs0: SKIP (0.000s)
[88.362299] Subtest nopreempt: SKIP (0.002s)
[88.414635] [009/132] (945s left) kms_flip (2x-blocking-wf_vblank)
[88.895216] Starting subtest: 2x-blocking-wf_vblank
[88.896864] Starting dynamic subtest: AB-VGA1-HDMI-A1
[119.685729] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.790s)
[119.687764] Subtest 2x-blocking-wf_vblank: SUCCESS (30.793s)
[119.935059] [010/132] (914s left) kms_plane (pixel-format-yf-tiled-modifier)
[120.419159] Starting subtest: pixel-format-yf-tiled-modifier
[120.423301] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[120.517376] [011/132] (913s left) gem_spin_batch (engines)
[120.590778] Starting subtest: engines
[120.592699] Starting dynamic subtest: rcs0
[123.903433] Dynamic subtest rcs0: SUCCESS (3.311s)
[123.913205] Starting dynamic subtest: bcs0
[127.213635] Dynamic subtest bcs0: SUCCESS (3.310s)
[127.223378] Starting dynamic subtest: vcs0
[130.523738] Dynamic subtest vcs0: SUCCESS (3.310s)
[130.525322] Subtest engines: SUCCESS (9.932s)
[130.733624] [012/132] (903s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[131.217375] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[131.285422] [013/132] (903s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[131.777421] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[131.781505] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[131.879608] [014/132] (902s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[132.362655] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[132.409883] [015/132] (902s left) kms_invalid_mode (bad-vtotal)
[132.890114] Starting subtest: bad-vtotal
[132.893709] Starting dynamic subtest: pipe-A-VGA-1
[132.999729] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.112s)
[133.010482] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.012675] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[133.024506] Starting dynamic subtest: pipe-B-VGA-1
[133.026642] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s)
[133.038463] Starting dynamic subtest: pipe-B-HDMI-A-1
[133.040127] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[133.041896] Subtest bad-vtotal: SUCCESS (0.117s)
[133.255763] [016/132] (901s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[133.739820] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[133.798859] [017/132] (900s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[133.871874] Starting subtest: x-tiled-to-vebox-y-tiled
[133.875952] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[134.071276] [018/132] (900s left) gem_exec_schedule (preempt-queue)
[134.150150] Subtest preempt-queue: SKIP (0.000s)
[134.336751] [019/132] (900s left) gem_exec_fence (expired-history)
[134.571381] Starting subtest: expired-history
[134.625148] Subtest expired-history: SUCCESS (0.055s)
[134.941860] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[134.945593] [020/132] (899s left) kms_color (legacy-gamma-reset)
[135.427267] Starting subtest: legacy-gamma-reset
[135.429297] Starting dynamic subtest: pipe-A-VGA-1
[135.676509] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.249s)
[135.686840] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.688461] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.005s)
[135.698717] Starting dynamic subtest: pipe-B-VGA-1
[135.700302] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.004s)
[135.710373] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.711950] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[135.713591] Subtest legacy-gamma-reset: SUCCESS (0.264s)
[135.931204] [021/132] (898s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[136.426145] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[137.584984] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.158s)
[137.806630] [022/132] (897s left) kms_draw_crc (fill-fb)
[138.294810] Starting subtest: fill-fb
[138.652869] Subtest fill-fb: SUCCESS (0.361s)
[138.859794] [023/132] (896s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[139.347228] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[139.351135] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[139.458156] [024/132] (895s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[139.520398] Starting subtest: wait-all-for-submit-delayed-submit
[139.625772] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[139.727249] [025/132] (895s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[139.792465] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[139.850097] [026/132] (895s left) core_setmaster (master-drop-set-root)
[139.959600] Starting subtest: master-drop-set-root
[139.990486] Subtest master-drop-set-root: SUCCESS (0.031s)
[140.055749] [027/132] (895s left) kms_addfb_basic (unused-offsets)
[140.116197] Starting subtest: unused-offsets
[140.117857] Subtest unused-offsets: SUCCESS (0.000s)
[140.642886] [028/132] (894s left) kms_psr (psr2-cursor-blt)
[141.151867] Subtest psr2-cursor-blt: SKIP (0.000s)
[141.217144] [029/132] (893s left) prime_busy (after)
[141.285712] Starting subtest: after
[141.291171] Starting dynamic subtest: rcs0
[141.308264] Dynamic subtest rcs0: SUCCESS (0.016s)
[141.320244] Starting dynamic subtest: bcs0
[141.321903] Dynamic subtest bcs0: SUCCESS (0.011s)
[141.333860] Starting dynamic subtest: vcs0
[141.335971] Dynamic subtest vcs0: SUCCESS (0.015s)
[141.442966] Subtest after: SUCCESS (0.157s)
[141.546259] [030/132] (893s left) i915_query (query-garbage)
[141.606572] Starting subtest: query-garbage
[141.608829] Subtest query-garbage: SUCCESS (0.000s)
[141.700512] [031/132] (893s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[142.288700] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[142.499795] [032/132] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[142.994134] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[142.998131] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[143.102495] [033/132] (892s left) kms_cursor_edge_walk (128x128-left-edge)
[143.586019] Starting subtest: 128x128-left-edge
[143.589939] Starting dynamic subtest: pipe-A-VGA-1
[146.971923] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.387s)
[146.982484] Starting dynamic subtest: pipe-B-HDMI-A-1
[150.302923] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.329s)
[150.304710] Subtest 128x128-left-edge: SUCCESS (6.720s)
[150.542620] [034/132] (884s left) syncobj_basic (bad-pad-handle-to-fd)
[150.607882] Starting subtest: bad-pad-handle-to-fd
[150.609577] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[150.706368] [035/132] (884s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[151.193551] Starting subtest: yf-tiled-64bpp-rotate-180
[151.198071] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[151.291083] [036/132] (884s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[151.772203] Starting subtest: addfb25-y-tiled-small-legacy
[151.776511] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[151.877305] [037/132] (883s left) gem_ctx_param (invalid-set-no-zeromap)
[151.941891] Starting subtest: invalid-set-no-zeromap
[151.944106] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[152.025926] [038/132] (883s left) kms_cursor_crc (cursor-onscreen-max-size)
[152.518777] Starting subtest: cursor-onscreen-max-size
[152.524796] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[152.626142] [039/132] (883s left) kms_psr (psr2-cursor-plane-move)
[153.109664] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[153.173241] [040/132] (882s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[153.665139] Starting subtest: y-tiled-32bpp-rotate-270
[153.669013] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[153.769704] [041/132] (882s left) prime_mmap (test_forked_cpu_write)
[153.830032] Starting subtest: test_forked_cpu_write
[153.831629] Starting dynamic subtest: test_forked_cpu_write-smem
[153.845177] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.015s)
[153.847069] Subtest test_forked_cpu_write: SUCCESS (0.016s)
[153.955321] [042/132] (881s left) prime_mmap (test_refcounting)
[154.014466] Starting subtest: test_refcounting
[154.016093] Starting dynamic subtest: test_refcounting-smem
[154.018337] Dynamic subtest test_refcounting-smem: SUCCESS (0.003s)
[154.020295] Subtest test_refcounting: SUCCESS (0.003s)
[154.118244] [043/132] (881s left) gem_exec_gttfill (multigpu-basic)
[154.295141] Starting subtest: multigpu-basic
[159.013638] Subtest multigpu-basic: SUCCESS (4.719s)
[159.081649] [044/132] (876s left) kms_psr (fbc-psr-cursor-plane-move)
[159.611887] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[159.675128] [045/132] (876s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[160.182115] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[162.243370] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.083s)
[162.391306] [046/132] (873s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[162.885926] Starting subtest: 4-tiled-8bpp-rotate-0
[162.889467] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[162.991812] [047/132] (873s left) kms_plane_multiple (tiling-none)
[163.466416] Starting subtest: tiling-none
[163.468243] Starting dynamic subtest: pipe-A-VGA-1
[164.221902] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.756s)
[164.233455] Starting dynamic subtest: pipe-A-HDMI-A-1
[165.209076] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.985s)
[165.220407] Starting dynamic subtest: pipe-B-VGA-1
[165.929578] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.720s)
[165.941160] Starting dynamic subtest: pipe-B-HDMI-A-1
[166.959044] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.028s)
[166.960778] Subtest tiling-none: SUCCESS (3.495s)
[167.213261] [048/132] (868s left) gem_mmap_gtt (basic-small-bo-tiledx)
[167.283636] Starting subtest: basic-small-bo-tiledX
[167.489783] Subtest basic-small-bo-tiledX: SUCCESS (0.205s)
[167.625935] [049/132] (868s left) gem_ctx_shared (detached-shared-gtt)
[167.775485] Subtest detached-shared-gtt: SKIP (0.000s)
[167.865462] [050/132] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[168.367112] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[168.370954] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[168.467309] [051/132] (867s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[168.541808] Starting subtest: invalid-multi-wait-unsubmitted
[168.543766] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[168.631560] [052/132] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[169.119162] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[169.123089] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[169.234895] [053/132] (867s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[169.302809] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[169.363378] [054/132] (867s left) gem_mmap_gtt (medium-copy-odd)
[169.423367] Starting subtest: medium-copy-odd
[170.234795] Subtest medium-copy-odd: SUCCESS (0.812s)
[170.347666] [055/132] (866s left) sw_sync (sync_random_merge)
[170.494048] Starting subtest: sync_random_merge
[170.608613] Subtest sync_random_merge: SUCCESS (0.113s)
[170.689626] [056/132] (865s left) perf_pmu (interrupts)
[170.750141] Starting subtest: interrupts
[171.796167] Subtest interrupts: SUCCESS (1.044s)
[171.911758] [057/132] (864s left) vgem_basic (unload)
[171.972829] Starting subtest: unload
[200.943920] Subtest unload: SUCCESS (28.971s)
[201.079685] [058/132] (835s left) kms_chamelium_edid (dp-mode-timings)
[201.682968] Subtest dp-mode-timings: SKIP (0.000s)
[201.894615] [059/132] (834s left) syncobj_wait (wait-all-snapshot)
[201.959324] Starting subtest: wait-all-snapshot
[202.041321] Subtest wait-all-snapshot: SUCCESS (0.082s)
[202.143517] [060/132] (834s left) i915_query (engine-info-invalid)
[202.206151] Starting subtest: engine-info-invalid
[202.207934] Subtest engine-info-invalid: SUCCESS (0.000s)
[202.294962] [061/132] (834s left) kms_atomic_interruptible (legacy-cursor)
[202.777610] Starting subtest: legacy-cursor
[202.779194] Starting dynamic subtest: pipe-A-VGA-1
[209.081874] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.302s)
[209.083912] Subtest legacy-cursor: SUCCESS (6.303s)
[209.341875] [062/132] (827s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[209.829739] Starting subtest: flip-vs-cursor-toggle
[224.102988] Subtest flip-vs-cursor-toggle: SUCCESS (14.272s)
[224.361630] [063/132] (812s left) perf_pmu (busy-idle-no-semaphores)
[224.423909] Starting subtest: busy-idle-no-semaphores
[224.425945] Starting dynamic subtest: rcs0
[225.046283] Dynamic subtest rcs0: SUCCESS (0.621s)
[225.060077] Starting dynamic subtest: bcs0
[225.677187] Dynamic subtest bcs0: SUCCESS (0.630s)
[225.691240] Starting dynamic subtest: vcs0
[226.794950] Dynamic subtest vcs0: SUCCESS (1.117s)
[226.796880] Subtest busy-idle-no-semaphores: SUCCESS (2.371s)
[226.914536] [064/132] (810s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[227.401356] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[227.405300] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[227.503759] [065/132] (809s left) template (b)
[227.564770] Starting subtest: B
[227.566695] Subtest B: SUCCESS (0.000s)
[227.668725] [066/132] (809s left) kms_frontbuffer_tracking (fbc-1p-rte)
[228.159803] Starting subtest: fbc-1p-rte
[231.364257] Subtest fbc-1p-rte: SUCCESS (3.209s)
[231.619342] [067/132] (805s left) gem_unref_active_buffers
[231.819337] [068/132] (805s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[232.310207] Starting subtest: short-flip-before-cursor-atomic-transitions
[233.344820] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.034s)
[233.610755] [069/132] (803s left) i915_pm_freq_api (freq-suspend)
[233.679162] Subtest freq-suspend: SKIP (0.000s)
[233.748874] [070/132] (803s left) gen9_exec_parse (unaligned-access)
[233.818908] Subtest unaligned-access: SKIP (0.000s)
[233.880349] [071/132] (803s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[234.368990] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[234.373056] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[234.484274] [072/132] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[234.974436] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[236.940875] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (1.970s)
[237.182434] [073/132] (800s left) gen9_exec_parse (batch-invalid-length)
[237.246211] Subtest batch-invalid-length: SKIP (0.000s)
[237.306669] [074/132] (800s left) gem_pread (bench)
[237.374785] Starting subtest: bench
[238.702729] Subtest bench: SUCCESS (1.325s)
[238.810954] [075/132] (798s left) kms_plane (planar-pixel-format-settings)
[239.294055] Starting subtest: planar-pixel-format-settings
[239.298255] Subtest planar-pixel-format-settings: SKIP (0.000s)
[239.389306] [076/132] (798s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[239.873013] Starting subtest: 2x-flip-vs-cursor-legacy
[240.307874] Subtest 2x-flip-vs-cursor-legacy: SUCCESS (0.435s)
[240.581994] [077/132] (797s left) kms_content_protection (lic-type-0-hdcp14)
[241.080234] Starting subtest: lic-type-0-hdcp14
[241.083536] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[241.180978] [078/132] (796s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[241.661659] Starting subtest: cursorA-vs-flipA-toggle
[252.601467] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.941s)
[252.862972] [079/132] (785s left) gem_eio (in-flight-contexts-immediate)
[252.935189] Starting subtest: in-flight-contexts-immediate
[258.073100] Subtest in-flight-contexts-immediate: SUCCESS (5.138s)
[258.588759] [080/132] (779s left) gem_exec_balancer (invalid-balancer)
[258.659271] Subtest invalid-balancer: SKIP (0.000s)
[258.759236] [081/132] (779s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[258.820801] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[258.885722] [082/132] (779s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[259.373307] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[259.377243] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[259.496560] [083/132] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[259.990776] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[259.995111] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[260.099449] [084/132] (778s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[260.162743] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[260.225832] [085/132] (777s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[260.712882] Starting subtest: extended-modeset-hang-oldfb-with-reset
[260.714678] Starting dynamic subtest: pipe-A
[271.158386] Dynamic subtest pipe-A: SUCCESS (10.443s)
[271.171526] Starting dynamic subtest: pipe-B
[281.973770] Dynamic subtest pipe-B: SUCCESS (10.811s)
[281.975523] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.259s)
[282.252678] [086/132] (756s left) gem_userptr_blits (input-checking)
[282.329099] Starting subtest: input-checking
[282.330820] Subtest input-checking: SUCCESS (0.000s)
[282.467169] [087/132] (755s left) kms_frontbuffer_tracking (fbc-tiling-y)
[282.964689] Starting subtest: fbc-tiling-y
[282.968777] Subtest fbc-tiling-y: SKIP (0.000s)
[283.065762] [088/132] (755s left) gem_exec_reloc (basic-cpu-gtt)
[283.133250] Starting subtest: basic-cpu-gtt
[283.136906] Subtest basic-cpu-gtt: SUCCESS (0.004s)
[283.647608] [089/132] (754s left) kms_flip (2x-flip-vs-fences-interruptible)
[284.137021] Starting subtest: 2x-flip-vs-fences-interruptible
[284.138831] Starting dynamic subtest: AB-VGA1-HDMI-A1
[314.529237] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.390s)
[314.533801] Subtest 2x-flip-vs-fences-interruptible: SUCCESS (30.394s)
[314.809155] [090/132] (723s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[315.291848] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[315.361478] [091/132] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[315.852295] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[315.856114] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[315.964618] [092/132] (722s left) gem_close_race (multigpu-basic-threads)
[316.046085] Starting subtest: multigpu-basic-threads
[316.049610] Subtest multigpu-basic-threads: SKIP (0.000s)
[316.270687] [093/132] (722s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[316.756041] Starting subtest: cursor-rapid-movement-64x21
[316.810552] Subtest cursor-rapid-movement-64x21: SKIP (0.052s)
[316.921643] [094/132] (721s left) gem_pwrite_snooped
[317.137989] [095/132] (721s left) kms_sequence (get-busy)
[317.624871] Starting subtest: get-busy
[317.626571] Starting dynamic subtest: pipe-A-VGA-1
[320.149976] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.525s)
[320.163807] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.602523] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.451s)
[322.618627] Starting dynamic subtest: pipe-B-VGA-1
[324.968513] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.362s)
[324.981983] Starting dynamic subtest: pipe-B-HDMI-A-1
[327.410341] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.440s)
[327.411973] Subtest get-busy: SUCCESS (9.788s)
[327.677628] [096/132] (711s left) kms_lease (atomic-implicit-crtc)
[328.165712] Starting subtest: atomic-implicit-crtc
[328.167598] Starting dynamic subtest: pipe-A-VGA-1
[328.175783] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.001s)
[328.189356] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.197682] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.022s)
[328.211421] Starting dynamic subtest: pipe-B-VGA-1
[328.219708] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.017s)
[328.233294] Starting dynamic subtest: pipe-B-HDMI-A-1
[328.243355] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[328.245479] Subtest atomic-implicit-crtc: SUCCESS (0.052s)
[328.308684] [097/132] (710s left) kms_flip (flip-vs-dpms-on-nop)
[328.789997] Starting subtest: flip-vs-dpms-on-nop
[328.791811] Starting dynamic subtest: A-VGA1
[329.850937] Dynamic subtest A-VGA1: SUCCESS (1.059s)
[329.866924] Starting dynamic subtest: B-VGA1
[330.836696] Dynamic subtest B-VGA1: SUCCESS (0.982s)
[330.853213] Starting dynamic subtest: A-HDMI-A1
[331.890651] Dynamic subtest A-HDMI-A1: SUCCESS (1.050s)
[331.910329] Starting dynamic subtest: B-HDMI-A1
[332.956500] Dynamic subtest B-HDMI-A1: SUCCESS (1.063s)
[332.958713] Subtest flip-vs-dpms-on-nop: SUCCESS (4.169s)
[333.140491] [098/132] (705s left) kms_psr (psr-sprite-blt)
[333.623938] Subtest psr-sprite-blt: SKIP (0.000s)
[333.690119] [099/132] (705s left) api_intel_allocator (default-alignment)
[333.753897] Starting subtest: default-alignment
[333.757886] Subtest default-alignment: SUCCESS (0.004s)
[333.878322] [100/132] (705s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[334.359036] Starting subtest: compare-crc-sanitycheck-nv12
[334.360752] Starting dynamic subtest: pipe-A-VGA-1
[334.364264] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[334.380615] Starting dynamic subtest: pipe-B-HDMI-A-1
[334.384995] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[334.389356] Subtest compare-crc-sanitycheck-nv12: SKIP (0.006s)
[334.462534] [101/132] (704s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[334.941885] Starting subtest: cursor-vs-flip-legacy
[365.910080] Subtest cursor-vs-flip-legacy: SUCCESS (30.969s)
[366.171962] [102/132] (672s left) kms_big_fb (linear-16bpp-rotate-90)
[366.662092] Starting subtest: linear-16bpp-rotate-90
[366.750549] Subtest linear-16bpp-rotate-90: SKIP (0.087s)
[366.970043] [103/132] (672s left) kms_atomic (plane-cursor-legacy)
[367.448627] Starting subtest: plane-cursor-legacy
[367.450288] Starting dynamic subtest: pipe-A-VGA-1
[367.655606] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.207s)
[367.657328] Subtest plane-cursor-legacy: SUCCESS (0.210s)
[367.916260] [104/132] (671s left) gem_bad_reloc (negative-reloc)
[367.983973] Starting subtest: negative-reloc
[367.987849] Subtest negative-reloc: SKIP (0.000s)
[368.109207] [105/132] (671s left) syncobj_eventfd (binary-wait-signaled)
[368.175231] Starting subtest: binary-wait-signaled
[368.177017] Subtest binary-wait-signaled: SUCCESS (0.000s)
[368.282630] [106/132] (671s left) api_intel_bb (full-batch)
[368.346672] Starting subtest: full-batch
[368.348576] Subtest full-batch: SUCCESS (0.002s)
[368.466214] [107/132] (670s left) gem_mmap_offset (bad-flags)
[368.533704] Starting subtest: bad-flags
[368.535336] Subtest bad-flags: SUCCESS (0.000s)
[368.648118] [108/132] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[369.138440] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[369.142185] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[369.249420] [109/132] (670s left) kms_chamelium_audio (hdmi-audio-edid)
[369.852848] Subtest hdmi-audio-edid: SKIP (0.000s)
[370.061720] [110/132] (669s left) gem_exec_whisper (basic-contexts-priority)
[370.137492] Starting subtest: basic-contexts-priority
[370.141100] Subtest basic-contexts-priority: SKIP (0.001s)
[370.346225] [111/132] (669s left) gem_exec_flush (basic-wb-rw-default)
[370.419938] Starting subtest: basic-wb-rw-default
[375.870436] Subtest basic-wb-rw-default: SUCCESS (5.451s)
[376.074773] [112/132] (663s left) kms_flip (basic-plain-flip)
[376.551130] Starting subtest: basic-plain-flip
[376.553283] Starting dynamic subtest: A-VGA1
[377.333057] Dynamic subtest A-VGA1: SUCCESS (0.782s)
[377.349692] Starting dynamic subtest: B-VGA1
[378.036172] Dynamic subtest B-VGA1: SUCCESS (0.700s)
[378.052589] Starting dynamic subtest: A-HDMI-A1
[378.810244] Dynamic subtest A-HDMI-A1: SUCCESS (0.772s)
[378.828131] Starting dynamic subtest: B-HDMI-A1
[379.594129] Dynamic subtest B-HDMI-A1: SUCCESS (0.781s)
[379.596377] Subtest basic-plain-flip: SUCCESS (3.048s)
[379.797775] [113/132] (659s left) syncobj_timeline (reset-signaled)
[379.862830] Starting subtest: reset-signaled
[379.864634] Subtest reset-signaled: SUCCESS (0.000s)
[379.963711] [114/132] (659s left) i915_pm_rps (reset)
[380.028498] Starting subtest: reset
[384.572153] Subtest reset: SUCCESS (4.536s)
[384.693582] [115/132] (655s left) gem_wait (await)
[384.773590] Starting subtest: await
[384.775306] Starting dynamic subtest: all-engines
[385.807550] Dynamic subtest all-engines: SUCCESS (1.033s)
[385.824997] Starting dynamic subtest: rcs0
[386.835342] Dynamic subtest rcs0: SUCCESS (1.025s)
[386.852876] Starting dynamic subtest: bcs0
[387.863270] Dynamic subtest bcs0: SUCCESS (1.025s)
[387.880113] Starting dynamic subtest: vcs0
[388.889267] Dynamic subtest vcs0: SUCCESS (1.023s)
[388.896236] Subtest await: SUCCESS (4.117s)
[389.124945] [116/132] (650s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[389.195425] Starting subtest: etime-single-wait-all-for-submit-submitted
[389.299734] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[389.394133] [117/132] (650s left) gem_exec_schedule (submit-golden-slice)
[389.476843] Subtest submit-golden-slice: SKIP (0.000s)
[389.675838] [118/132] (650s left) gem_userptr_blits (readonly-unsync)
[389.745948] Subtest readonly-unsync: SKIP (0.000s)
[389.877157] [119/132] (650s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[389.942073] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[389.943874] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[390.047703] [120/132] (650s left) gem_fence_thrash (bo-copy)
[390.109088] Starting subtest: bo-copy
[391.214823] Subtest bo-copy: SUCCESS (1.105s)
[391.330910] [121/132] (648s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[391.821363] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[393.221170] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.401s)
[393.462400] [122/132] (646s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[393.948152] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[393.952190] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[394.056022] [123/132] (646s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[394.535029] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[394.537130] Starting dynamic subtest: pipe-A
[394.543759] Dynamic subtest pipe-A: SKIP (0.002s)
[394.559848] Starting dynamic subtest: pipe-B
[394.568072] Dynamic subtest pipe-B: SKIP (0.001s)
[394.572117] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.008s)
[394.640430] [124/132] (645s left) prime_mmap (test_correct_cpu_write)
[394.701830] Starting subtest: test_correct_cpu_write
[394.703673] Starting dynamic subtest: test_correct_cpu_write-smem
[394.705520] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[394.707593] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[394.825906] [125/132] (645s left) gem_mmap_gtt (cpuset-big-copy-odd)
[394.887491] Starting subtest: cpuset-big-copy-odd
[398.281904] Subtest cpuset-big-copy-odd: SUCCESS (3.395s)
[398.504939] [126/132] (641s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[398.640324] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.000s)
[398.701915] [127/132] (641s left) gem_ctx_persistence (hostile)
[398.766092] Subtest hostile: SKIP (0.000s)
[398.829196] [128/132] (641s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[398.897454] Starting subtest: y-tiled-to-vebox-y-tiled
[398.901311] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[399.101047] [129/132] (641s left) kms_vblank (wait-idle)
[399.592855] Starting subtest: wait-idle
[399.595149] Starting dynamic subtest: pipe-A-VGA-1
[401.884979] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.292s)
[401.898989] Starting dynamic subtest: pipe-A-HDMI-A-1
[404.143313] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.256s)
[404.158196] Starting dynamic subtest: pipe-B-VGA-1
[406.308794] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.164s)
[406.323740] Starting dynamic subtest: pipe-B-HDMI-A-1
[408.567531] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.256s)
[408.569219] Subtest wait-idle: SUCCESS (8.978s)
[408.825542] [130/132] (631s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[409.157656] Starting subtest: syncobj-timeline-multiple-ext-nodes
[409.159902] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.001s)
[409.408943] [131/132] (631s left) kms_cursor_legacy (forked-bo)
[409.886824] Starting subtest: forked-bo
[409.888593] Starting dynamic subtest: pipe-A
[415.328152] Dynamic subtest pipe-A: SUCCESS (5.439s)
[415.341834] Starting dynamic subtest: pipe-B
[420.820014] Dynamic subtest pipe-B: SUCCESS (5.489s)
[420.835850] Starting dynamic subtest: all-pipes
[426.318068] Dynamic subtest all-pipes: SUCCESS (5.495s)
[426.319886] Subtest forked-bo: SUCCESS (16.432s)
[426.411826] [132/132] (614s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[426.490281] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[426.492586] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[426.588810] Closing watchdogs
results: parsing output: 0/ for test: kms_feature_discovery
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: gem_shrink
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_pm_dc
results: parsing output: 5/ for test: gem_exec_capture
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_spin_batch
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_color
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_draw_crc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: core_setmaster
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: prime_busy
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: syncobj_basic
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: prime_mmap
results: parsing output: 41/ for test: prime_mmap
results: parsing output: 42/ for test: gem_exec_gttfill
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_plane_multiple
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: gem_ctx_shared
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: kms_chamelium_edid
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: i915_query
results: parsing output: 60/ for test: kms_atomic_interruptible
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: template
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_unref_active_buffers
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: i915_pm_freq_api
results: parsing output: 69/ for test: gen9_exec_parse
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: gem_pread
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_eio
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: kms_pipe_b_c_ivb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_busy
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_close_race
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_sequence
results: parsing output: 95/ for test: kms_lease
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_atomic
results: parsing output: 103/ for test: gem_bad_reloc
results: parsing output: 104/ for test: syncobj_eventfd
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap_offset
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_chamelium_audio
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: gem_exec_flush
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: i915_pm_rps
results: parsing output: 114/ for test: gem_wait
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: gem_fence_thrash
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: syncobj_timeline
Done.