[149.712998] Initializing watchdogs [149.713387] /dev/watchdog0 [149.802711] [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 [149.823736] [001/162] (960s left) i915_module_load (load) [150.138216] Starting subtest: load [158.557086] Subtest load: SUCCESS (8.389s) [158.825305] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [158.834809] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [158.849812] [002/162] (951s left) core_auth (basic-auth) [159.165550] Starting subtest: basic-auth [159.176219] Subtest basic-auth: SUCCESS (0.011s) [159.432458] [003/162] (951s left) core_debugfs (read-all-entries) [159.704246] Starting subtest: read-all-entries [159.733776] Subtest read-all-entries: SUCCESS (0.029s) [160.070574] [004/162] (951s left) core_sysfs (read-all-entries) [160.340300] Starting subtest: read-all-entries [160.367673] Subtest read-all-entries: SUCCESS (0.028s) [160.572884] [005/162] (950s left) fbdev (eof) [160.864601] Subtest eof: SKIP (0.000s) [161.038257] [006/162] (950s left) fbdev (info) [161.325895] Subtest info: SKIP (0.000s) [161.499818] [007/162] (950s left) fbdev (nullptr) [161.800933] Subtest nullptr: SKIP (0.000s) [161.986771] [008/162] (949s left) fbdev (read) [162.307212] Subtest read: SKIP (0.000s) [162.514484] [009/162] (949s left) fbdev (write) [162.796185] Subtest write: SKIP (0.000s) [162.985073] [010/162] (949s left) gem_basic (bad-close) [163.256823] Starting subtest: bad-close [163.265784] Subtest bad-close: SUCCESS (0.000s) [163.492291] [011/162] (949s left) gem_basic (create-close) [163.743720] Starting subtest: create-close [163.756867] Subtest create-close: SUCCESS (0.001s) [163.948778] [012/162] (948s left) gem_basic (create-fd-close) [164.224251] Starting subtest: create-fd-close [164.235383] Subtest create-fd-close: SUCCESS (0.007s) [164.447073] [013/162] (948s left) gem_busy (busy@all-engines) [164.829076] Starting subtest: busy [164.838657] Starting dynamic subtest: all-engines [165.074133] Dynamic subtest all-engines: SUCCESS (0.246s) [165.078164] Subtest busy: SUCCESS (0.251s) [165.830322] [014/162] (947s left) gem_close_race (basic-process) [166.186561] Starting subtest: basic-process [166.367066] Subtest basic-process: SUCCESS (0.180s) [166.754878] [015/162] (946s left) gem_close_race (basic-threads) [167.165332] Starting subtest: basic-threads [168.540913] Subtest basic-threads: SUCCESS (1.379s) [168.882929] [016/162] (944s left) gem_ctx_create (basic) [169.179454] Starting subtest: basic [169.182264] Subtest basic: SUCCESS (0.000s) [169.522377] [017/162] (944s left) gem_ctx_create (basic-files) [169.846483] Starting subtest: basic-files [171.923210] Subtest basic-files: SUCCESS (2.073s) [172.358206] [018/162] (941s left) gem_ctx_exec (basic) [172.634730] Starting subtest: basic [172.678405] Subtest basic: SUCCESS (0.042s) [172.985292] [019/162] (941s left) gem_exec_basic (basic) [173.266366] Starting subtest: basic [173.270758] Starting dynamic subtest: rcs0-smem [173.279633] Dynamic subtest rcs0-smem: SUCCESS (0.008s) [173.330150] Starting dynamic subtest: bcs0-smem [173.331850] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [173.364502] Starting dynamic subtest: vcs0-smem [173.366166] Dynamic subtest vcs0-smem: SUCCESS (0.008s) [173.397955] Starting dynamic subtest: vecs0-smem [173.399670] Dynamic subtest vecs0-smem: SUCCESS (0.004s) [173.401436] Subtest basic: SUCCESS (0.036s) [173.649402] [020/162] (940s left) gem_exec_create (basic) [173.967481] Starting subtest: basic [173.986691] Starting dynamic subtest: smem [176.089880] Dynamic subtest smem: SUCCESS (2.107s) [176.099702] Subtest basic: SUCCESS (2.116s) [176.430515] [021/162] (938s left) gem_exec_fence (basic-busy) [176.924105] Starting subtest: basic-busy [176.926388] Starting dynamic subtest: rcs0 [176.952249] Dynamic subtest rcs0: SUCCESS (0.034s) [177.059587] Starting dynamic subtest: bcs0 [177.071482] Dynamic subtest bcs0: SUCCESS (0.049s) [177.130144] Starting dynamic subtest: vcs0 [177.133570] Dynamic subtest vcs0: SUCCESS (0.049s) [177.173699] Starting dynamic subtest: vecs0 [177.176708] Dynamic subtest vecs0: SUCCESS (0.064s) [177.178376] Subtest basic-busy: SUCCESS (0.208s) [178.428445] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [178.436177] [022/162] (936s left) gem_exec_fence (basic-wait) [178.895455] Starting subtest: basic-wait [178.901356] Starting dynamic subtest: rcs0 [178.929906] Dynamic subtest rcs0: SUCCESS (0.031s) [179.007696] Starting dynamic subtest: bcs0 [179.013513] Dynamic subtest bcs0: SUCCESS (0.033s) [179.101286] Starting dynamic subtest: vcs0 [179.104265] Dynamic subtest vcs0: SUCCESS (0.033s) [179.165558] Starting dynamic subtest: vecs0 [179.171097] Dynamic subtest vecs0: SUCCESS (0.045s) [179.174943] Subtest basic-wait: SUCCESS (0.165s) [179.955469] [023/162] (935s left) gem_exec_fence (basic-await) [180.428799] Starting subtest: basic-await [180.430749] Starting dynamic subtest: rcs0 [180.652511] Dynamic subtest rcs0: SUCCESS (0.219s) [180.692047] Starting dynamic subtest: bcs0 [180.853227] Dynamic subtest bcs0: SUCCESS (0.194s) [180.936137] Starting dynamic subtest: vcs0 [181.124499] Dynamic subtest vcs0: SUCCESS (0.271s) [181.178460] Starting dynamic subtest: vecs0 [181.365833] Dynamic subtest vecs0: SUCCESS (0.238s) [181.374375] Subtest basic-await: SUCCESS (0.945s) [182.205306] [024/162] (933s left) gem_exec_fence (nb-await) [182.770119] Starting subtest: nb-await [182.773258] Starting dynamic subtest: rcs0 [182.879241] Dynamic subtest rcs0: SUCCESS (0.104s) [182.926497] Starting dynamic subtest: bcs0 [182.967966] Dynamic subtest bcs0: SUCCESS (0.086s) [183.013541] Starting dynamic subtest: vcs0 [183.059762] Dynamic subtest vcs0: SUCCESS (0.086s) [183.127641] Starting dynamic subtest: vecs0 [183.145471] Dynamic subtest vecs0: SUCCESS (0.088s) [183.147957] Subtest nb-await: SUCCESS (0.374s) [184.010771] [025/162] (931s left) gem_exec_gttfill (basic) [184.382205] Starting subtest: basic [219.645312] Subtest basic: SUCCESS (35.262s) [220.185779] [026/162] (895s left) gem_exec_parallel (engines) [220.724086] Starting subtest: engines [220.727587] Starting dynamic subtest: basic [227.895775] Dynamic subtest basic: SUCCESS (7.180s) [227.942356] Starting dynamic subtest: contexts [239.044920] Dynamic subtest contexts: SUCCESS (11.145s) [239.101834] Starting dynamic subtest: fds [251.863318] Dynamic subtest fds: SUCCESS (12.796s) [251.922991] Starting dynamic subtest: userptr [258.586618] Dynamic subtest userptr: SUCCESS (6.727s) [258.589641] Subtest engines: SUCCESS (37.872s) [258.978126] [027/162] (857s left) gem_exec_store (basic) [259.259778] Starting subtest: basic [259.332840] Subtest basic: SUCCESS (0.077s) [259.760995] [028/162] (856s left) gem_flink_basic (bad-flink) [260.003697] Starting subtest: bad-flink [260.006764] Subtest bad-flink: SUCCESS (0.000s) [260.226050] [029/162] (856s left) gem_flink_basic (bad-open) [260.463598] Starting subtest: bad-open [260.466232] Subtest bad-open: SUCCESS (0.000s) [260.676305] [030/162] (856s left) gem_flink_basic (basic) [260.910304] Starting subtest: basic [260.914256] Subtest basic: SUCCESS (0.000s) [261.130927] [031/162] (855s left) gem_flink_basic (double-flink) [261.370991] Starting subtest: double-flink [261.376162] Subtest double-flink: SUCCESS (0.000s) [261.594228] [032/162] (855s left) gem_flink_basic (flink-lifetime) [261.832228] Starting subtest: flink-lifetime [261.841248] Subtest flink-lifetime: SUCCESS (0.009s) [262.068155] [033/162] (855s left) gem_huc_copy (huc-copy) [262.349332] Subtest huc-copy: SKIP (0.000s) [262.567535] [034/162] (855s left) gem_linear_blits (basic) [263.261197] Starting subtest: basic [263.310710] Subtest basic: SUCCESS (0.046s) [263.562921] [035/162] (854s left) gem_mmap (basic) [263.985213] Starting subtest: basic [264.003539] Subtest basic: SUCCESS (0.003s) [264.210499] [036/162] (853s left) gem_mmap_gtt (basic) [264.449233] Starting subtest: basic [264.451859] Subtest basic: SUCCESS (0.005s) [264.667469] [037/162] (853s left) gem_render_linear_blits (basic) [265.017531] Starting subtest: basic [265.280578] Subtest basic: SUCCESS (0.258s) [265.512162] [038/162] (852s left) gem_render_tiled_blits (basic) [265.774118] Starting subtest: basic [265.983888] Subtest basic: SUCCESS (0.210s) [266.225291] [039/162] (852s left) gem_ringfill (basic-all) [266.739155] Starting subtest: basic-all [268.153727] Subtest basic-all: SUCCESS (1.414s) [268.395771] [040/162] (850s left) gem_softpin (allocator-basic) [268.664306] Starting subtest: allocator-basic [269.090826] Subtest allocator-basic: SUCCESS (0.423s) [269.374533] [041/162] (849s left) gem_softpin (allocator-basic-reserve) [269.637806] Starting subtest: allocator-basic-reserve [270.082233] Subtest allocator-basic-reserve: SUCCESS (0.432s) [270.378737] [042/162] (849s left) gem_softpin (safe-alignment) [270.652269] Starting subtest: safe-alignment [270.714405] Subtest safe-alignment: SUCCESS (0.060s) [270.943955] [043/162] (848s left) gem_sync (basic-all) [271.235620] Starting subtest: basic-all [274.794383] Subtest basic-all: SUCCESS (3.556s) [275.151844] [044/162] (844s left) gem_sync (basic-each) [275.447476] Starting subtest: basic-each [278.114444] Subtest basic-each: SUCCESS (2.669s) [278.469415] [045/162] (841s left) gem_tiled_blits (basic) [279.009166] Starting subtest: basic [279.103833] Subtest basic: SUCCESS (0.091s) [279.347484] [046/162] (840s left) gem_tiled_fence_blits (basic) [280.321114] Starting subtest: basic [280.398778] Subtest basic: SUCCESS (0.077s) [280.676359] [047/162] (839s left) gem_tiled_pread_basic (basic) [281.079172] Starting subtest: basic [282.245213] Subtest basic: SUCCESS (1.164s) [282.465251] [048/162] (838s left) gem_wait (busy@all-engines) [282.781290] Starting subtest: busy [282.783733] Starting dynamic subtest: all-engines [283.311900] Dynamic subtest all-engines: SUCCESS (0.537s) [283.313815] Subtest busy: SUCCESS (0.538s) [283.753929] [049/162] (837s left) gem_wait (wait@all-engines) [284.066385] Starting subtest: wait [284.069648] Starting dynamic subtest: all-engines [285.118258] Dynamic subtest all-engines: SUCCESS (1.054s) [285.123195] Subtest wait: SUCCESS (1.056s) [285.555311] [050/162] (835s left) i915_getparams_basic (basic-eu-total) [285.784230] Starting subtest: basic-eu-total [285.791702] Subtest basic-eu-total: SUCCESS (0.000s) [286.001761] [051/162] (835s left) i915_getparams_basic (basic-subslice-total) [286.234187] Starting subtest: basic-subslice-total [286.239278] Subtest basic-subslice-total: SUCCESS (0.000s) [286.449699] [052/162] (835s left) i915_hangman (error-state-basic) [286.741165] Starting subtest: error-state-basic [286.788831] Subtest error-state-basic: SUCCESS (0.036s) [287.075720] [053/162] (834s left) i915_pciid [287.530311] [054/162] (834s left) intel_hwmon (hwmon-read) [287.769260] Subtest hwmon-read: SKIP (0.000s) [287.995616] [055/162] (834s left) intel_hwmon (hwmon-write) [288.237116] Subtest hwmon-write: SKIP (0.000s) [288.451615] [056/162] (834s left) kms_addfb_basic (addfb25-4-tiled) [289.183719] Starting subtest: addfb25-4-tiled [289.186729] Subtest addfb25-4-tiled: SUCCESS (0.004s) [289.420134] [057/162] (833s left) kms_addfb_basic (addfb25-bad-modifier) [289.972318] Starting subtest: addfb25-bad-modifier [289.975285] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [290.231312] [058/162] (832s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [290.813151] Starting subtest: addfb25-framebuffer-vs-set-tiling [290.817272] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [291.040244] [059/162] (832s left) kms_addfb_basic (addfb25-modifier-no-flag) [291.661873] Starting subtest: addfb25-modifier-no-flag [291.667475] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [291.893837] [060/162] (831s left) kms_addfb_basic (addfb25-x-tiled-legacy) [292.431508] Starting subtest: addfb25-x-tiled-legacy [292.433393] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [292.665253] [061/162] (830s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [293.224436] Starting subtest: addfb25-x-tiled-mismatch-legacy [293.231444] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [293.459187] [062/162] (830s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [294.069873] Starting subtest: addfb25-yf-tiled-legacy [294.073824] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s) [294.313453] [063/162] (829s left) kms_addfb_basic (addfb25-y-tiled-legacy) [294.972181] Starting subtest: addfb25-y-tiled-legacy [294.979158] Subtest addfb25-y-tiled-legacy: SUCCESS (0.005s) [295.386180] [064/162] (829s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [296.005885] Starting subtest: addfb25-y-tiled-small-legacy [296.012752] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [296.235700] [065/162] (828s left) kms_addfb_basic (bad-pitch-0) [296.464197] Starting subtest: bad-pitch-0 [296.467266] Subtest bad-pitch-0: SUCCESS (0.000s) [297.029954] [066/162] (827s left) kms_addfb_basic (bad-pitch-1024) [297.265144] Starting subtest: bad-pitch-1024 [297.268781] Subtest bad-pitch-1024: SUCCESS (0.000s) [297.875187] [067/162] (827s left) kms_addfb_basic (bad-pitch-128) [298.120345] Starting subtest: bad-pitch-128 [298.124146] Subtest bad-pitch-128: SUCCESS (0.000s) [298.704307] [068/162] (826s left) kms_addfb_basic (bad-pitch-256) [298.953183] Starting subtest: bad-pitch-256 [298.956291] Subtest bad-pitch-256: SUCCESS (0.000s) [299.452259] [069/162] (826s left) kms_addfb_basic (bad-pitch-32) [299.700941] Starting subtest: bad-pitch-32 [299.704208] Subtest bad-pitch-32: SUCCESS (0.000s) [300.279281] [070/162] (825s left) kms_addfb_basic (bad-pitch-63) [300.592201] Starting subtest: bad-pitch-63 [300.594834] Subtest bad-pitch-63: SUCCESS (0.000s) [301.216701] [071/162] (824s left) kms_addfb_basic (bad-pitch-65536) [301.467924] Starting subtest: bad-pitch-65536 [301.470956] Subtest bad-pitch-65536: SUCCESS (0.002s) [302.052937] [072/162] (824s left) kms_addfb_basic (bad-pitch-999) [302.288439] Starting subtest: bad-pitch-999 [302.290388] Subtest bad-pitch-999: SUCCESS (0.000s) [302.860570] [073/162] (823s left) kms_addfb_basic (basic) [303.097352] Starting subtest: basic [303.101919] Subtest basic: SUCCESS (0.001s) [303.609879] [074/162] (823s left) kms_addfb_basic (basic-x-tiled-legacy) [303.851564] Starting subtest: basic-x-tiled-legacy [303.853689] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [304.458362] [075/162] (822s left) kms_addfb_basic (basic-y-tiled-legacy) [304.701217] Starting subtest: basic-y-tiled-legacy [304.704253] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [305.240301] [076/162] (821s left) kms_addfb_basic (bo-too-small) [305.831845] Starting subtest: bo-too-small [305.836361] Subtest bo-too-small: SUCCESS (0.003s) [306.061457] [077/162] (821s left) kms_addfb_basic (bo-too-small-due-to-tiling) [306.638470] Starting subtest: bo-too-small-due-to-tiling [306.642254] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [306.872183] [078/162] (820s left) kms_addfb_basic (clobberred-modifier) [307.110409] Starting subtest: clobberred-modifier [307.114120] Subtest clobberred-modifier: SUCCESS (0.000s) [307.711740] [079/162] (820s left) kms_addfb_basic (framebuffer-vs-set-tiling) [307.964228] Starting subtest: framebuffer-vs-set-tiling [307.968373] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [308.591708] [080/162] (819s left) kms_addfb_basic (invalid-get-prop) [308.825158] Starting subtest: invalid-get-prop [308.829139] Subtest invalid-get-prop: SUCCESS (0.000s) [309.431895] [081/162] (818s left) kms_addfb_basic (invalid-get-prop-any) [309.669785] Starting subtest: invalid-get-prop-any [309.672826] Subtest invalid-get-prop-any: SUCCESS (0.000s) [310.360723] [082/162] (818s left) kms_addfb_basic (invalid-set-prop) [310.597661] Starting subtest: invalid-set-prop [310.602180] Subtest invalid-set-prop: SUCCESS (0.000s) [311.153861] [083/162] (817s left) kms_addfb_basic (invalid-set-prop-any) [311.398296] Starting subtest: invalid-set-prop-any [311.401288] Subtest invalid-set-prop-any: SUCCESS (0.000s) [311.942627] [084/162] (817s left) kms_addfb_basic (no-handle) [312.179174] Starting subtest: no-handle [312.181262] Subtest no-handle: SUCCESS (0.000s) [312.763463] [085/162] (816s left) kms_addfb_basic (size-max) [313.318375] Starting subtest: size-max [313.321715] Subtest size-max: SUCCESS (0.002s) [313.561671] [086/162] (815s left) kms_addfb_basic (small-bo) [314.090329] Starting subtest: small-bo [314.093767] Subtest small-bo: SUCCESS (0.000s) [314.324390] [087/162] (815s left) kms_addfb_basic (tile-pitch-mismatch) [314.574486] Starting subtest: tile-pitch-mismatch [314.577140] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [315.156625] [088/162] (814s left) kms_addfb_basic (too-high) [315.754245] Starting subtest: too-high [315.759179] Subtest too-high: SUCCESS (0.005s) [315.983998] [089/162] (814s left) kms_addfb_basic (too-wide) [316.567202] Starting subtest: too-wide [316.570977] Subtest too-wide: SUCCESS (0.000s) [316.788981] [090/162] (813s left) kms_addfb_basic (unused-handle) [317.034569] Starting subtest: unused-handle [317.038262] Subtest unused-handle: SUCCESS (0.000s) [317.580928] [091/162] (813s left) kms_addfb_basic (unused-modifier) [317.816739] Starting subtest: unused-modifier [317.819706] Subtest unused-modifier: SUCCESS (0.000s) [318.412771] [092/162] (812s left) kms_addfb_basic (unused-offsets) [318.652147] Starting subtest: unused-offsets [318.655802] Subtest unused-offsets: SUCCESS (0.000s) [319.203337] [093/162] (811s left) kms_addfb_basic (unused-pitches) [319.428476] Starting subtest: unused-pitches [319.432251] Subtest unused-pitches: SUCCESS (0.000s) [320.009763] [094/162] (811s left) kms_busy (basic) [320.644169] Subtest basic: SKIP (0.000s) [320.862752] [095/162] (810s left) kms_prop_blob (basic) [321.150955] Starting subtest: basic [321.155480] Subtest basic: SUCCESS (0.000s) [321.367841] [096/162] (810s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [322.009531] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [322.221161] [097/162] (809s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [322.951170] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [323.322552] [098/162] (808s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [323.974647] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [324.189866] [099/162] (808s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [324.768201] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [325.105918] [100/162] (807s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [325.740534] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [325.949981] [101/162] (807s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [326.531563] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [326.746416] [102/162] (806s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [327.352581] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [327.570172] [103/162] (805s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [328.175402] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [328.393337] [104/162] (805s left) kms_dsc (dsc-basic) [328.970312] Subtest dsc-basic: SKIP (0.000s) [329.186276] [105/162] (804s left) kms_flip (basic-flip-vs-dpms) [329.792777] Starting subtest: basic-flip-vs-dpms [329.803755] Subtest basic-flip-vs-dpms: SKIP (0.012s) [330.089583] [106/162] (804s left) kms_flip (basic-flip-vs-modeset) [330.736922] Starting subtest: basic-flip-vs-modeset [330.750106] Subtest basic-flip-vs-modeset: SKIP (0.008s) [331.033610] [107/162] (803s left) kms_flip (basic-flip-vs-wf_vblank) [331.710220] Starting subtest: basic-flip-vs-wf_vblank [331.726555] Subtest basic-flip-vs-wf_vblank: SKIP (0.008s) [331.988847] [108/162] (802s left) kms_flip (basic-plain-flip) [332.601646] Starting subtest: basic-plain-flip [332.617596] Subtest basic-plain-flip: SKIP (0.012s) [332.904576] [109/162] (801s left) kms_force_connector_basic (force-connector-state) [333.270455] Starting subtest: force-connector-state [334.099743] Subtest force-connector-state: SUCCESS (0.829s) [334.632930] [110/162] (800s left) kms_force_connector_basic (force-edid) [335.010565] Starting subtest: force-edid [335.610507] Subtest force-edid: SUCCESS (0.598s) [336.896636] [111/162] (798s left) kms_force_connector_basic (force-load-detect) [337.287239] Starting subtest: force-load-detect [337.290757] Subtest force-load-detect: SKIP (0.000s) [337.813187] [112/162] (797s left) kms_force_connector_basic (prune-stale-modes) [338.204122] Starting subtest: prune-stale-modes [338.557581] Subtest prune-stale-modes: SUCCESS (0.356s) [339.352754] [113/162] (796s left) kms_frontbuffer_tracking (basic) [339.970446] Subtest basic: SKIP (0.000s) [340.378994] [114/162] (795s left) kms_hdmi_inject (inject-audio) [340.624911] Starting subtest: inject-audio [341.337179] Subtest inject-audio: SUCCESS (0.703s) [341.954902] [115/162] (794s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [342.583158] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [342.823777] [116/162] (793s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [343.438799] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [343.669923] [117/162] (793s left) kms_pipe_crc_basic (hang-read-crc) [344.275354] Subtest hang-read-crc: SKIP (0.000s) [344.503192] [118/162] (792s left) kms_pipe_crc_basic (nonblocking-crc) [345.061623] Subtest nonblocking-crc: SKIP (0.000s) [345.323433] [119/162] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [345.953985] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [346.187989] [120/162] (791s left) kms_pipe_crc_basic (read-crc) [346.716589] Subtest read-crc: SKIP (0.000s) [346.948362] [121/162] (790s left) kms_pipe_crc_basic (read-crc-frame-sequence) [347.470892] Subtest read-crc-frame-sequence: SKIP (0.000s) [347.710371] [122/162] (790s left) kms_pm_backlight (basic-brightness) [348.300198] Subtest basic-brightness: SKIP (0.000s) [348.525717] [123/162] (789s left) kms_pm_rpm (basic-pci-d3-state) [350.378635] Starting subtest: basic-pci-d3-state [350.628865] Subtest basic-pci-d3-state: SUCCESS (0.249s) [350.869366] [124/162] (787s left) kms_pm_rpm (basic-rte) [351.104421] Starting subtest: basic-rte [352.857905] Subtest basic-rte: SUCCESS (1.753s) [353.335418] [125/162] (785s left) kms_psr (psr-primary-page-flip) [353.926332] Subtest psr-primary-page-flip: SKIP (0.000s) [354.185402] [126/162] (784s left) kms_psr (psr-cursor-plane-move) [354.813541] Subtest psr-cursor-plane-move: SKIP (0.000s) [355.184868] [127/162] (784s left) kms_psr (psr-sprite-plane-onoff) [355.806277] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [356.056742] [128/162] (783s left) kms_psr (psr-primary-mmap-gtt) [356.630168] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [356.878425] [129/162] (782s left) kms_setmode (basic-clone-single-crtc) [357.119231] Starting subtest: basic-clone-single-crtc [357.128988] Subtest basic-clone-single-crtc: SKIP (0.000s) [357.367478] [130/162] (782s left) i915_pm_rps (basic-api) [357.687588] Starting subtest: basic-api [357.712102] Subtest basic-api: SUCCESS (0.024s) [357.976694] [131/162] (782s left) prime_self_import (basic-llseek-bad) [358.204780] Starting subtest: basic-llseek-bad [358.223304] Subtest basic-llseek-bad: SUCCESS (0.016s) [358.465164] [132/162] (781s left) prime_self_import (basic-llseek-size) [358.706490] Starting subtest: basic-llseek-size [358.727594] Subtest basic-llseek-size: SUCCESS (0.027s) [358.968196] [133/162] (781s left) prime_self_import (basic-with_fd_dup) [359.200976] Starting subtest: basic-with_fd_dup [359.223692] Subtest basic-with_fd_dup: SUCCESS (0.024s) [359.472969] [134/162] (781s left) prime_self_import (basic-with_one_bo) [359.689326] Starting subtest: basic-with_one_bo [359.724815] Subtest basic-with_one_bo: SUCCESS (0.034s) [359.977659] [135/162] (781s left) prime_self_import (basic-with_one_bo_two_files) [360.217310] Starting subtest: basic-with_one_bo_two_files [360.239843] Subtest basic-with_one_bo_two_files: SUCCESS (0.023s) [360.493935] [136/162] (780s left) prime_self_import (basic-with_two_bos) [360.723935] Starting subtest: basic-with_two_bos [360.747991] Subtest basic-with_two_bos: SUCCESS (0.026s) [361.007483] [137/162] (780s left) prime_vgem (basic-fence-flip) [361.295190] Starting subtest: basic-fence-flip [361.651286] Subtest basic-fence-flip: SKIP (0.351s) [361.918456] [138/162] (779s left) prime_vgem (basic-fence-mmap) [362.226151] Starting subtest: basic-fence-mmap [362.372412] Subtest basic-fence-mmap: SUCCESS (0.151s) [362.643298] [139/162] (779s left) prime_vgem (basic-fence-read) [362.938572] Starting subtest: basic-fence-read [363.237861] Subtest basic-fence-read: SUCCESS (0.298s) [363.496420] [140/162] (778s left) prime_vgem (basic-gtt) [363.784718] Starting subtest: basic-gtt [363.866423] Subtest basic-gtt: SUCCESS (0.071s) [364.132183] [141/162] (778s left) prime_vgem (basic-read) [364.417183] Starting subtest: basic-read [364.559943] Subtest basic-read: SUCCESS (0.150s) [364.823322] [142/162] (777s left) prime_vgem (basic-write) [365.095998] Starting subtest: basic-write [365.276765] Subtest basic-write: SUCCESS (0.179s) [365.520430] [143/162] (777s left) vgem_basic (setversion) [365.761396] Starting subtest: setversion [365.766120] Subtest setversion: SUCCESS (0.000s) [366.005705] [144/162] (777s left) vgem_basic (create) [366.247181] Starting subtest: create [366.249914] Subtest create: SUCCESS (0.002s) [366.496677] [145/162] (776s left) vgem_basic (debugfs) [366.745937] Starting subtest: debugfs [366.751802] Subtest debugfs: SUCCESS (0.003s) [366.996640] [146/162] (776s left) vgem_basic (dmabuf-export) [367.236252] Starting subtest: dmabuf-export [367.250742] Subtest dmabuf-export: SUCCESS (0.012s) [367.487286] [147/162] (776s left) vgem_basic (dmabuf-fence) [367.737818] Starting subtest: dmabuf-fence [367.741470] Subtest dmabuf-fence: SUCCESS (0.008s) [367.974502] [148/162] (776s left) vgem_basic (dmabuf-fence-before) [368.224220] Starting subtest: dmabuf-fence-before [368.226812] Subtest dmabuf-fence-before: SUCCESS (0.003s) [368.471478] [149/162] (775s left) vgem_basic (dmabuf-mmap) [368.717479] Starting subtest: dmabuf-mmap [368.797350] Subtest dmabuf-mmap: SUCCESS (0.091s) [369.030456] [150/162] (775s left) vgem_basic (mmap) [369.270421] Starting subtest: mmap [369.312974] Subtest mmap: SUCCESS (0.050s) [369.546789] [151/162] (775s left) vgem_basic (second-client) [369.794277] Starting subtest: second-client [369.807206] Subtest second-client: SUCCESS (0.018s) [370.073583] [152/162] (774s left) vgem_basic (sysfs) [370.316313] Starting subtest: sysfs [370.320097] Subtest sysfs: SUCCESS (0.003s) [370.565097] [153/162] (774s left) core_hotunplug (unbind-rebind) [371.002524] Starting subtest: unbind-rebind [377.695909] Subtest unbind-rebind: SUCCESS (6.689s) [377.925877] [154/162] (767s left) vgem_basic (unload) [378.157565] Starting subtest: unload [407.473443] Subtest unload: SUCCESS (29.313s) [407.847813] [155/162] (737s left) i915_module_load (reload) [408.072864] Starting subtest: reload [418.017731] Subtest reload: SUCCESS (9.920s) [418.293894] [156/162] (727s left) gem_lmem_swapping (basic) [418.632290] Subtest basic: SKIP (0.000s) [418.850547] [157/162] (727s left) gem_lmem_swapping (parallel-random-engines) [419.126900] Subtest parallel-random-engines: SKIP (0.000s) [419.366326] [158/162] (726s left) gem_lmem_swapping (random-engines) [419.646898] Subtest random-engines: SKIP (0.000s) [419.854673] [159/162] (726s left) gem_lmem_swapping (verify-random) [420.121559] Subtest verify-random: SKIP (0.000s) [420.338877] [160/162] (726s left) i915_pm_rpm (module-reload) [422.290206] Starting subtest: module-reload [445.374642] Subtest module-reload: SUCCESS (23.083s) [445.550648] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [445.556619] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [445.563626] [161/162] (701s left) i915_selftest (live) [445.827279] Starting subtest: live [445.829695] Starting dynamic subtest: sanitycheck [453.299411] Dynamic subtest sanitycheck: SUCCESS (7.474s) [453.342374] Starting dynamic subtest: uncore [460.612280] Dynamic subtest uncore: SUCCESS (7.307s) [460.719411] Starting dynamic subtest: workarounds [468.311340] Dynamic subtest workarounds: SUCCESS (7.691s) [468.356486] Starting dynamic subtest: gt_engines [475.934519] Dynamic subtest gt_engines: SUCCESS (7.620s) [476.002535] Starting dynamic subtest: gt_timelines [516.208173] Dynamic subtest gt_timelines: SUCCESS (40.260s) [516.255060] Starting dynamic subtest: gt_contexts [524.087832] Dynamic subtest gt_contexts: SUCCESS (7.870s) [524.128155] Starting dynamic subtest: gt_lrc [535.096863] Dynamic subtest gt_lrc: SUCCESS (11.004s) [535.197345] Starting dynamic subtest: gt_mocs [542.212778] Dynamic subtest gt_mocs: SUCCESS (7.106s) [542.254359] Starting dynamic subtest: gt_pm [550.975347] Dynamic subtest gt_pm: SUCCESS (8.758s) [551.077657] Starting dynamic subtest: gt_heartbeat [558.229401] Dynamic subtest gt_heartbeat: SUCCESS (7.247s) [558.273177] Starting dynamic subtest: gt_tlb [566.365622] Dynamic subtest gt_tlb: SUCCESS (8.128s) [566.448488] Starting dynamic subtest: requests [580.443206] Dynamic subtest requests: SUCCESS (14.066s) [580.538617] Starting dynamic subtest: migrate [592.506905] Dynamic subtest migrate: SUCCESS (12.057s) [592.555375] Starting dynamic subtest: active [599.682236] Dynamic subtest active: SUCCESS (7.167s) [599.731238] Starting dynamic subtest: objects [608.593504] Dynamic subtest objects: SUCCESS (8.905s) [608.635412] Starting dynamic subtest: mman [623.147070] Dynamic subtest mman: SUCCESS (14.548s) [623.192167] Starting dynamic subtest: dmabuf [630.724727] Dynamic subtest dmabuf: SUCCESS (7.572s) [630.771337] Starting dynamic subtest: vma [637.970669] Dynamic subtest vma: SUCCESS (7.240s) [638.017207] Starting dynamic subtest: coherency [651.053327] Dynamic subtest coherency: SUCCESS (13.075s) [651.103506] Starting dynamic subtest: gtt [666.812585] Dynamic subtest gtt: SUCCESS (15.754s) [666.862353] Starting dynamic subtest: gem [675.304241] Dynamic subtest gem: SUCCESS (8.480s) [675.348052] Starting dynamic subtest: evict [691.696199] Dynamic subtest evict: SUCCESS (16.388s) [691.741925] Starting dynamic subtest: hugepages [700.139531] Dynamic subtest hugepages: SUCCESS (8.427s) [700.263224] Starting dynamic subtest: gem_contexts [736.684573] Dynamic subtest gem_contexts: SUCCESS (36.540s) [736.730306] Starting dynamic subtest: client [744.004275] Dynamic subtest client: SUCCESS (7.314s) [744.053552] Starting dynamic subtest: gem_migrate [751.106831] Dynamic subtest gem_migrate: SUCCESS (7.093s) [751.154769] Starting dynamic subtest: reset [766.978575] Dynamic subtest reset: SUCCESS (15.862s) [767.030525] Starting dynamic subtest: memory_region [774.204056] Dynamic subtest memory_region: SUCCESS (7.216s) [774.251731] Starting dynamic subtest: hangcheck [805.207863] Dynamic subtest hangcheck: SUCCESS (30.997s) [805.348845] Starting dynamic subtest: execlists [819.251353] Dynamic subtest execlists: SUCCESS (14.029s) [819.301535] Starting dynamic subtest: ring_submission [826.499280] Dynamic subtest ring_submission: SUCCESS (7.237s) [826.542534] Starting dynamic subtest: perf [834.578290] Dynamic subtest perf: SUCCESS (8.075s) [834.626305] Starting dynamic subtest: slpc [841.733946] Dynamic subtest slpc: SUCCESS (7.148s) [841.780956] Starting dynamic subtest: guc [849.133166] Dynamic subtest guc: SUCCESS (7.391s) [849.200537] Starting dynamic subtest: guc_multi_lrc [856.172522] Dynamic subtest guc_multi_lrc: SUCCESS (7.035s) [856.298107] Starting dynamic subtest: guc_hang [863.211255] Dynamic subtest guc_hang: SUCCESS (7.027s) [863.260039] Starting dynamic subtest: late_gt_pm [870.713463] Dynamic subtest late_gt_pm: SUCCESS (7.491s) [870.715239] Subtest live: SUCCESS (424.882s) [870.888922] [162/162] (276s left) dmabuf (all-tests) [871.141119] Starting subtest: all-tests [871.145724] Subtest all-tests: SKIP (0.000s) [871.300224] 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.