[74.602864] Initializing watchdogs
[74.603147]   /dev/watchdog0
[74.660748] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5a85 Intel Broxton (Gen9) HD Graphics 500
[74.693107] [001/161] (960s left) i915_module_load (load)
[75.361361] Starting subtest: load
[79.570798] Subtest load: SUCCESS (4.194s)
[79.714255] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[79.721764] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[79.752354] [002/161] (955s left) core_auth (basic-auth)
[80.066406] Starting subtest: basic-auth
[80.087982] Subtest basic-auth: SUCCESS (0.002s)
[80.237962] [003/161] (955s left) debugfs_test (read_all_entries)
[80.468299] Starting subtest: read_all_entries
[80.621670] Subtest read_all_entries: SUCCESS (0.154s)
[80.929629] [004/161] (954s left) debugfs_test (basic-hwmon)
[81.195953] Starting subtest: basic-hwmon
[81.240348] Subtest basic-hwmon: SKIP (0.000s)
[81.462465] [005/161] (954s left) debugfs_test (sysfs)
[81.731395] Starting subtest: sysfs
[81.872925] Subtest sysfs: SUCCESS (0.172s)
[82.158514] [006/161] (953s left) fbdev (eof)
[82.405708] Starting subtest: eof
[82.428274] Subtest eof: SUCCESS (0.003s)
[82.582403] [007/161] (953s left) fbdev (info)
[82.829736] Starting subtest: info
[82.851589] Subtest info: SUCCESS (0.000s)
[83.004855] [008/161] (953s left) fbdev (nullptr)
[83.206310] Starting subtest: nullptr
[83.229637] Subtest nullptr: SUCCESS (0.000s)
[83.385078] [009/161] (953s left) fbdev (read)
[83.628079] Starting subtest: read
[85.094689] Subtest read: SUCCESS (1.498s)
[85.258661] [010/161] (951s left) fbdev (write)
[85.501664] Starting subtest: write
[86.260058] Subtest write: SUCCESS (0.777s)
[86.423762] [011/161] (950s left) gem_basic (bad-close)
[86.686958] Starting subtest: bad-close
[86.731556] Subtest bad-close: SUCCESS (0.000s)
[86.883493] [012/161] (950s left) gem_basic (create-close)
[87.149368] Starting subtest: create-close
[87.197503] Subtest create-close: SUCCESS (0.000s)
[87.351924] [013/161] (949s left) gem_basic (create-fd-close)
[87.614455] Starting subtest: create-fd-close
[87.664514] Subtest create-fd-close: SUCCESS (0.001s)
[87.817991] [014/161] (949s left) gem_busy (busy@all-engines)
[88.065331] Starting subtest: busy
[88.085488] Starting dynamic subtest: all-engines
[88.184629] Dynamic subtest all-engines: SUCCESS (0.110s)
[88.210066] Subtest busy: SUCCESS (0.111s)
[88.678744] [015/161] (948s left) gem_close_race (basic-process)
[88.979571] Starting subtest: basic-process
[89.065368] Subtest basic-process: SUCCESS (0.111s)
[89.354787] [016/161] (948s left) gem_close_race (basic-threads)
[89.609065] Starting subtest: basic-threads
[90.827477] Subtest basic-threads: SUCCESS (1.226s)
[91.116312] [017/161] (946s left) gem_ctx_create (basic)
[91.381448] Starting subtest: basic
[91.401808] Subtest basic: SUCCESS (0.000s)
[91.660917] [018/161] (946s left) gem_ctx_create (basic-files)
[91.907069] Starting subtest: basic-files
[93.957037] Subtest basic-files: SUCCESS (2.044s)
[94.265068] [019/161] (943s left) gem_ctx_exec (basic)
[94.509663] Starting subtest: basic
[94.530488] Subtest basic: SUCCESS (0.012s)
[94.715615] [020/161] (943s left) gem_exec_basic (basic)
[94.967596] Starting subtest: basic
[94.990390] Starting dynamic subtest: rcs0-smem
[95.011344] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[95.054079] Starting dynamic subtest: bcs0-smem
[95.077613] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[95.125164] Starting dynamic subtest: vcs0-smem
[95.145464] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[95.202993] Starting dynamic subtest: vecs0-smem
[95.226659] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[95.249664] Subtest basic: SUCCESS (0.013s)
[95.405859] [021/161] (943s left) gem_exec_create (basic)
[95.642219] Starting subtest: basic
[95.662289] Starting dynamic subtest: smem
[97.735387] Dynamic subtest smem: SUCCESS (2.084s)
[97.759088] Subtest basic: SUCCESS (2.085s)
[98.018625] [022/161] (940s left) gem_exec_fence (basic-busy)
[98.407603] Starting subtest: basic-busy
[98.432144] Starting dynamic subtest: rcs0
[98.484933] Dynamic subtest rcs0: SUCCESS (0.042s)
[98.538800] Starting dynamic subtest: bcs0
[98.591651] Dynamic subtest bcs0: SUCCESS (0.036s)
[98.642903] Starting dynamic subtest: vcs0
[98.696670] Dynamic subtest vcs0: SUCCESS (0.035s)
[98.744051] Starting dynamic subtest: vecs0
[98.796996] Dynamic subtest vecs0: SUCCESS (0.033s)
[98.820703] Subtest basic-busy: SUCCESS (0.149s)
[99.445731] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[99.469622] [023/161] (939s left) gem_exec_fence (basic-wait)
[99.884034] Starting subtest: basic-wait
[99.905352] Starting dynamic subtest: rcs0
[99.925962] Dynamic subtest rcs0: SUCCESS (0.035s)
[99.971871] Starting dynamic subtest: bcs0
[99.995070] Dynamic subtest bcs0: SUCCESS (0.031s)
[100.056962] Starting dynamic subtest: vcs0
[100.078248] Dynamic subtest vcs0: SUCCESS (0.042s)
[100.125968] Starting dynamic subtest: vecs0
[100.148354] Dynamic subtest vecs0: SUCCESS (0.030s)
[100.169503] Subtest basic-wait: SUCCESS (0.141s)
[100.822618] [024/161] (938s left) gem_exec_fence (basic-await)
[101.215673] Starting subtest: basic-await
[101.236201] Starting dynamic subtest: rcs0
[101.389093] Dynamic subtest rcs0: SUCCESS (0.174s)
[101.435148] Starting dynamic subtest: bcs0
[101.553050] Dynamic subtest bcs0: SUCCESS (0.165s)
[101.600274] Starting dynamic subtest: vcs0
[101.717354] Dynamic subtest vcs0: SUCCESS (0.163s)
[101.760810] Starting dynamic subtest: vecs0
[101.887284] Dynamic subtest vecs0: SUCCESS (0.165s)
[101.908131] Subtest basic-await: SUCCESS (0.672s)
[102.717510] [025/161] (936s left) gem_exec_fence (nb-await)
[103.104900] Starting subtest: nb-await
[103.125251] Starting dynamic subtest: rcs0
[103.189068] Dynamic subtest rcs0: SUCCESS (0.084s)
[103.242534] Starting dynamic subtest: bcs0
[103.263311] Dynamic subtest bcs0: SUCCESS (0.074s)
[103.310879] Starting dynamic subtest: vcs0
[103.360270] Dynamic subtest vcs0: SUCCESS (0.072s)
[103.419120] Starting dynamic subtest: vecs0
[103.440097] Dynamic subtest vecs0: SUCCESS (0.071s)
[103.463510] Subtest nb-await: SUCCESS (0.305s)
[104.216222] [026/161] (935s left) gem_exec_gttfill (basic)
[104.481604] Starting subtest: basic
[134.855348] Subtest basic: SUCCESS (30.400s)
[135.185448] [027/161] (904s left) gem_exec_parallel (engines)
[135.591725] Starting subtest: engines
[135.612445] Starting dynamic subtest: basic
[141.044062] Dynamic subtest basic: SUCCESS (5.219s)
[141.090314] Starting dynamic subtest: contexts
[146.425918] Dynamic subtest contexts: SUCCESS (5.469s)
[146.470143] Starting dynamic subtest: fds
[152.105702] Dynamic subtest fds: SUCCESS (5.669s)
[152.150115] Starting dynamic subtest: userptr
[156.276058] Dynamic subtest userptr: SUCCESS (4.167s)
[156.298763] Subtest engines: SUCCESS (20.527s)
[156.479112] [028/161] (883s left) gem_exec_store (basic)
[156.800324] Starting subtest: basic
[156.821769] Subtest basic: SUCCESS (0.085s)
[157.104777] [029/161] (882s left) gem_flink_basic (bad-flink)
[157.357246] Starting subtest: bad-flink
[157.378083] Subtest bad-flink: SUCCESS (0.000s)
[157.549127] [030/161] (882s left) gem_flink_basic (bad-open)
[157.788404] Starting subtest: bad-open
[157.810777] Subtest bad-open: SUCCESS (0.000s)
[157.975807] [031/161] (882s left) gem_flink_basic (basic)
[158.212398] Starting subtest: basic
[158.233381] Subtest basic: SUCCESS (0.000s)
[158.407593] [032/161] (881s left) gem_flink_basic (double-flink)
[158.670047] Starting subtest: double-flink
[158.695845] Subtest double-flink: SUCCESS (0.000s)
[158.890381] [033/161] (881s left) gem_flink_basic (flink-lifetime)
[159.173232] Starting subtest: flink-lifetime
[159.200597] Subtest flink-lifetime: SUCCESS (0.004s)
[159.396399] [034/161] (881s left) gem_huc_copy (huc-copy)
[159.690902] Starting subtest: huc-copy
[159.733926] Subtest huc-copy: SKIP (0.000s)
[159.904452] [035/161] (880s left) gem_linear_blits (basic)
[160.338861] Starting subtest: basic
[160.360422] Subtest basic: SUCCESS (0.029s)
[160.638150] [036/161] (880s left) gem_mmap (basic)
[161.046468] Starting subtest: basic
[161.154623] Subtest basic: SUCCESS (0.001s)
[161.329999] [037/161] (879s left) gem_mmap_gtt (basic)
[161.581950] Starting subtest: basic
[161.604699] Subtest basic: SUCCESS (0.002s)
[161.799730] [038/161] (879s left) gem_render_linear_blits (basic)
[162.038431] Starting subtest: basic
[162.146034] Subtest basic: SUCCESS (0.097s)
[162.314487] [039/161] (879s left) gem_render_tiled_blits (basic)
[162.587513] Starting subtest: basic
[162.714387] Subtest basic: SUCCESS (0.132s)
[162.890590] [040/161] (878s left) gem_ringfill (basic-all)
[163.470873] Starting subtest: basic-all
[164.678288] Subtest basic-all: SUCCESS (1.234s)
[164.901378] [041/161] (877s left) gem_softpin (allocator-basic)
[165.156845] Starting subtest: allocator-basic
[165.420838] Subtest allocator-basic: SUCCESS (0.285s)
[165.652246] [042/161] (876s left) gem_softpin (allocator-basic-reserve)
[165.893895] Starting subtest: allocator-basic-reserve
[166.184541] Subtest allocator-basic-reserve: SUCCESS (0.307s)
[166.402136] [043/161] (875s left) gem_softpin (safe-alignment)
[166.641350] Starting subtest: safe-alignment
[166.663185] Subtest safe-alignment: SUCCESS (0.038s)
[166.884312] [044/161] (875s left) gem_sync (basic-all)
[167.328327] Starting subtest: basic-all
[169.629259] Subtest basic-all: SUCCESS (2.323s)
[169.801116] [045/161] (872s left) gem_sync (basic-each)
[170.265179] Starting subtest: basic-each
[172.409941] Subtest basic-each: SUCCESS (2.351s)
[172.704068] [046/161] (870s left) gem_tiled_blits (basic)
[173.045220] Starting subtest: basic
[173.100611] Subtest basic: SUCCESS (0.053s)
[173.407324] [047/161] (869s left) gem_tiled_fence_blits (basic)
[173.936653] Starting subtest: basic
[173.979627] Subtest basic: SUCCESS (0.044s)
[174.269616] [048/161] (868s left) gem_tiled_pread_basic
[175.113799] [049/161] (868s left) gem_wait (busy@all-engines)
[175.425319] Starting subtest: busy
[175.451928] Starting dynamic subtest: all-engines
[176.024675] Dynamic subtest all-engines: SUCCESS (0.531s)
[176.050622] Subtest busy: SUCCESS (0.531s)
[176.306774] [050/161] (867s left) gem_wait (wait@all-engines)
[176.585417] Starting subtest: wait
[176.608955] Starting dynamic subtest: all-engines
[177.630783] Dynamic subtest all-engines: SUCCESS (1.046s)
[177.654392] Subtest wait: SUCCESS (1.046s)
[177.980615] [051/161] (865s left) i915_getparams_basic (basic-eu-total)
[178.235955] Starting subtest: basic-eu-total
[178.277609] Subtest basic-eu-total: SUCCESS (0.000s)
[178.452989] [052/161] (865s left) i915_getparams_basic (basic-subslice-total)
[178.701767] Starting subtest: basic-subslice-total
[178.746636] Subtest basic-subslice-total: SUCCESS (0.000s)
[178.917828] [053/161] (865s left) i915_hangman (error-state-basic)
[179.170505] Starting subtest: error-state-basic
[179.193449] Subtest error-state-basic: SUCCESS (0.023s)
[179.397600] [054/161] (864s left) i915_pciid
[179.863944] [055/161] (864s left) kms_addfb_basic (addfb25-4-tiled)
[180.278672] Starting subtest: addfb25-4-tiled
[180.299590] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[180.472809] [056/161] (864s left) kms_addfb_basic (addfb25-bad-modifier)
[180.833058] Starting subtest: addfb25-bad-modifier
[180.854918] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[181.046077] [057/161] (863s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[181.404081] Starting subtest: addfb25-framebuffer-vs-set-tiling
[181.427117] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[181.599427] [058/161] (863s left) kms_addfb_basic (addfb25-modifier-no-flag)
[181.939214] Starting subtest: addfb25-modifier-no-flag
[181.962459] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[182.140784] [059/161] (862s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[182.503808] Starting subtest: addfb25-x-tiled-legacy
[182.524563] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[182.700218] [060/161] (862s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[183.065671] Starting subtest: addfb25-x-tiled-mismatch-legacy
[183.086877] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[183.264964] [061/161] (862s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[183.625811] Starting subtest: addfb25-yf-tiled-legacy
[183.648827] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[183.817760] [062/161] (861s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[184.169603] Starting subtest: addfb25-y-tiled-legacy
[184.192326] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[184.364708] [063/161] (861s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[184.713047] Starting subtest: addfb25-y-tiled-small-legacy
[184.742545] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[184.910552] [064/161] (861s left) kms_addfb_basic (bad-pitch-0)
[185.175390] Starting subtest: bad-pitch-0
[185.195542] Subtest bad-pitch-0: SUCCESS (0.000s)
[185.470985] [065/161] (860s left) kms_addfb_basic (bad-pitch-1024)
[185.736183] Starting subtest: bad-pitch-1024
[185.756565] Subtest bad-pitch-1024: SUCCESS (0.000s)
[186.020773] [066/161] (860s left) kms_addfb_basic (bad-pitch-128)
[186.306047] Starting subtest: bad-pitch-128
[186.336161] Subtest bad-pitch-128: SUCCESS (0.000s)
[186.579464] [067/161] (859s left) kms_addfb_basic (bad-pitch-256)
[186.876604] Starting subtest: bad-pitch-256
[186.901568] Subtest bad-pitch-256: SUCCESS (0.000s)
[187.148856] [068/161] (859s left) kms_addfb_basic (bad-pitch-32)
[187.394684] Starting subtest: bad-pitch-32
[187.416258] Subtest bad-pitch-32: SUCCESS (0.000s)
[187.688391] [069/161] (859s left) kms_addfb_basic (bad-pitch-63)
[187.957058] Starting subtest: bad-pitch-63
[187.977304] Subtest bad-pitch-63: SUCCESS (0.000s)
[188.241332] [070/161] (858s left) kms_addfb_basic (bad-pitch-65536)
[188.512637] Starting subtest: bad-pitch-65536
[188.532635] Subtest bad-pitch-65536: SUCCESS (0.001s)
[188.804360] [071/161] (858s left) kms_addfb_basic (bad-pitch-999)
[189.071101] Starting subtest: bad-pitch-999
[189.091339] Subtest bad-pitch-999: SUCCESS (0.000s)
[189.358874] [072/161] (857s left) kms_addfb_basic (basic)
[189.631504] Starting subtest: basic
[189.652430] Subtest basic: SUCCESS (0.000s)
[189.922498] [073/161] (857s left) kms_addfb_basic (basic-x-tiled-legacy)
[190.167312] Starting subtest: basic-x-tiled-legacy
[190.190290] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[190.474894] [074/161] (857s left) kms_addfb_basic (basic-y-tiled-legacy)
[190.738687] Starting subtest: basic-y-tiled-legacy
[190.760284] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[191.023350] [075/161] (856s left) kms_addfb_basic (bo-too-small)
[191.388359] Starting subtest: bo-too-small
[191.410835] Subtest bo-too-small: SUCCESS (0.001s)
[191.581528] [076/161] (856s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[191.940923] Starting subtest: bo-too-small-due-to-tiling
[191.962130] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[192.143502] [077/161] (855s left) kms_addfb_basic (clobberred-modifier)
[192.413326] Starting subtest: clobberred-modifier
[192.434253] Subtest clobberred-modifier: SUCCESS (0.000s)
[192.687208] [078/161] (855s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[192.955504] Starting subtest: framebuffer-vs-set-tiling
[192.976878] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[193.251628] [079/161] (855s left) kms_addfb_basic (invalid-get-prop)
[193.518209] Starting subtest: invalid-get-prop
[193.539571] Subtest invalid-get-prop: SUCCESS (0.000s)
[193.808409] [080/161] (854s left) kms_addfb_basic (invalid-get-prop-any)
[194.072237] Starting subtest: invalid-get-prop-any
[194.093234] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[194.366219] [081/161] (854s left) kms_addfb_basic (invalid-set-prop)
[194.631532] Starting subtest: invalid-set-prop
[194.653301] Subtest invalid-set-prop: SUCCESS (0.000s)
[194.924591] [082/161] (854s left) kms_addfb_basic (invalid-set-prop-any)
[195.190894] Starting subtest: invalid-set-prop-any
[195.211920] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[195.504649] [083/161] (853s left) kms_addfb_basic (no-handle)
[195.797639] Starting subtest: no-handle
[195.822653] Subtest no-handle: SUCCESS (0.000s)
[196.096631] [084/161] (853s left) kms_addfb_basic (size-max)
[196.450045] Starting subtest: size-max
[196.478081] Subtest size-max: SUCCESS (0.000s)
[196.647816] [085/161] (852s left) kms_addfb_basic (small-bo)
[196.981391] Starting subtest: small-bo
[197.002285] Subtest small-bo: SUCCESS (0.000s)
[197.201989] [086/161] (852s left) kms_addfb_basic (tile-pitch-mismatch)
[197.461218] Starting subtest: tile-pitch-mismatch
[197.483867] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[197.745937] [087/161] (852s left) kms_addfb_basic (too-high)
[198.109604] Starting subtest: too-high
[198.130466] Subtest too-high: SUCCESS (0.002s)
[198.302820] [088/161] (851s left) kms_addfb_basic (too-wide)
[198.661059] Starting subtest: too-wide
[198.682251] Subtest too-wide: SUCCESS (0.000s)
[198.864333] [089/161] (851s left) kms_addfb_basic (unused-handle)
[199.133094] Starting subtest: unused-handle
[199.153383] Subtest unused-handle: SUCCESS (0.000s)
[199.420868] [090/161] (850s left) kms_addfb_basic (unused-modifier)
[199.675390] Starting subtest: unused-modifier
[199.696205] Subtest unused-modifier: SUCCESS (0.000s)
[199.979093] [091/161] (850s left) kms_addfb_basic (unused-offsets)
[200.226841] Starting subtest: unused-offsets
[200.249171] Subtest unused-offsets: SUCCESS (0.000s)
[200.519645] [092/161] (850s left) kms_addfb_basic (unused-pitches)
[200.763303] Starting subtest: unused-pitches
[200.784547] Subtest unused-pitches: SUCCESS (0.000s)
[201.076314] [093/161] (849s left) kms_busy (basic)
[201.447105] Starting subtest: basic
[201.469052] Starting dynamic subtest: flip
[202.267584] Dynamic subtest flip: SUCCESS (0.816s)
[202.355138] Starting dynamic subtest: modeset
[203.718238] Dynamic subtest modeset: SUCCESS (1.459s)
[203.740944] Subtest basic: SUCCESS (2.280s)
[204.211820] [094/161] (846s left) kms_prop_blob (basic)
[204.488215] Starting subtest: basic
[204.511615] Subtest basic: SUCCESS (0.000s)
[204.684448] [095/161] (846s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[205.032724] Starting subtest: basic-busy-flip-before-cursor-atomic
[205.075423] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[205.249695] [096/161] (846s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[205.573781] Starting subtest: basic-busy-flip-before-cursor-legacy
[205.618635] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[205.794156] [097/161] (845s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[206.154337] Starting subtest: basic-flip-after-cursor-atomic
[207.154104] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.999s)
[207.600384] [098/161] (844s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[207.964339] Starting subtest: basic-flip-after-cursor-legacy
[208.924835] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.987s)
[209.381556] [099/161] (842s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[209.720109] Starting subtest: basic-flip-after-cursor-varying-size
[210.713858] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.994s)
[211.161549] [100/161] (840s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[211.499675] Starting subtest: basic-flip-before-cursor-atomic
[212.502260] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.000s)
[212.954849] [101/161] (839s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[213.273469] Starting subtest: basic-flip-before-cursor-legacy
[214.293186] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.996s)
[214.713651] [102/161] (837s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[215.056102] Starting subtest: basic-flip-before-cursor-varying-size
[216.057449] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.980s)
[216.478996] [103/161] (836s left) kms_dsc (dsc-basic)
[216.875628] Subtest dsc-basic: SKIP (0.000s)
[217.045126] [104/161] (835s left) kms_flip (basic-flip-vs-dpms)
[217.424102] Starting subtest: basic-flip-vs-dpms
[217.444115] Starting dynamic subtest: A-DP1
[218.659713] Dynamic subtest A-DP1: SUCCESS (1.244s)
[218.709367] Starting dynamic subtest: B-DP1
[219.811892] Dynamic subtest B-DP1: SUCCESS (1.151s)
[219.860619] Starting dynamic subtest: C-DP1
[220.956900] Dynamic subtest C-DP1: SUCCESS (1.147s)
[221.000143] Subtest basic-flip-vs-dpms: SUCCESS (3.552s)
[221.449976] [105/161] (831s left) kms_flip (basic-flip-vs-modeset)
[221.814129] Starting subtest: basic-flip-vs-modeset
[221.834536] Starting dynamic subtest: A-DP1
[223.074201] Dynamic subtest A-DP1: SUCCESS (1.265s)
[223.123623] Starting dynamic subtest: B-DP1
[224.226672] Dynamic subtest B-DP1: SUCCESS (1.159s)
[224.274864] Starting dynamic subtest: C-DP1
[225.383362] Dynamic subtest C-DP1: SUCCESS (1.150s)
[225.407369] Subtest basic-flip-vs-modeset: SUCCESS (3.587s)
[225.848639] [106/161] (827s left) kms_flip (basic-flip-vs-wf_vblank)
[226.217320] Starting subtest: basic-flip-vs-wf_vblank
[226.239982] Starting dynamic subtest: A-DP1
[227.662520] Dynamic subtest A-DP1: SUCCESS (1.452s)
[227.709661] Starting dynamic subtest: B-DP1
[229.081820] Dynamic subtest B-DP1: SUCCESS (1.418s)
[229.131988] Starting dynamic subtest: C-DP1
[230.505820] Dynamic subtest C-DP1: SUCCESS (1.421s)
[230.528808] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.302s)
[231.059461] [107/161] (822s left) kms_flip (basic-plain-flip)
[231.419102] Starting subtest: basic-plain-flip
[231.441214] Starting dynamic subtest: A-DP1
[232.566158] Dynamic subtest A-DP1: SUCCESS (1.154s)
[232.614742] Starting dynamic subtest: B-DP1
[233.703348] Dynamic subtest B-DP1: SUCCESS (1.135s)
[233.754066] Starting dynamic subtest: C-DP1
[234.846111] Dynamic subtest C-DP1: SUCCESS (1.136s)
[234.870164] Subtest basic-plain-flip: SUCCESS (3.437s)
[235.381549] [108/161] (818s left) kms_force_connector_basic (force-connector-state)
[235.683384] Subtest force-connector-state: SKIP (0.000s)
[235.864173] [109/161] (817s left) kms_force_connector_basic (force-edid)
[236.140542] Subtest force-edid: SKIP (0.000s)
[236.321503] [110/161] (817s left) kms_force_connector_basic (force-load-detect)
[236.610381] Subtest force-load-detect: SKIP (0.000s)
[236.786253] [111/161] (817s left) kms_force_connector_basic (prune-stale-modes)
[237.065606] Subtest prune-stale-modes: SKIP (0.000s)
[237.237511] [112/161] (816s left) kms_frontbuffer_tracking (basic)
[237.673833] Starting subtest: basic
[241.421087] Subtest basic: SUCCESS (3.817s)
[241.643300] [113/161] (812s left) kms_hdmi_inject (inject-audio)
[241.916239] Subtest inject-audio: SKIP (0.000s)
[242.093634] [114/161] (812s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[242.430588] Starting subtest: compare-crc-sanitycheck-xr24
[242.452178] Starting dynamic subtest: pipe-A-DP-1
[242.910275] Dynamic subtest pipe-A-DP-1: SUCCESS (0.475s)
[242.958641] Starting dynamic subtest: pipe-B-DP-1
[243.545315] Dynamic subtest pipe-B-DP-1: SUCCESS (0.627s)
[243.596935] Starting dynamic subtest: pipe-C-DP-1
[244.183287] Dynamic subtest pipe-C-DP-1: SUCCESS (0.637s)
[244.207243] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.754s)
[244.643235] [115/161] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[244.981381] Starting subtest: compare-crc-sanitycheck-nv12
[245.003821] Starting dynamic subtest: pipe-A-DP-1
[245.047778] Dynamic subtest pipe-A-DP-1: SKIP (0.001s)
[245.114857] Starting dynamic subtest: pipe-B-DP-1
[245.157818] Dynamic subtest pipe-B-DP-1: SKIP (0.001s)
[245.228946] Starting dynamic subtest: pipe-C-DP-1
[245.274986] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[245.318424] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s)
[245.520397] [116/161] (809s left) kms_pipe_crc_basic (hang-read-crc)
[245.881107] Starting subtest: hang-read-crc
[245.901942] Starting dynamic subtest: pipe-A-DP-1
[247.194151] Dynamic subtest pipe-A-DP-1: SUCCESS (1.317s)
[247.258940] Starting dynamic subtest: pipe-B-DP-1
[248.677176] Dynamic subtest pipe-B-DP-1: SUCCESS (1.473s)
[248.746338] Starting dynamic subtest: pipe-C-DP-1
[250.145234] Dynamic subtest pipe-C-DP-1: SUCCESS (1.464s)
[250.166043] Subtest hang-read-crc: SUCCESS (4.269s)
[250.569726] [117/161] (804s left) kms_pipe_crc_basic (nonblocking-crc)
[250.915106] Starting subtest: nonblocking-crc
[250.935489] Starting dynamic subtest: pipe-A-DP-1
[251.565777] Dynamic subtest pipe-A-DP-1: SUCCESS (0.628s)
[251.618826] Starting dynamic subtest: pipe-B-DP-1
[252.376929] Dynamic subtest pipe-B-DP-1: SUCCESS (0.808s)
[252.445379] Starting dynamic subtest: pipe-C-DP-1
[253.195703] Dynamic subtest pipe-C-DP-1: SUCCESS (0.813s)
[253.217806] Subtest nonblocking-crc: SUCCESS (2.265s)
[253.616774] [118/161] (801s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[253.962732] Starting subtest: nonblocking-crc-frame-sequence
[253.982669] Starting dynamic subtest: pipe-A-DP-1
[254.643998] Dynamic subtest pipe-A-DP-1: SUCCESS (0.662s)
[254.695515] Starting dynamic subtest: pipe-B-DP-1
[255.466513] Dynamic subtest pipe-B-DP-1: SUCCESS (0.816s)
[255.548146] Starting dynamic subtest: pipe-C-DP-1
[256.263958] Dynamic subtest pipe-C-DP-1: SUCCESS (0.797s)
[256.290185] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.292s)
[256.697636] [119/161] (798s left) kms_pipe_crc_basic (read-crc)
[257.059303] Starting subtest: read-crc
[257.086206] Starting dynamic subtest: pipe-A-DP-1
[257.640118] Dynamic subtest pipe-A-DP-1: SUCCESS (0.565s)
[257.689156] Starting dynamic subtest: pipe-B-DP-1
[258.379137] Dynamic subtest pipe-B-DP-1: SUCCESS (0.735s)
[258.458997] Starting dynamic subtest: pipe-C-DP-1
[259.120067] Dynamic subtest pipe-C-DP-1: SUCCESS (0.731s)
[259.140835] Subtest read-crc: SUCCESS (2.046s)
[259.536528] [120/161] (796s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[259.880036] Starting subtest: read-crc-frame-sequence
[259.900861] Starting dynamic subtest: pipe-A-DP-1
[260.466043] Dynamic subtest pipe-A-DP-1: SUCCESS (0.565s)
[260.514813] Starting dynamic subtest: pipe-B-DP-1
[261.207862] Dynamic subtest pipe-B-DP-1: SUCCESS (0.740s)
[261.261333] Starting dynamic subtest: pipe-C-DP-1
[261.944435] Dynamic subtest pipe-C-DP-1: SUCCESS (0.727s)
[261.966567] Subtest read-crc-frame-sequence: SUCCESS (2.049s)
[262.365534] [121/161] (793s left) kms_pm_backlight (basic-brightness)
[262.742724] Subtest basic-brightness: SKIP (0.000s)
[262.920439] [122/161] (793s left) kms_pm_rpm (basic-pci-d3-state)
[264.728411] Starting subtest: basic-pci-d3-state
[265.409285] Subtest basic-pci-d3-state: SUCCESS (0.677s)
[265.737490] [123/161] (790s left) kms_pm_rpm (basic-rte)
[265.986506] Starting subtest: basic-rte
[268.184604] Subtest basic-rte: SUCCESS (2.225s)
[269.163297] [124/161] (787s left) kms_psr (psr-primary-page-flip)
[269.560687] Subtest psr-primary-page-flip: SKIP (0.000s)
[269.741377] [125/161] (786s left) kms_psr (psr-cursor-plane-move)
[270.082676] Subtest psr-cursor-plane-move: SKIP (0.000s)
[270.262468] [126/161] (786s left) kms_psr (psr-sprite-plane-onoff)
[270.628808] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[270.805954] [127/161] (786s left) kms_psr (psr-primary-mmap-gtt)
[271.177088] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[271.355884] [128/161] (785s left) kms_setmode (basic-clone-single-crtc)
[271.609445] Starting subtest: basic-clone-single-crtc
[271.674660] Subtest basic-clone-single-crtc: SKIP (0.000s)
[271.875762] [129/161] (785s left) i915_pm_rps (basic-api)
[272.134279] Starting subtest: basic-api
[272.162657] Subtest basic-api: SUCCESS (0.008s)
[272.364880] [130/161] (785s left) prime_self_import (basic-llseek-bad)
[272.616071] Starting subtest: basic-llseek-bad
[272.663459] Subtest basic-llseek-bad: SUCCESS (0.005s)
[272.846918] [131/161] (784s left) prime_self_import (basic-llseek-size)
[273.069731] Starting subtest: basic-llseek-size
[273.111573] Subtest basic-llseek-size: SUCCESS (0.008s)
[273.294290] [132/161] (784s left) prime_self_import (basic-with_fd_dup)
[273.543210] Starting subtest: basic-with_fd_dup
[273.587799] Subtest basic-with_fd_dup: SUCCESS (0.007s)
[273.774730] [133/161] (784s left) prime_self_import (basic-with_one_bo)
[274.011746] Starting subtest: basic-with_one_bo
[274.057294] Subtest basic-with_one_bo: SUCCESS (0.008s)
[274.232454] [134/161] (784s left) prime_self_import (basic-with_one_bo_two_files)
[274.475403] Starting subtest: basic-with_one_bo_two_files
[274.517706] Subtest basic-with_one_bo_two_files: SUCCESS (0.007s)
[274.697702] [135/161] (783s left) prime_self_import (basic-with_two_bos)
[274.946754] Starting subtest: basic-with_two_bos
[274.991168] Subtest basic-with_two_bos: SUCCESS (0.008s)
[275.170357] [136/161] (783s left) prime_vgem (basic-fence-flip)
[275.446354] Starting subtest: basic-fence-flip
[276.090658] Subtest basic-fence-flip: SUCCESS (0.659s)
[276.316603] [137/161] (782s left) prime_vgem (basic-fence-mmap)
[276.616502] Starting subtest: basic-fence-mmap
[276.639952] Subtest basic-fence-mmap: SUCCESS (0.073s)
[276.846327] [138/161] (782s left) prime_vgem (basic-fence-read)
[277.144328] Starting subtest: basic-fence-read
[277.216392] Subtest basic-fence-read: SUCCESS (0.144s)
[277.450638] [139/161] (781s left) prime_vgem (basic-gtt)
[277.772112] Starting subtest: basic-gtt
[277.797851] Subtest basic-gtt: SUCCESS (0.031s)
[278.019634] [140/161] (781s left) prime_vgem (basic-read)
[278.300352] Starting subtest: basic-read
[278.325157] Subtest basic-read: SUCCESS (0.065s)
[278.526650] [141/161] (781s left) prime_vgem (basic-write)
[278.807346] Starting subtest: basic-write
[278.858646] Subtest basic-write: SUCCESS (0.098s)
[279.065360] [142/161] (780s left) vgem_basic (setversion)
[279.319731] Starting subtest: setversion
[279.365965] Subtest setversion: SUCCESS (0.000s)
[279.543766] [143/161] (780s left) vgem_basic (create)
[279.811249] Starting subtest: create
[279.834193] Subtest create: SUCCESS (0.001s)
[280.015651] [144/161] (780s left) vgem_basic (debugfs)
[280.268429] Starting subtest: debugfs
[280.291240] Subtest debugfs: SUCCESS (0.001s)
[280.469550] [145/161] (779s left) vgem_basic (dmabuf-export)
[280.719404] Starting subtest: dmabuf-export
[280.765795] Subtest dmabuf-export: SUCCESS (0.013s)
[280.941956] [146/161] (779s left) vgem_basic (dmabuf-fence)
[281.205686] Starting subtest: dmabuf-fence
[281.228414] Subtest dmabuf-fence: SUCCESS (0.002s)
[281.410432] [147/161] (779s left) vgem_basic (dmabuf-fence-before)
[281.658718] Starting subtest: dmabuf-fence-before
[281.681071] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[281.857470] [148/161] (779s left) vgem_basic (dmabuf-mmap)
[282.130196] Starting subtest: dmabuf-mmap
[282.152456] Subtest dmabuf-mmap: SUCCESS (0.037s)
[282.330725] [149/161] (778s left) vgem_basic (mmap)
[282.584639] Starting subtest: mmap
[282.607176] Subtest mmap: SUCCESS (0.024s)
[282.794503] [150/161] (778s left) vgem_basic (second-client)
[283.064834] Starting subtest: second-client
[283.109397] Subtest second-client: SUCCESS (0.032s)
[283.285706] [151/161] (778s left) vgem_basic (sysfs)
[283.556751] Starting subtest: sysfs
[283.578868] Subtest sysfs: SUCCESS (0.001s)
[283.756732] [152/161] (777s left) core_hotunplug (unbind-rebind)
[284.151386] Starting subtest: unbind-rebind
[296.728753] Killing the test because the kernel is tainted.
[416.920929] Timeout. Killing the current test with SIGKILL.
[417.922675] Child refuses to die, tainted 0x2c0. Aborting.
[418.107152] Closing watchdogs