[84.611859] Initializing watchdogs [84.612421] /dev/watchdog0 [84.691246] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:22b1 Intel Cherryview (Gen8) Atom/Celeron/Pentium Processor x5-E8000/J3xxx/N3xxx Integrated Graphics Controller [84.711346] [001/162] (960s left) i915_module_load (load) [84.977974] Starting subtest: load [90.137056] Subtest load: SUCCESS (5.209s) [90.417213] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [90.426814] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [90.437838] [002/162] (955s left) core_auth (basic-auth) [90.744049] Starting subtest: basic-auth [90.753337] Subtest basic-auth: SUCCESS (0.010s) [90.995513] [003/162] (954s left) core_debugfs (read-all-entries) [91.241841] Starting subtest: read-all-entries [91.252638] Subtest read-all-entries: SUCCESS (0.015s) [91.435864] [004/162] (954s left) core_sysfs (read-all-entries) [91.654686] Starting subtest: read-all-entries [91.673459] Subtest read-all-entries: SUCCESS (0.018s) [91.847689] [005/162] (954s left) fbdev (eof) [92.115234] Subtest eof: SKIP (0.000s) [92.277825] [006/162] (953s left) fbdev (info) [92.547621] Subtest info: SKIP (0.000s) [92.715568] [007/162] (953s left) fbdev (nullptr) [92.983188] Subtest nullptr: SKIP (0.000s) [93.146128] [008/162] (953s left) fbdev (read) [93.408309] Subtest read: SKIP (0.000s) [93.570910] [009/162] (953s left) fbdev (write) [93.833110] Subtest write: SKIP (0.000s) [93.988875] [010/162] (952s left) gem_basic (bad-close) [94.207048] Starting subtest: bad-close [94.218210] Subtest bad-close: SUCCESS (0.001s) [94.393765] [011/162] (952s left) gem_basic (create-close) [94.608309] Starting subtest: create-close [94.614273] Subtest create-close: SUCCESS (0.001s) [94.777656] [012/162] (952s left) gem_basic (create-fd-close) [95.024521] Starting subtest: create-fd-close [95.030160] Subtest create-fd-close: SUCCESS (0.002s) [95.192271] [013/162] (952s left) gem_busy (busy@all-engines) [95.486140] Starting subtest: busy [95.489097] Starting dynamic subtest: all-engines [95.663857] Dynamic subtest all-engines: SUCCESS (0.183s) [95.666219] Subtest busy: SUCCESS (0.185s) [96.161638] [014/162] (951s left) gem_close_race (basic-process) [96.438343] Starting subtest: basic-process [96.579479] Subtest basic-process: SUCCESS (0.144s) [96.875470] [015/162] (950s left) gem_close_race (basic-threads) [97.153263] Starting subtest: basic-threads [98.369699] Subtest basic-threads: SUCCESS (1.222s) [98.685513] [016/162] (949s left) gem_ctx_create (basic) [98.958780] Starting subtest: basic [98.961356] Subtest basic: SUCCESS (0.001s) [99.256866] [017/162] (948s left) gem_ctx_create (basic-files) [99.519239] Starting subtest: basic-files [101.579762] Subtest basic-files: SUCCESS (2.064s) [101.941148] [018/162] (946s left) gem_ctx_exec (basic) [102.168898] Starting subtest: basic [102.184211] Subtest basic: SUCCESS (0.017s) [102.378937] [019/162] (946s left) gem_exec_basic (basic) [102.640228] Starting subtest: basic [102.643762] Starting dynamic subtest: rcs0-smem [102.647181] Dynamic subtest rcs0-smem: SUCCESS (0.007s) [102.682317] Starting dynamic subtest: bcs0-smem [102.684231] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [102.725935] Starting dynamic subtest: vcs0-smem [102.728611] Dynamic subtest vcs0-smem: SUCCESS (0.023s) [102.756511] Starting dynamic subtest: vecs0-smem [102.759272] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [102.761974] Subtest basic: SUCCESS (0.046s) [102.991235] [020/162] (945s left) gem_exec_create (basic) [103.260825] Starting subtest: basic [103.264582] Starting dynamic subtest: smem [105.346643] Dynamic subtest smem: SUCCESS (2.089s) [105.348287] Subtest basic: SUCCESS (2.091s) [105.637301] [021/162] (943s left) gem_exec_fence (basic-busy) [106.072154] Starting subtest: basic-busy [106.073831] Starting dynamic subtest: rcs0 [106.103133] Dynamic subtest rcs0: SUCCESS (0.031s) [106.127838] Starting dynamic subtest: bcs0 [106.140051] Dynamic subtest bcs0: SUCCESS (0.037s) [106.167486] Starting dynamic subtest: vcs0 [106.183414] Dynamic subtest vcs0: SUCCESS (0.039s) [106.214318] Starting dynamic subtest: vecs0 [106.226787] Dynamic subtest vecs0: SUCCESS (0.042s) [106.228643] Subtest basic-busy: SUCCESS (0.158s) [107.191859] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [107.203189] [022/162] (941s left) gem_exec_fence (basic-wait) [107.629273] Starting subtest: basic-wait [107.631709] Starting dynamic subtest: rcs0 [107.665757] Dynamic subtest rcs0: SUCCESS (0.038s) [107.692464] Starting dynamic subtest: bcs0 [107.713403] Dynamic subtest bcs0: SUCCESS (0.047s) [107.739564] Starting dynamic subtest: vcs0 [107.759627] Dynamic subtest vcs0: SUCCESS (0.045s) [107.787763] Starting dynamic subtest: vecs0 [107.808611] Dynamic subtest vecs0: SUCCESS (0.046s) [107.812210] Subtest basic-wait: SUCCESS (0.186s) [108.610857] [023/162] (940s left) gem_exec_fence (basic-await) [109.047897] Starting subtest: basic-await [109.051064] Starting dynamic subtest: rcs0 [109.250923] Dynamic subtest rcs0: SUCCESS (0.199s) [109.283332] Starting dynamic subtest: bcs0 [109.450859] Dynamic subtest bcs0: SUCCESS (0.191s) [109.479745] Starting dynamic subtest: vcs0 [109.644703] Dynamic subtest vcs0: SUCCESS (0.189s) [109.672704] Starting dynamic subtest: vecs0 [109.832500] Dynamic subtest vecs0: SUCCESS (0.193s) [109.835233] Subtest basic-await: SUCCESS (0.786s) [110.667537] [024/162] (938s left) gem_exec_fence (nb-await) [111.098486] Starting subtest: nb-await [111.100890] Starting dynamic subtest: rcs0 [111.206313] Dynamic subtest rcs0: SUCCESS (0.103s) [111.234179] Starting dynamic subtest: bcs0 [111.303829] Dynamic subtest bcs0: SUCCESS (0.097s) [111.333196] Starting dynamic subtest: vcs0 [111.406173] Dynamic subtest vcs0: SUCCESS (0.093s) [111.432223] Starting dynamic subtest: vecs0 [111.501674] Dynamic subtest vecs0: SUCCESS (0.094s) [111.506750] Subtest nb-await: SUCCESS (0.408s) [112.299560] [025/162] (937s left) gem_exec_gttfill (basic) [112.558790] Starting subtest: basic [145.577370] Subtest basic: SUCCESS (33.018s) [145.934587] [026/162] (903s left) gem_exec_parallel (engines) [146.375149] Starting subtest: engines [146.380303] Starting dynamic subtest: basic [154.357979] Dynamic subtest basic: SUCCESS (7.990s) [154.389243] Starting dynamic subtest: contexts [165.522612] Dynamic subtest contexts: SUCCESS (11.162s) [165.554795] Starting dynamic subtest: fds [178.755427] Dynamic subtest fds: SUCCESS (13.230s) [178.811931] Starting dynamic subtest: userptr [185.391980] Dynamic subtest userptr: SUCCESS (6.633s) [185.394560] Subtest engines: SUCCESS (39.026s) [185.751763] [027/162] (864s left) gem_exec_store (basic) [186.038367] Starting subtest: basic [186.102225] Subtest basic: SUCCESS (0.070s) [186.445655] [028/162] (863s left) gem_flink_basic (bad-flink) [186.668999] Starting subtest: bad-flink [186.673296] Subtest bad-flink: SUCCESS (0.000s) [186.870267] [029/162] (863s left) gem_flink_basic (bad-open) [187.081543] Starting subtest: bad-open [187.086471] Subtest bad-open: SUCCESS (0.000s) [187.285689] [030/162] (863s left) gem_flink_basic (basic) [187.500301] Starting subtest: basic [187.504134] Subtest basic: SUCCESS (0.000s) [187.709885] [031/162] (863s left) gem_flink_basic (double-flink) [187.927894] Starting subtest: double-flink [187.931372] Subtest double-flink: SUCCESS (0.000s) [188.133885] [032/162] (863s left) gem_flink_basic (flink-lifetime) [188.347684] Starting subtest: flink-lifetime [188.357410] Subtest flink-lifetime: SUCCESS (0.009s) [188.615122] [033/162] (862s left) gem_huc_copy (huc-copy) [188.851129] Subtest huc-copy: SKIP (0.000s) [189.051665] [034/162] (862s left) gem_linear_blits (basic) [189.595253] Starting subtest: basic [189.646833] Subtest basic: SUCCESS (0.045s) [189.894832] [035/162] (861s left) gem_mmap (basic) [190.307578] Starting subtest: basic [190.325646] Subtest basic: SUCCESS (0.003s) [190.517664] [036/162] (861s left) gem_mmap_gtt (basic) [190.741332] Starting subtest: basic [190.755236] Subtest basic: SUCCESS (0.009s) [190.976497] [037/162] (861s left) gem_render_linear_blits (basic) [191.217896] Starting subtest: basic [191.359247] Subtest basic: SUCCESS (0.136s) [191.563588] [038/162] (860s left) gem_render_tiled_blits (basic) [191.802048] Starting subtest: basic [192.015334] Subtest basic: SUCCESS (0.211s) [192.222806] [039/162] (860s left) gem_ringfill (basic-all) [192.735546] Starting subtest: basic-all [194.069132] Subtest basic-all: SUCCESS (1.333s) [194.288677] [040/162] (858s left) gem_softpin (allocator-basic) [194.532720] Starting subtest: allocator-basic [194.957715] Subtest allocator-basic: SUCCESS (0.403s) [195.191752] [041/162] (857s left) gem_softpin (allocator-basic-reserve) [195.422395] Starting subtest: allocator-basic-reserve [195.840808] Subtest allocator-basic-reserve: SUCCESS (0.403s) [196.129372] [042/162] (857s left) gem_softpin (safe-alignment) [196.368438] Starting subtest: safe-alignment [196.428939] Subtest safe-alignment: SUCCESS (0.052s) [196.632893] [043/162] (856s left) gem_sync (basic-all) [196.893890] Starting subtest: basic-all [200.201709] Subtest basic-all: SUCCESS (3.308s) [200.531130] [044/162] (853s left) gem_sync (basic-each) [200.802780] Starting subtest: basic-each [203.611310] Subtest basic-each: SUCCESS (2.809s) [203.931224] [045/162] (849s left) gem_tiled_blits (basic) [204.388856] Starting subtest: basic [204.473306] Subtest basic: SUCCESS (0.095s) [204.711144] [046/162] (849s left) gem_tiled_fence_blits (basic) [205.377353] Starting subtest: basic [205.446873] Subtest basic: SUCCESS (0.071s) [205.686953] [047/162] (848s left) gem_tiled_pread_basic (basic) [206.059291] Starting subtest: basic [207.073630] Subtest basic: SUCCESS (1.014s) [207.268251] [048/162] (847s left) gem_wait (busy@all-engines) [207.559596] Starting subtest: busy [207.562200] Starting dynamic subtest: all-engines [208.105108] Dynamic subtest all-engines: SUCCESS (0.546s) [208.109562] Subtest busy: SUCCESS (0.548s) [208.525419] [049/162] (846s left) gem_wait (wait@all-engines) [208.820438] Starting subtest: wait [208.822418] Starting dynamic subtest: all-engines [209.870751] Dynamic subtest all-engines: SUCCESS (1.050s) [209.875403] Subtest wait: SUCCESS (1.054s) [210.277423] [050/162] (844s left) i915_getparams_basic (basic-eu-total) [210.492224] Starting subtest: basic-eu-total [210.496825] Subtest basic-eu-total: SUCCESS (0.000s) [210.750211] [051/162] (844s left) i915_getparams_basic (basic-subslice-total) [210.969108] Starting subtest: basic-subslice-total [210.979192] Subtest basic-subslice-total: SUCCESS (0.000s) [211.207355] [052/162] (844s left) i915_hangman (error-state-basic) [211.477452] Starting subtest: error-state-basic [211.513227] Subtest error-state-basic: SUCCESS (0.043s) [211.781989] [053/162] (843s left) i915_pciid [212.198774] [054/162] (843s left) intel_hwmon (hwmon-read) [212.413288] Subtest hwmon-read: SKIP (0.000s) [212.608818] [055/162] (843s left) intel_hwmon (hwmon-write) [212.826691] Subtest hwmon-write: SKIP (0.000s) [213.049060] [056/162] (843s left) kms_addfb_basic (addfb25-4-tiled) [213.639916] Starting subtest: addfb25-4-tiled [213.642486] Subtest addfb25-4-tiled: SUCCESS (0.003s) [213.862843] [057/162] (842s left) kms_addfb_basic (addfb25-bad-modifier) [214.416660] Starting subtest: addfb25-bad-modifier [214.420591] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [214.642624] [058/162] (842s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [215.194832] Starting subtest: addfb25-framebuffer-vs-set-tiling [215.196610] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [215.410521] [059/162] (841s left) kms_addfb_basic (addfb25-modifier-no-flag) [215.968176] Starting subtest: addfb25-modifier-no-flag [215.969892] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [216.184868] [060/162] (840s left) kms_addfb_basic (addfb25-x-tiled-legacy) [216.728536] Starting subtest: addfb25-x-tiled-legacy [216.730340] Subtest addfb25-x-tiled-legacy: SUCCESS (0.002s) [216.944152] [061/162] (840s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [217.521573] Starting subtest: addfb25-x-tiled-mismatch-legacy [217.523756] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [217.740728] [062/162] (839s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [218.323359] Starting subtest: addfb25-yf-tiled-legacy [218.326457] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s) [218.536931] [063/162] (839s left) kms_addfb_basic (addfb25-y-tiled-legacy) [219.043806] Starting subtest: addfb25-y-tiled-legacy [219.047232] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [219.258803] [064/162] (838s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [219.816270] Starting subtest: addfb25-y-tiled-small-legacy [219.819728] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [220.027895] [065/162] (838s left) kms_addfb_basic (bad-pitch-0) [220.270357] Starting subtest: bad-pitch-0 [220.272339] Subtest bad-pitch-0: SUCCESS (0.000s) [220.851174] [066/162] (837s left) kms_addfb_basic (bad-pitch-1024) [221.071792] Starting subtest: bad-pitch-1024 [221.075605] Subtest bad-pitch-1024: SUCCESS (0.000s) [221.625937] [067/162] (836s left) kms_addfb_basic (bad-pitch-128) [221.850903] Starting subtest: bad-pitch-128 [221.854447] Subtest bad-pitch-128: SUCCESS (0.000s) [222.385206] [068/162] (836s left) kms_addfb_basic (bad-pitch-256) [222.608297] Starting subtest: bad-pitch-256 [222.612887] Subtest bad-pitch-256: SUCCESS (0.000s) [223.229647] [069/162] (835s left) kms_addfb_basic (bad-pitch-32) [223.455323] Starting subtest: bad-pitch-32 [223.457101] Subtest bad-pitch-32: SUCCESS (0.000s) [224.054769] [070/162] (835s left) kms_addfb_basic (bad-pitch-63) [224.275637] Starting subtest: bad-pitch-63 [224.280962] Subtest bad-pitch-63: SUCCESS (0.000s) [224.838186] [071/162] (834s left) kms_addfb_basic (bad-pitch-65536) [225.054959] Starting subtest: bad-pitch-65536 [225.058770] Subtest bad-pitch-65536: SUCCESS (0.002s) [225.593395] [072/162] (833s left) kms_addfb_basic (bad-pitch-999) [225.804330] Starting subtest: bad-pitch-999 [225.807230] Subtest bad-pitch-999: SUCCESS (0.000s) [226.367342] [073/162] (833s left) kms_addfb_basic (basic) [226.584645] Starting subtest: basic [226.587438] Subtest basic: SUCCESS (0.000s) [227.182194] [074/162] (832s left) kms_addfb_basic (basic-x-tiled-legacy) [227.412351] Starting subtest: basic-x-tiled-legacy [227.414041] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [227.885412] [075/162] (832s left) kms_addfb_basic (basic-y-tiled-legacy) [228.106332] Starting subtest: basic-y-tiled-legacy [228.108294] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [228.660155] [076/162] (831s left) kms_addfb_basic (bo-too-small) [229.156723] Starting subtest: bo-too-small [229.159321] Subtest bo-too-small: SUCCESS (0.002s) [229.376875] [077/162] (831s left) kms_addfb_basic (bo-too-small-due-to-tiling) [229.956460] Starting subtest: bo-too-small-due-to-tiling [229.958125] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s) [230.174047] [078/162] (830s left) kms_addfb_basic (clobberred-modifier) [230.399278] Starting subtest: clobberred-modifier [230.401148] Subtest clobberred-modifier: SUCCESS (0.000s) [230.891294] [079/162] (830s left) kms_addfb_basic (framebuffer-vs-set-tiling) [231.121280] Starting subtest: framebuffer-vs-set-tiling [231.124233] Subtest framebuffer-vs-set-tiling: SUCCESS (0.002s) [231.676429] [080/162] (829s left) kms_addfb_basic (invalid-get-prop) [231.888944] Starting subtest: invalid-get-prop [231.892241] Subtest invalid-get-prop: SUCCESS (0.000s) [232.453766] [081/162] (828s left) kms_addfb_basic (invalid-get-prop-any) [232.671753] Starting subtest: invalid-get-prop-any [232.675228] Subtest invalid-get-prop-any: SUCCESS (0.000s) [233.232331] [082/162] (828s left) kms_addfb_basic (invalid-set-prop) [233.507273] Starting subtest: invalid-set-prop [233.509282] Subtest invalid-set-prop: SUCCESS (0.000s) [233.999795] [083/162] (827s left) kms_addfb_basic (invalid-set-prop-any) [234.220667] Starting subtest: invalid-set-prop-any [234.222544] Subtest invalid-set-prop-any: SUCCESS (0.000s) [234.743807] [084/162] (827s left) kms_addfb_basic (no-handle) [234.962421] Starting subtest: no-handle [234.964046] Subtest no-handle: SUCCESS (0.000s) [235.689825] [085/162] (826s left) kms_addfb_basic (size-max) [236.225225] Starting subtest: size-max [236.227946] Subtest size-max: SUCCESS (0.002s) [236.441885] [086/162] (826s left) kms_addfb_basic (small-bo) [237.018514] Starting subtest: small-bo [237.020805] Subtest small-bo: SUCCESS (0.002s) [237.236903] [087/162] (825s left) kms_addfb_basic (tile-pitch-mismatch) [237.481154] Starting subtest: tile-pitch-mismatch [237.483744] Subtest tile-pitch-mismatch: SUCCESS (0.004s) [238.062930] [088/162] (824s left) kms_addfb_basic (too-high) [238.615513] Starting subtest: too-high [238.617894] Subtest too-high: SUCCESS (0.006s) [238.856172] [089/162] (824s left) kms_addfb_basic (too-wide) [239.370237] Starting subtest: too-wide [239.372661] Subtest too-wide: SUCCESS (0.000s) [239.608675] [090/162] (823s left) kms_addfb_basic (unused-handle) [239.824935] Starting subtest: unused-handle [239.828624] Subtest unused-handle: SUCCESS (0.000s) [240.391751] [091/162] (823s left) kms_addfb_basic (unused-modifier) [240.624505] Starting subtest: unused-modifier [240.627647] Subtest unused-modifier: SUCCESS (0.000s) [241.238706] [092/162] (822s left) kms_addfb_basic (unused-offsets) [241.458860] Starting subtest: unused-offsets [241.462369] Subtest unused-offsets: SUCCESS (0.002s) [242.014159] [093/162] (821s left) kms_addfb_basic (unused-pitches) [242.238630] Starting subtest: unused-pitches [242.242034] Subtest unused-pitches: SUCCESS (0.000s) [242.821633] [094/162] (821s left) kms_busy (basic) [243.412373] Subtest basic: SKIP (0.000s) [243.680638] [095/162] (820s left) kms_prop_blob (basic) [243.906361] Starting subtest: basic [243.908361] Subtest basic: SUCCESS (0.000s) [244.128154] [096/162] (820s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [244.676572] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [244.868817] [097/162] (819s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [245.421966] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [245.636922] [098/162] (819s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [246.209239] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [246.405798] [099/162] (818s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [247.031839] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [247.231666] [100/162] (818s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [247.831358] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [248.035430] [101/162] (817s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [248.574170] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [248.785884] [102/162] (817s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [249.395495] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [249.601344] [103/162] (816s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [250.288715] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [250.505233] [104/162] (815s left) kms_dsc (dsc-basic) [251.062620] Subtest dsc-basic: SKIP (0.000s) [251.267838] [105/162] (815s left) kms_flip (basic-flip-vs-dpms) [251.846678] Starting subtest: basic-flip-vs-dpms [251.857166] Subtest basic-flip-vs-dpms: SKIP (0.009s) [252.114327] [106/162] (814s left) kms_flip (basic-flip-vs-modeset) [252.701631] Starting subtest: basic-flip-vs-modeset [252.711954] Subtest basic-flip-vs-modeset: SKIP (0.010s) [252.964943] [107/162] (813s left) kms_flip (basic-flip-vs-wf_vblank) [253.519031] Starting subtest: basic-flip-vs-wf_vblank [253.527560] Subtest basic-flip-vs-wf_vblank: SKIP (0.006s) [253.791546] [108/162] (813s left) kms_flip (basic-plain-flip) [254.401980] Starting subtest: basic-plain-flip [254.410630] Subtest basic-plain-flip: SKIP (0.009s) [254.670175] [109/162] (812s left) kms_force_connector_basic (force-connector-state) [255.005672] Starting subtest: force-connector-state [255.591690] Subtest force-connector-state: SUCCESS (0.578s) [256.496213] [110/162] (811s left) kms_force_connector_basic (force-edid) [256.939292] Starting subtest: force-edid [257.131686] Subtest force-edid: SUCCESS (0.196s) [257.782664] [111/162] (810s left) kms_force_connector_basic (force-load-detect) [258.171425] Starting subtest: force-load-detect [258.177193] Subtest force-load-detect: SKIP (0.000s) [258.689912] [112/162] (809s left) kms_force_connector_basic (prune-stale-modes) [259.003620] Starting subtest: prune-stale-modes [259.208850] Subtest prune-stale-modes: SUCCESS (0.203s) [259.752700] [113/162] (808s left) kms_frontbuffer_tracking (basic) [260.370755] Subtest basic: SKIP (0.000s) [260.595427] [114/162] (807s left) kms_hdmi_inject (inject-audio) [260.824564] Starting subtest: inject-audio [261.229189] Subtest inject-audio: SUCCESS (0.399s) [261.751541] [115/162] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [262.308849] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [262.538775] [116/162] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [263.090145] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [263.360530] [117/162] (805s left) kms_pipe_crc_basic (hang-read-crc) [263.846399] Subtest hang-read-crc: SKIP (0.000s) [264.078587] [118/162] (805s left) kms_pipe_crc_basic (nonblocking-crc) [264.625823] Subtest nonblocking-crc: SKIP (0.000s) [264.847257] [119/162] (804s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [265.480206] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [265.702980] [120/162] (804s left) kms_pipe_crc_basic (read-crc) [266.246203] Subtest read-crc: SKIP (0.000s) [266.481696] [121/162] (803s left) kms_pipe_crc_basic (read-crc-frame-sequence) [267.029397] Subtest read-crc-frame-sequence: SKIP (0.000s) [267.250453] [122/162] (802s left) kms_pm_backlight (basic-brightness) [267.852640] Subtest basic-brightness: SKIP (0.000s) [268.072665] [123/162] (802s left) kms_pm_rpm (basic-pci-d3-state) [269.940326] Starting subtest: basic-pci-d3-state [270.162670] Subtest basic-pci-d3-state: SUCCESS (0.222s) [270.379494] [124/162] (800s left) kms_pm_rpm (basic-rte) [270.589584] Starting subtest: basic-rte [272.399374] Subtest basic-rte: SUCCESS (1.808s) [272.856744] [125/162] (797s left) kms_psr (psr-primary-page-flip) [273.444488] Subtest psr-primary-page-flip: SKIP (0.000s) [273.665455] [126/162] (797s left) kms_psr (psr-cursor-plane-move) [274.205130] Subtest psr-cursor-plane-move: SKIP (0.000s) [274.449617] [127/162] (796s left) kms_psr (psr-sprite-plane-onoff) [275.040951] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [275.256945] [128/162] (796s left) kms_psr (psr-primary-mmap-gtt) [275.741721] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [275.959511] [129/162] (795s left) kms_setmode (basic-clone-single-crtc) [276.195262] Starting subtest: basic-clone-single-crtc [276.205197] Subtest basic-clone-single-crtc: SKIP (0.001s) [276.433441] [130/162] (795s left) i915_pm_rps (basic-api) [276.705748] Starting subtest: basic-api [276.721759] Subtest basic-api: SUCCESS (0.018s) [276.947421] [131/162] (795s left) prime_self_import (basic-llseek-bad) [277.156111] Starting subtest: basic-llseek-bad [277.168986] Subtest basic-llseek-bad: SUCCESS (0.012s) [277.395106] [132/162] (794s left) prime_self_import (basic-llseek-size) [277.610457] Starting subtest: basic-llseek-size [277.621633] Subtest basic-llseek-size: SUCCESS (0.018s) [277.850919] [133/162] (794s left) prime_self_import (basic-with_fd_dup) [278.055749] Starting subtest: basic-with_fd_dup [278.073686] Subtest basic-with_fd_dup: SUCCESS (0.017s) [278.351765] [134/162] (794s left) prime_self_import (basic-with_one_bo) [278.582585] Starting subtest: basic-with_one_bo [278.592560] Subtest basic-with_one_bo: SUCCESS (0.016s) [278.814248] [135/162] (794s left) prime_self_import (basic-with_one_bo_two_files) [279.018604] Starting subtest: basic-with_one_bo_two_files [279.032703] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s) [279.257513] [136/162] (793s left) prime_self_import (basic-with_two_bos) [279.473062] Starting subtest: basic-with_two_bos [279.496726] Subtest basic-with_two_bos: SUCCESS (0.023s) [279.729223] [137/162] (793s left) prime_vgem (basic-fence-flip) [280.006793] Starting subtest: basic-fence-flip [280.463207] Subtest basic-fence-flip: SKIP (0.443s) [280.816400] [138/162] (792s left) prime_vgem (basic-fence-mmap) [281.104300] Starting subtest: basic-fence-mmap [281.208658] Subtest basic-fence-mmap: SUCCESS (0.109s) [281.450927] [139/162] (792s left) prime_vgem (basic-fence-read) [281.723189] Starting subtest: basic-fence-read [281.983727] Subtest basic-fence-read: SUCCESS (0.261s) [282.228989] [140/162] (791s left) prime_vgem (basic-gtt) [282.476693] Starting subtest: basic-gtt [282.525560] Subtest basic-gtt: SUCCESS (0.045s) [282.753234] [141/162] (791s left) prime_vgem (basic-read) [283.016150] Starting subtest: basic-read [283.138777] Subtest basic-read: SUCCESS (0.124s) [283.383763] [142/162] (791s left) prime_vgem (basic-write) [283.637705] Starting subtest: basic-write [283.809317] Subtest basic-write: SUCCESS (0.171s) [284.033261] [143/162] (790s left) vgem_basic (setversion) [284.255773] Starting subtest: setversion [284.262196] Subtest setversion: SUCCESS (0.000s) [284.499625] [144/162] (790s left) vgem_basic (create) [284.713781] Starting subtest: create [284.716207] Subtest create: SUCCESS (0.001s) [284.929326] [145/162] (790s left) vgem_basic (debugfs) [285.158041] Starting subtest: debugfs [285.161950] Subtest debugfs: SUCCESS (0.003s) [285.392197] [146/162] (790s left) vgem_basic (dmabuf-export) [285.611721] Starting subtest: dmabuf-export [285.619271] Subtest dmabuf-export: SUCCESS (0.012s) [285.840688] [147/162] (789s left) vgem_basic (dmabuf-fence) [286.057336] Starting subtest: dmabuf-fence [286.060517] Subtest dmabuf-fence: SUCCESS (0.003s) [286.281067] [148/162] (789s left) vgem_basic (dmabuf-fence-before) [286.497243] Starting subtest: dmabuf-fence-before [286.500447] Subtest dmabuf-fence-before: SUCCESS (0.002s) [286.711888] [149/162] (789s left) vgem_basic (dmabuf-mmap) [286.930636] Starting subtest: dmabuf-mmap [286.973118] Subtest dmabuf-mmap: SUCCESS (0.041s) [287.182349] [150/162] (789s left) vgem_basic (mmap) [287.407229] Starting subtest: mmap [287.437114] Subtest mmap: SUCCESS (0.031s) [287.662578] [151/162] (788s left) vgem_basic (second-client) [287.885383] Starting subtest: second-client [287.907438] Subtest second-client: SUCCESS (0.018s) [288.122253] [152/162] (788s left) vgem_basic (sysfs) [288.359427] Starting subtest: sysfs [288.372063] Subtest sysfs: SUCCESS (0.004s) [288.688943] [153/162] (788s left) core_hotunplug (unbind-rebind) [289.164075] Starting subtest: unbind-rebind [294.370316] Subtest unbind-rebind: SUCCESS (5.199s) [294.572203] [154/162] (782s left) vgem_basic (unload) [294.795152] Starting subtest: unload [324.010678] Subtest unload: SUCCESS (29.220s) [324.378762] [155/162] (752s left) i915_module_load (reload) [324.592759] Starting subtest: reload [331.737897] Subtest reload: SUCCESS (7.139s) [332.105117] [156/162] (745s left) gem_lmem_swapping (basic) [332.516190] Subtest basic: SKIP (0.000s) [332.731982] [157/162] (745s left) gem_lmem_swapping (parallel-random-engines) [332.980609] Subtest parallel-random-engines: SKIP (0.000s) [333.192550] [158/162] (744s left) gem_lmem_swapping (random-engines) [333.437606] Subtest random-engines: SKIP (0.000s) [333.637341] [159/162] (744s left) gem_lmem_swapping (verify-random) [333.877219] Subtest verify-random: SKIP (0.000s) [334.077641] [160/162] (744s left) i915_pm_rpm (module-reload) [335.675808] Starting subtest: module-reload [353.836202] Subtest module-reload: SUCCESS (18.162s) [353.980860] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [353.986163] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [353.998341] [161/162] (724s left) i915_selftest (live) [354.245771] Starting subtest: live [354.252284] Starting dynamic subtest: sanitycheck [359.913482] Dynamic subtest sanitycheck: SUCCESS (5.664s) [359.948420] Starting dynamic subtest: uncore [365.583712] Dynamic subtest uncore: SUCCESS (5.662s) [365.624784] Starting dynamic subtest: workarounds [371.837657] Dynamic subtest workarounds: SUCCESS (6.247s) [371.870576] Starting dynamic subtest: gt_engines [377.943390] Dynamic subtest gt_engines: SUCCESS (6.097s) [377.972856] Starting dynamic subtest: gt_timelines [414.962775] Dynamic subtest gt_timelines: SUCCESS (37.016s) [414.999186] Starting dynamic subtest: gt_contexts [420.873840] Dynamic subtest gt_contexts: SUCCESS (5.903s) [420.923720] Starting dynamic subtest: gt_lrc [430.169571] Dynamic subtest gt_lrc: SUCCESS (9.263s) [430.201361] Starting dynamic subtest: gt_mocs [435.752591] Dynamic subtest gt_mocs: SUCCESS (5.604s) [435.799686] Starting dynamic subtest: gt_pm [442.414146] Dynamic subtest gt_pm: SUCCESS (6.655s) [442.450726] Starting dynamic subtest: gt_heartbeat [448.037188] Dynamic subtest gt_heartbeat: SUCCESS (5.618s) [448.088727] Starting dynamic subtest: gt_tlb [454.399483] Dynamic subtest gt_tlb: SUCCESS (6.350s) [454.436321] Starting dynamic subtest: requests [466.559411] Dynamic subtest requests: SUCCESS (12.146s) [466.597223] Starting dynamic subtest: migrate [476.652811] Dynamic subtest migrate: SUCCESS (10.089s) [476.724164] Starting dynamic subtest: active [482.359578] Dynamic subtest active: SUCCESS (5.688s) [482.429446] Starting dynamic subtest: objects [489.551962] Dynamic subtest objects: SUCCESS (7.190s) [489.586099] Starting dynamic subtest: mman [503.258633] Dynamic subtest mman: SUCCESS (13.701s) [503.289297] Starting dynamic subtest: dmabuf [509.032232] Dynamic subtest dmabuf: SUCCESS (5.763s) [509.081998] Starting dynamic subtest: vma [514.791426] Dynamic subtest vma: SUCCESS (5.752s) [514.840991] Starting dynamic subtest: coherency [526.814557] Dynamic subtest coherency: SUCCESS (12.012s) [526.844151] Starting dynamic subtest: gtt [540.371685] Dynamic subtest gtt: SUCCESS (13.556s) [540.405205] Starting dynamic subtest: gem [547.394623] Dynamic subtest gem: SUCCESS (7.012s) [547.425914] Starting dynamic subtest: evict [561.250169] Dynamic subtest evict: SUCCESS (13.845s) [561.279841] Starting dynamic subtest: hugepages [567.415275] Dynamic subtest hugepages: SUCCESS (6.161s) [567.445815] Starting dynamic subtest: gem_contexts [600.977809] Dynamic subtest gem_contexts: SUCCESS (33.558s) [601.011148] Starting dynamic subtest: client [606.586873] Dynamic subtest client: SUCCESS (5.603s) [606.650898] Starting dynamic subtest: gem_migrate [612.453034] Dynamic subtest gem_migrate: SUCCESS (5.850s) [612.525273] Starting dynamic subtest: reset [626.387705] Dynamic subtest reset: SUCCESS (13.920s) [626.429519] Starting dynamic subtest: memory_region [632.032462] Dynamic subtest memory_region: SUCCESS (5.628s) [632.064501] Starting dynamic subtest: hangcheck [661.109774] Dynamic subtest hangcheck: SUCCESS (29.076s) [661.147943] Starting dynamic subtest: execlists [673.182216] Dynamic subtest execlists: SUCCESS (12.058s) [673.211755] Starting dynamic subtest: ring_submission [678.666246] Dynamic subtest ring_submission: SUCCESS (5.483s) [678.751457] Starting dynamic subtest: perf [684.982097] Dynamic subtest perf: SUCCESS (6.304s) [685.032547] Starting dynamic subtest: slpc [690.626909] Dynamic subtest slpc: SUCCESS (5.638s) [690.669358] Starting dynamic subtest: guc [696.219589] Dynamic subtest guc: SUCCESS (5.583s) [696.261402] Starting dynamic subtest: guc_multi_lrc [702.278661] Dynamic subtest guc_multi_lrc: SUCCESS (6.041s) [702.346964] Starting dynamic subtest: guc_hang [707.903129] Dynamic subtest guc_hang: SUCCESS (5.617s) [707.941505] Starting dynamic subtest: late_gt_pm [713.498896] Dynamic subtest late_gt_pm: SUCCESS (5.589s) [713.509258] Subtest live: SUCCESS (359.251s) [713.695117] [162/162] (365s left) dmabuf (all-tests) [713.920470] Starting subtest: all-tests [713.928358] Starting dynamic subtest: sanitycheck [713.995823] Dynamic subtest sanitycheck: SUCCESS (0.071s) [714.061232] Starting dynamic subtest: dma_fence [714.260187] Dynamic subtest dma_fence: SUCCESS (0.253s) [714.299507] Starting dynamic subtest: dma_fence_chain [714.302944] Dynamic subtest dma_fence_chain: SKIP (0.006s) [714.331112] Starting dynamic subtest: dma_fence_unwrap [714.401207] Dynamic subtest dma_fence_unwrap: SUCCESS (0.110s) [714.450205] Starting dynamic subtest: dma_resv [714.500661] Dynamic subtest dma_resv: SUCCESS (0.088s) [714.509841] Subtest all-tests: SUCCESS (0.587s) [714.653588] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.