[43.614491] Initializing watchdogs [43.614689] /dev/watchdog0 [43.639881] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0162 Intel Ivybridge (Gen7) IvyBridge GT2 [HD Graphics 4000] [43.665979] [001/162] (960s left) i915_module_load (load) [43.842828] Starting subtest: load [45.580659] Subtest load: SUCCESS (1.735s) [45.686259] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [45.687764] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [45.711989] [002/162] (958s left) core_auth (basic-auth) [45.869668] Starting subtest: basic-auth [45.888999] Subtest basic-auth: SUCCESS (0.001s) [46.028786] [003/162] (958s left) core_debugfs (read-all-entries) [46.197079] Starting subtest: read-all-entries [46.218327] Subtest read-all-entries: SUCCESS (0.069s) [46.370702] [004/162] (958s left) core_sysfs (read-all-entries) [46.525591] Starting subtest: read-all-entries [46.544918] Subtest read-all-entries: SUCCESS (0.003s) [46.691607] [005/162] (958s left) fbdev (eof) [46.840673] Starting subtest: eof [46.861320] Subtest eof: SUCCESS (0.001s) [47.001174] [006/162] (957s left) fbdev (info) [47.104133] Starting subtest: info [47.125874] Subtest info: SUCCESS (0.000s) [47.266264] [007/162] (957s left) fbdev (nullptr) [47.418498] Starting subtest: nullptr [47.439462] Subtest nullptr: SUCCESS (0.000s) [47.571348] [008/162] (957s left) fbdev (read) [47.719103] Starting subtest: read [47.833911] Subtest read: SUCCESS (0.139s) [47.979905] [009/162] (957s left) fbdev (write) [48.102367] Starting subtest: write [48.168359] Subtest write: SUCCESS (0.071s) [48.334276] [010/162] (956s left) gem_basic (bad-close) [48.461854] Starting subtest: bad-close [48.504333] Subtest bad-close: SUCCESS (0.000s) [48.648306] [011/162] (956s left) gem_basic (create-close) [48.782909] Starting subtest: create-close [48.821511] Subtest create-close: SUCCESS (0.000s) [48.959169] [012/162] (956s left) gem_basic (create-fd-close) [49.101901] Starting subtest: create-fd-close [49.146317] Subtest create-fd-close: SUCCESS (0.000s) [49.282682] [013/162] (956s left) gem_busy (busy@all-engines) [49.456025] Starting subtest: busy [49.475627] Starting dynamic subtest: all-engines [49.495114] Dynamic subtest all-engines: SUCCESS (0.026s) [49.514322] Subtest busy: SUCCESS (0.026s) [49.870473] [014/162] (955s left) gem_close_race (basic-process) [50.023252] Starting subtest: basic-process [50.047110] Subtest basic-process: SUCCESS (0.044s) [50.335549] [015/162] (955s left) gem_close_race (basic-threads) [50.507059] Starting subtest: basic-threads [51.664705] Subtest basic-threads: SUCCESS (1.189s) [51.938111] [016/162] (954s left) gem_ctx_create (basic) [52.091181] Starting subtest: basic [52.110242] Subtest basic: SUCCESS (0.000s) [52.340154] [017/162] (953s left) gem_ctx_create (basic-files) [52.493811] Starting subtest: basic-files [54.502988] Subtest basic-files: SUCCESS (2.014s) [54.968979] [018/162] (951s left) gem_ctx_exec (basic) [55.129879] Starting subtest: basic [55.149153] Subtest basic: SUCCESS (0.003s) [55.303491] [019/162] (951s left) gem_exec_basic (basic) [55.485433] Starting subtest: basic [55.505990] Starting dynamic subtest: rcs0-smem [55.528018] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [55.558069] Starting dynamic subtest: bcs0-smem [55.579650] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [55.613322] Starting dynamic subtest: vcs0-smem [55.632776] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [55.652329] Subtest basic: SUCCESS (0.003s) [55.788572] [020/162] (950s left) gem_exec_create (basic) [55.958014] Starting subtest: basic [55.979119] Starting dynamic subtest: smem [57.986199] Dynamic subtest smem: SUCCESS (2.055s) [58.005865] Subtest basic: SUCCESS (2.056s) [58.247974] [021/162] (948s left) gem_exec_fence (basic-busy) [58.493879] Starting subtest: basic-busy [58.513457] Starting dynamic subtest: rcs0 [58.554852] Dynamic subtest rcs0: SUCCESS (0.024s) [58.595576] Starting dynamic subtest: bcs0 [58.638228] Dynamic subtest bcs0: SUCCESS (0.034s) [58.674528] Starting dynamic subtest: vcs0 [58.711917] Dynamic subtest vcs0: SUCCESS (0.035s) [58.730524] Subtest basic-busy: SUCCESS (0.095s) [59.160730] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [59.190600] [022/162] (947s left) gem_exec_fence (basic-wait) [59.439483] Starting subtest: basic-wait [59.459238] Starting dynamic subtest: rcs0 [59.478740] Dynamic subtest rcs0: SUCCESS (0.038s) [59.514926] Starting dynamic subtest: bcs0 [59.536715] Dynamic subtest bcs0: SUCCESS (0.043s) [59.576439] Starting dynamic subtest: vcs0 [59.598621] Dynamic subtest vcs0: SUCCESS (0.060s) [59.620126] Subtest basic-wait: SUCCESS (0.144s) [60.108591] [023/162] (946s left) gem_exec_fence (basic-await) [60.354962] Starting subtest: basic-await [60.377169] Starting dynamic subtest: rcs0 [60.417742] Dynamic subtest rcs0: SUCCESS (0.070s) [60.444926] Starting dynamic subtest: bcs0 [60.482073] Dynamic subtest bcs0: SUCCESS (0.068s) [60.512408] Starting dynamic subtest: vcs0 [60.569776] Dynamic subtest vcs0: SUCCESS (0.070s) [60.589706] Subtest basic-await: SUCCESS (0.209s) [61.087137] [024/162] (946s left) gem_exec_fence (nb-await) [61.341803] Starting subtest: nb-await [61.362044] Starting dynamic subtest: rcs0 [61.380166] Dynamic subtest rcs0: SUCCESS (0.053s) [61.406734] Starting dynamic subtest: bcs0 [61.443357] Dynamic subtest bcs0: SUCCESS (0.052s) [61.472174] Starting dynamic subtest: vcs0 [61.493619] Dynamic subtest vcs0: SUCCESS (0.052s) [61.514191] Subtest nb-await: SUCCESS (0.159s) [62.025854] [025/162] (945s left) gem_exec_gttfill (basic) [62.175692] Starting subtest: basic [64.254092] Subtest basic: SUCCESS (2.100s) [64.524558] [026/162] (942s left) gem_exec_parallel (engines) [64.767402] Starting subtest: engines [64.785826] Starting dynamic subtest: basic [66.380891] Dynamic subtest basic: SUCCESS (1.632s) [66.412332] Starting dynamic subtest: contexts [67.962372] Dynamic subtest contexts: SUCCESS (1.588s) [67.992519] Starting dynamic subtest: fds [69.672741] Dynamic subtest fds: SUCCESS (1.706s) [69.705710] Starting dynamic subtest: userptr [71.346819] Dynamic subtest userptr: SUCCESS (1.673s) [71.366312] Subtest engines: SUCCESS (6.602s) [71.630058] [027/162] (935s left) gem_exec_store (basic) [71.857396] Starting subtest: basic [71.876958] Subtest basic: SUCCESS (0.038s) [72.077340] [028/162] (935s left) gem_flink_basic (bad-flink) [72.241514] Starting subtest: bad-flink [72.262790] Subtest bad-flink: SUCCESS (0.000s) [72.403132] [029/162] (935s left) gem_flink_basic (bad-open) [72.552246] Starting subtest: bad-open [72.571916] Subtest bad-open: SUCCESS (0.000s) [72.708586] [030/162] (935s left) gem_flink_basic (basic) [72.856141] Starting subtest: basic [72.875573] Subtest basic: SUCCESS (0.000s) [73.017612] [031/162] (935s left) gem_flink_basic (double-flink) [73.162187] Starting subtest: double-flink [73.184260] Subtest double-flink: SUCCESS (0.000s) [73.330670] [032/162] (934s left) gem_flink_basic (flink-lifetime) [73.477099] Starting subtest: flink-lifetime [73.498474] Subtest flink-lifetime: SUCCESS (0.001s) [73.640430] [033/162] (934s left) gem_huc_copy (huc-copy) [73.812797] Subtest huc-copy: SKIP (0.000s) [73.953945] [034/162] (934s left) gem_linear_blits (basic) [74.140689] Starting subtest: basic [74.163933] Subtest basic: SUCCESS (0.006s) [74.381649] [035/162] (934s left) gem_mmap (basic) [74.689521] Starting subtest: basic [74.787103] Subtest basic: SUCCESS (0.000s) [74.932081] [036/162] (933s left) gem_mmap_gtt (basic) [75.085565] Starting subtest: basic [75.107748] Subtest basic: SUCCESS (0.001s) [75.248543] [037/162] (933s left) gem_render_linear_blits (basic) [75.416376] Starting subtest: basic [75.516108] Subtest basic: SUCCESS (0.017s) [75.660790] [038/162] (933s left) gem_render_tiled_blits (basic) [75.831966] Starting subtest: basic [75.953711] Subtest basic: SUCCESS (0.023s) [76.097249] [039/162] (933s left) gem_ringfill (basic-all) [76.368532] Starting subtest: basic-all [77.453691] Subtest basic-all: SUCCESS (1.108s) [77.637678] [040/162] (931s left) gem_softpin (allocator-basic) [77.810421] Subtest allocator-basic: SKIP (0.000s) [77.975680] [041/162] (931s left) gem_softpin (allocator-basic-reserve) [78.146435] Subtest allocator-basic-reserve: SKIP (0.000s) [78.317348] [042/162] (931s left) gem_softpin (safe-alignment) [78.511879] Starting subtest: safe-alignment [78.531539] Subtest safe-alignment: SUCCESS (0.006s) [78.672622] [043/162] (931s left) gem_sync (basic-all) [78.862854] Starting subtest: basic-all [80.890158] Subtest basic-all: SUCCESS (2.072s) [81.158657] [044/162] (928s left) gem_sync (basic-each) [81.341853] Starting subtest: basic-each [83.465300] Subtest basic-each: SUCCESS (2.187s) [83.744800] [045/162] (926s left) gem_tiled_blits (basic) [83.943273] Starting subtest: basic [83.964930] Subtest basic: SUCCESS (0.008s) [84.144624] [046/162] (925s left) gem_tiled_fence_blits (basic) [84.430922] Starting subtest: basic [84.453332] Subtest basic: SUCCESS (0.006s) [84.635041] [047/162] (925s left) gem_tiled_pread_basic [85.123659] [048/162] (925s left) gem_wait (busy@all-engines) [85.271746] Starting subtest: busy [85.292657] Starting dynamic subtest: all-engines [85.776096] Dynamic subtest all-engines: SUCCESS (0.516s) [85.795181] Subtest busy: SUCCESS (0.517s) [86.072086] [049/162] (924s left) gem_wait (wait@all-engines) [86.226869] Starting subtest: wait [86.246820] Starting dynamic subtest: all-engines [87.220134] Dynamic subtest all-engines: SUCCESS (1.022s) [87.241417] Subtest wait: SUCCESS (1.022s) [87.504631] [050/162] (923s left) i915_getparams_basic (basic-eu-total) [87.657170] Starting subtest: basic-eu-total [87.695781] Subtest basic-eu-total: SUCCESS (0.000s) [87.837846] [051/162] (922s left) i915_getparams_basic (basic-subslice-total) [87.980181] Starting subtest: basic-subslice-total [88.022552] Subtest basic-subslice-total: SUCCESS (0.000s) [88.166528] [052/162] (922s left) i915_hangman (error-state-basic) [88.297573] Starting subtest: error-state-basic [88.318914] Subtest error-state-basic: SUCCESS (0.006s) [88.464843] [053/162] (922s left) i915_pciid [88.794612] [054/162] (922s left) intel_hwmon (hwmon-read) [88.956332] Subtest hwmon-read: SKIP (0.000s) [89.103480] [055/162] (922s left) intel_hwmon (hwmon-write) [89.266341] Subtest hwmon-write: SKIP (0.000s) [89.412534] [056/162] (922s left) kms_addfb_basic (addfb25-4-tiled) [89.639867] Starting subtest: addfb25-4-tiled [89.659255] Subtest addfb25-4-tiled: SUCCESS (0.000s) [89.815800] [057/162] (921s left) kms_addfb_basic (addfb25-bad-modifier) [89.958943] Starting subtest: addfb25-bad-modifier [89.981043] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [90.131233] [058/162] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [90.285455] Starting subtest: addfb25-framebuffer-vs-set-tiling [90.307052] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [90.447645] [059/162] (921s left) kms_addfb_basic (addfb25-modifier-no-flag) [90.598322] Starting subtest: addfb25-modifier-no-flag [90.616965] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [90.761057] [060/162] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy) [90.901621] Starting subtest: addfb25-x-tiled-legacy [90.923746] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [91.091103] [061/162] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [91.238113] Starting subtest: addfb25-x-tiled-mismatch-legacy [91.260082] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [91.404658] [062/162] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [91.571105] Starting subtest: addfb25-yf-tiled-legacy [91.590783] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [91.734743] [063/162] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy) [91.881596] Starting subtest: addfb25-y-tiled-legacy [91.902593] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [92.105899] [064/162] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [92.255247] Starting subtest: addfb25-y-tiled-small-legacy [92.294738] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [92.442671] [065/162] (920s left) kms_addfb_basic (bad-pitch-0) [92.586445] Starting subtest: bad-pitch-0 [92.605947] Subtest bad-pitch-0: SUCCESS (0.000s) [92.753692] [066/162] (920s left) kms_addfb_basic (bad-pitch-1024) [92.899730] Starting subtest: bad-pitch-1024 [92.921503] Subtest bad-pitch-1024: SUCCESS (0.000s) [93.070953] [067/162] (919s left) kms_addfb_basic (bad-pitch-128) [93.221254] Starting subtest: bad-pitch-128 [93.241600] Subtest bad-pitch-128: SUCCESS (0.000s) [93.395303] [068/162] (919s left) kms_addfb_basic (bad-pitch-256) [93.538468] Starting subtest: bad-pitch-256 [93.558706] Subtest bad-pitch-256: SUCCESS (0.000s) [93.703621] [069/162] (919s left) kms_addfb_basic (bad-pitch-32) [93.846691] Starting subtest: bad-pitch-32 [93.867213] Subtest bad-pitch-32: SUCCESS (0.000s) [94.026750] [070/162] (919s left) kms_addfb_basic (bad-pitch-63) [94.172465] Starting subtest: bad-pitch-63 [94.193886] Subtest bad-pitch-63: SUCCESS (0.000s) [94.341105] [071/162] (919s left) kms_addfb_basic (bad-pitch-65536) [94.491076] Starting subtest: bad-pitch-65536 [94.511503] Subtest bad-pitch-65536: SUCCESS (0.000s) [94.661849] [072/162] (918s left) kms_addfb_basic (bad-pitch-999) [94.825214] Starting subtest: bad-pitch-999 [94.844429] Subtest bad-pitch-999: SUCCESS (0.000s) [94.989544] [073/162] (918s left) kms_addfb_basic (basic) [95.130421] Starting subtest: basic [95.151922] Subtest basic: SUCCESS (0.000s) [95.322779] [074/162] (918s left) kms_addfb_basic (basic-x-tiled-legacy) [95.472615] Starting subtest: basic-x-tiled-legacy [95.492185] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [95.645802] [075/162] (918s left) kms_addfb_basic (basic-y-tiled-legacy) [95.787130] Starting subtest: basic-y-tiled-legacy [95.806232] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [95.978091] [076/162] (918s left) kms_addfb_basic (bo-too-small) [96.125526] Starting subtest: bo-too-small [96.147287] Subtest bo-too-small: SUCCESS (0.000s) [96.303532] [077/162] (917s left) kms_addfb_basic (bo-too-small-due-to-tiling) [96.468792] Starting subtest: bo-too-small-due-to-tiling [96.490819] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [96.646659] [078/162] (917s left) kms_addfb_basic (clobberred-modifier) [96.826020] Starting subtest: clobberred-modifier [96.847502] Subtest clobberred-modifier: SUCCESS (0.000s) [97.003836] [079/162] (917s left) kms_addfb_basic (framebuffer-vs-set-tiling) [97.156263] Starting subtest: framebuffer-vs-set-tiling [97.179981] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [97.333152] [080/162] (917s left) kms_addfb_basic (invalid-get-prop) [97.491637] Starting subtest: invalid-get-prop [97.515373] Subtest invalid-get-prop: SUCCESS (0.000s) [97.666485] [081/162] (917s left) kms_addfb_basic (invalid-get-prop-any) [97.827161] Starting subtest: invalid-get-prop-any [97.848975] Subtest invalid-get-prop-any: SUCCESS (0.000s) [98.010939] [082/162] (916s left) kms_addfb_basic (invalid-set-prop) [98.188401] Starting subtest: invalid-set-prop [98.211895] Subtest invalid-set-prop: SUCCESS (0.000s) [98.368617] [083/162] (916s left) kms_addfb_basic (invalid-set-prop-any) [98.546934] Starting subtest: invalid-set-prop-any [98.568058] Subtest invalid-set-prop-any: SUCCESS (0.000s) [98.711169] [084/162] (916s left) kms_addfb_basic (no-handle) [98.855420] Starting subtest: no-handle [98.874945] Subtest no-handle: SUCCESS (0.000s) [99.028436] [085/162] (916s left) kms_addfb_basic (size-max) [99.191800] Starting subtest: size-max [99.213601] Subtest size-max: SUCCESS (0.000s) [99.358469] [086/162] (916s left) kms_addfb_basic (small-bo) [99.506114] Starting subtest: small-bo [99.526757] Subtest small-bo: SUCCESS (0.000s) [99.677792] [087/162] (915s left) kms_addfb_basic (tile-pitch-mismatch) [99.843795] Starting subtest: tile-pitch-mismatch [99.863169] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [100.010578] [088/162] (915s left) kms_addfb_basic (too-high) [100.155752] Starting subtest: too-high [100.177915] Subtest too-high: SUCCESS (0.001s) [100.330465] [089/162] (915s left) kms_addfb_basic (too-wide) [100.476883] Starting subtest: too-wide [100.498134] Subtest too-wide: SUCCESS (0.000s) [100.647993] [090/162] (915s left) kms_addfb_basic (unused-handle) [100.793333] Starting subtest: unused-handle [100.812685] Subtest unused-handle: SUCCESS (0.000s) [100.967036] [091/162] (915s left) kms_addfb_basic (unused-modifier) [101.106191] Starting subtest: unused-modifier [101.126794] Subtest unused-modifier: SUCCESS (0.000s) [101.283701] [092/162] (914s left) kms_addfb_basic (unused-offsets) [101.452152] Starting subtest: unused-offsets [101.473441] Subtest unused-offsets: SUCCESS (0.000s) [101.615180] [093/162] (914s left) kms_addfb_basic (unused-pitches) [101.761356] Starting subtest: unused-pitches [101.780924] Subtest unused-pitches: SUCCESS (0.000s) [101.933547] [094/162] (914s left) kms_busy (basic) [102.085043] Starting subtest: basic [102.104703] Starting dynamic subtest: flip [105.851183] Dynamic subtest flip: FAIL (0.494s) [105.892685] Starting dynamic subtest: modeset [109.529678] Dynamic subtest modeset: FAIL (4.470s) [109.554370] Subtest basic: FAIL (4.966s) [109.722837] [095/162] (906s left) kms_prop_blob (basic) [109.902102] Starting subtest: basic [109.925302] Subtest basic: SUCCESS (0.000s) [110.100668] [096/162] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [110.285587] Starting subtest: basic-busy-flip-before-cursor-atomic [111.199878] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.920s) [111.454975] [097/162] (905s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [111.598460] Starting subtest: basic-busy-flip-before-cursor-legacy [112.514026] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.929s) [112.773520] [098/162] (904s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [112.941837] Starting subtest: basic-flip-after-cursor-atomic [113.827161] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s) [114.073136] [099/162] (903s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [114.240279] Starting subtest: basic-flip-after-cursor-legacy [115.144214] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.916s) [115.382482] [100/162] (901s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [115.520980] Starting subtest: basic-flip-after-cursor-varying-size [116.432448] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.914s) [116.681593] [101/162] (900s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [116.851177] Starting subtest: basic-flip-before-cursor-atomic [117.733287] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.915s) [117.973456] [102/162] (899s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [118.124078] Starting subtest: basic-flip-before-cursor-legacy [119.014213] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.925s) [119.258546] [103/162] (898s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [119.405531] Starting subtest: basic-flip-before-cursor-varying-size [120.319698] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.921s) [120.578250] [104/162] (897s left) kms_dsc (dsc-basic) [120.750524] Subtest dsc-basic: SKIP (0.000s) [120.896831] [105/162] (897s left) kms_flip (basic-flip-vs-dpms) [121.064341] Starting subtest: basic-flip-vs-dpms [121.086123] Starting dynamic subtest: A-VGA1 [121.992144] Dynamic subtest A-VGA1: SUCCESS (0.952s) [122.039094] Starting dynamic subtest: B-VGA1 [122.914097] Dynamic subtest B-VGA1: SUCCESS (0.913s) [122.942849] Starting dynamic subtest: C-VGA1 [123.719798] Dynamic subtest C-VGA1: SUCCESS (0.802s) [123.738753] Subtest basic-flip-vs-dpms: SUCCESS (2.671s) [123.969558] [106/162] (894s left) kms_flip (basic-flip-vs-modeset) [124.142171] Starting subtest: basic-flip-vs-modeset [124.162650] Starting dynamic subtest: A-VGA1 [125.015088] Dynamic subtest A-VGA1: SUCCESS (0.893s) [125.050824] Starting dynamic subtest: B-VGA1 [125.862696] Dynamic subtest B-VGA1: SUCCESS (0.847s) [125.895909] Starting dynamic subtest: C-VGA1 [126.703146] Dynamic subtest C-VGA1: SUCCESS (0.846s) [126.721404] Subtest basic-flip-vs-modeset: SUCCESS (2.589s) [126.953665] [107/162] (891s left) kms_flip (basic-flip-vs-wf_vblank) [127.130934] Starting subtest: basic-flip-vs-wf_vblank [127.150136] Starting dynamic subtest: A-VGA1 [128.243661] Dynamic subtest A-VGA1: SUCCESS (1.146s) [128.271670] Starting dynamic subtest: B-VGA1 [129.374913] Dynamic subtest B-VGA1: SUCCESS (1.132s) [129.406561] Starting dynamic subtest: C-VGA1 [130.512088] Dynamic subtest C-VGA1: SUCCESS (1.131s) [130.532284] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.416s) [130.774563] [108/162] (887s left) kms_flip (basic-plain-flip) [130.939295] Starting subtest: basic-plain-flip [130.960628] Starting dynamic subtest: A-VGA1 [131.779626] Dynamic subtest A-VGA1: SUCCESS (0.864s) [131.818909] Starting dynamic subtest: B-VGA1 [132.628421] Dynamic subtest B-VGA1: SUCCESS (0.848s) [132.664929] Starting dynamic subtest: C-VGA1 [133.493037] Dynamic subtest C-VGA1: SUCCESS (0.863s) [133.511492] Subtest basic-plain-flip: SUCCESS (2.583s) [133.795273] [109/162] (884s left) kms_force_connector_basic (force-connector-state) [133.993063] Starting subtest: force-connector-state [134.125653] Subtest force-connector-state: SUCCESS (0.170s) [134.427357] [110/162] (884s left) kms_force_connector_basic (force-edid) [134.626216] Starting subtest: force-edid [134.648471] Subtest force-edid: SUCCESS (0.024s) [134.819829] [111/162] (884s left) kms_force_connector_basic (force-load-detect) [135.013174] Starting subtest: force-load-detect [135.166129] Subtest force-load-detect: SUCCESS (0.182s) [135.451438] [112/162] (883s left) kms_force_connector_basic (prune-stale-modes) [135.643599] Starting subtest: prune-stale-modes [135.665371] Subtest prune-stale-modes: SUCCESS (0.019s) [135.817863] [113/162] (883s left) kms_frontbuffer_tracking (basic) [136.031513] Starting subtest: basic [137.897040] Subtest basic: SUCCESS (1.926s) [138.095808] [114/162] (881s left) kms_hdmi_inject (inject-audio) [138.259375] Starting subtest: inject-audio [138.298363] Subtest inject-audio: SKIP (0.000s) [138.474875] [115/162] (880s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [138.629706] Starting subtest: compare-crc-sanitycheck-xr24 [138.650973] Starting dynamic subtest: pipe-A-VGA-1 [138.881173] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.277s) [138.911762] Starting dynamic subtest: pipe-B-VGA-1 [139.154739] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.265s) [139.190170] Starting dynamic subtest: pipe-C-VGA-1 [139.419957] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.268s) [139.439344] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.814s) [139.667257] [116/162] (879s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [139.808269] Starting subtest: compare-crc-sanitycheck-nv12 [139.829283] Starting dynamic subtest: pipe-A-VGA-1 [139.872836] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [139.916530] Starting dynamic subtest: pipe-B-VGA-1 [139.956418] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [139.997081] Starting dynamic subtest: pipe-C-VGA-1 [140.037266] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [140.081247] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s) [140.226757] [117/162] (879s left) kms_pipe_crc_basic (hang-read-crc) [140.393883] Starting subtest: hang-read-crc [140.413481] Starting dynamic subtest: pipe-A-VGA-1 [141.151580] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.786s) [141.185286] Starting dynamic subtest: pipe-B-VGA-1 [141.922726] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.766s) [141.954594] Starting dynamic subtest: pipe-C-VGA-1 [142.691530] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.768s) [142.712830] Subtest hang-read-crc: SUCCESS (2.324s) [142.913627] [118/162] (876s left) kms_pipe_crc_basic (nonblocking-crc) [143.061539] Starting subtest: nonblocking-crc [143.081091] Starting dynamic subtest: pipe-A-VGA-1 [143.527369] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.461s) [143.563390] Starting dynamic subtest: pipe-B-VGA-1 [143.976568] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.449s) [144.007112] Starting dynamic subtest: pipe-C-VGA-1 [144.422238] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.451s) [144.443291] Subtest nonblocking-crc: SUCCESS (1.366s) [144.653841] [119/162] (875s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [144.803654] Starting subtest: nonblocking-crc-frame-sequence [144.823224] Starting dynamic subtest: pipe-A-VGA-1 [145.239717] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.464s) [145.273612] Starting dynamic subtest: pipe-B-VGA-1 [145.698951] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.450s) [145.731439] Starting dynamic subtest: pipe-C-VGA-1 [146.145349] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.451s) [146.163474] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.369s) [146.372879] [120/162] (873s left) kms_pipe_crc_basic (read-crc) [146.537659] Starting subtest: read-crc [146.559311] Starting dynamic subtest: pipe-A-VGA-1 [146.911350] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.401s) [146.940782] Starting dynamic subtest: pipe-B-VGA-1 [147.294283] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.383s) [147.325735] Starting dynamic subtest: pipe-C-VGA-1 [147.693078] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.385s) [147.712977] Subtest read-crc: SUCCESS (1.173s) [147.915300] [121/162] (872s left) kms_pipe_crc_basic (read-crc-frame-sequence) [148.081644] Starting subtest: read-crc-frame-sequence [148.103803] Starting dynamic subtest: pipe-A-VGA-1 [148.471531] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.402s) [148.503547] Starting dynamic subtest: pipe-B-VGA-1 [148.854262] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.382s) [148.885860] Starting dynamic subtest: pipe-C-VGA-1 [149.235041] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.384s) [149.256141] Subtest read-crc-frame-sequence: SUCCESS (1.173s) [149.472043] [122/162] (870s left) kms_pm_backlight (basic-brightness) [149.647824] Subtest basic-brightness: SKIP (0.000s) [149.792581] [123/162] (870s left) kms_pm_rpm (basic-pci-d3-state) [161.251265] Subtest basic-pci-d3-state: SKIP (0.000s) [161.389636] [124/162] (859s left) kms_pm_rpm (basic-rte) [161.520518] Starting subtest: basic-rte [172.848410] Subtest basic-rte: SKIP (11.094s) [173.033100] [125/162] (847s left) kms_psr (psr-primary-page-flip) [173.227243] Subtest psr-primary-page-flip: SKIP (0.000s) [173.377367] [126/162] (847s left) kms_psr (psr-cursor-plane-move) [173.538543] Subtest psr-cursor-plane-move: SKIP (0.000s) [173.710181] [127/162] (847s left) kms_psr (psr-sprite-plane-onoff) [173.915711] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [174.084993] [128/162] (847s left) kms_psr (psr-primary-mmap-gtt) [174.299501] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [174.477472] [129/162] (846s left) kms_setmode (basic-clone-single-crtc) [174.650158] Starting subtest: basic-clone-single-crtc [174.721928] Subtest basic-clone-single-crtc: SKIP (0.000s) [174.889507] [130/162] (846s left) i915_pm_rps (basic-api) [175.065268] Starting subtest: basic-api [175.089976] Subtest basic-api: SUCCESS (0.003s) [175.272391] [131/162] (846s left) prime_self_import (basic-llseek-bad) [175.411378] Starting subtest: basic-llseek-bad [175.453810] Subtest basic-llseek-bad: SUCCESS (0.003s) [175.596679] [132/162] (846s left) prime_self_import (basic-llseek-size) [175.734452] Starting subtest: basic-llseek-size [175.773421] Subtest basic-llseek-size: SUCCESS (0.003s) [175.923417] [133/162] (846s left) prime_self_import (basic-with_fd_dup) [176.067251] Starting subtest: basic-with_fd_dup [176.111648] Subtest basic-with_fd_dup: SUCCESS (0.003s) [176.261746] [134/162] (845s left) prime_self_import (basic-with_one_bo) [176.384778] Starting subtest: basic-with_one_bo [176.427259] Subtest basic-with_one_bo: SUCCESS (0.003s) [176.572945] [135/162] (845s left) prime_self_import (basic-with_one_bo_two_files) [176.708147] Starting subtest: basic-with_one_bo_two_files [176.755266] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [176.899046] [136/162] (845s left) prime_self_import (basic-with_two_bos) [177.026442] Starting subtest: basic-with_two_bos [177.065101] Subtest basic-with_two_bos: SUCCESS (0.003s) [177.213186] [137/162] (845s left) prime_vgem (basic-fence-flip) [177.381460] Starting subtest: basic-fence-flip [177.673319] Subtest basic-fence-flip: SUCCESS (0.329s) [177.880255] [138/162] (844s left) prime_vgem (basic-fence-mmap) [178.044455] Starting subtest: basic-fence-mmap [178.066598] Subtest basic-fence-mmap: SUCCESS (0.027s) [178.231638] [139/162] (844s left) prime_vgem (basic-fence-read) [178.402347] Starting subtest: basic-fence-read [178.421865] Subtest basic-fence-read: SUCCESS (0.032s) [178.587934] [140/162] (844s left) prime_vgem (basic-gtt) [178.755340] Starting subtest: basic-gtt [178.777049] Subtest basic-gtt: SUCCESS (0.012s) [178.942337] [141/162] (844s left) prime_vgem (basic-read) [179.118497] Starting subtest: basic-read [179.137944] Subtest basic-read: SUCCESS (0.019s) [179.305403] [142/162] (844s left) prime_vgem (basic-write) [179.490222] Starting subtest: basic-write [179.511214] Subtest basic-write: SUCCESS (0.017s) [179.674146] [143/162] (843s left) vgem_basic (setversion) [179.829898] Starting subtest: setversion [179.868877] Subtest setversion: SUCCESS (0.000s) [180.022233] [144/162] (843s left) vgem_basic (create) [180.168742] Starting subtest: create [180.191041] Subtest create: SUCCESS (0.000s) [180.335995] [145/162] (843s left) vgem_basic (debugfs) [180.462108] Starting subtest: debugfs [180.483896] Subtest debugfs: SUCCESS (0.000s) [180.627708] [146/162] (843s left) vgem_basic (dmabuf-export) [180.776686] Starting subtest: dmabuf-export [180.816222] Subtest dmabuf-export: SUCCESS (0.002s) [180.959333] [147/162] (843s left) vgem_basic (dmabuf-fence) [181.106119] Starting subtest: dmabuf-fence [181.125217] Subtest dmabuf-fence: SUCCESS (0.001s) [181.273128] [148/162] (842s left) vgem_basic (dmabuf-fence-before) [181.401864] Starting subtest: dmabuf-fence-before [181.423218] Subtest dmabuf-fence-before: SUCCESS (0.001s) [181.571449] [149/162] (842s left) vgem_basic (dmabuf-mmap) [181.735090] Starting subtest: dmabuf-mmap [181.756920] Subtest dmabuf-mmap: SUCCESS (0.014s) [181.898879] [150/162] (842s left) vgem_basic (mmap) [182.057439] Starting subtest: mmap [182.077129] Subtest mmap: SUCCESS (0.010s) [182.223107] [151/162] (842s left) vgem_basic (second-client) [182.365701] Starting subtest: second-client [182.408066] Subtest second-client: SUCCESS (0.033s) [182.552698] [152/162] (842s left) vgem_basic (sysfs) [182.699236] Starting subtest: sysfs [182.720307] Subtest sysfs: SUCCESS (0.001s) [182.865617] [153/162] (842s left) core_hotunplug (unbind-rebind) [183.109718] Starting subtest: unbind-rebind [184.198767] Subtest unbind-rebind: SKIP (1.035s) [187.844123] Test exited with IGT_EXIT_ABORT, aborting. [187.966774] 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: no output, setting notrun results: parsing output: 154/ for test: i915_module_load results: no output, setting notrun results: parsing output: 155/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 156/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 157/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 158/ for test: gem_lmem_swapping results: no output, setting notrun results: parsing output: 159/ for test: i915_pm_rpm results: no output, setting notrun results: parsing output: 160/ for test: i915_selftest results: no output, setting notrun results: parsing output: 161/ for test: dmabuf results: no output, setting notrun Done.