search

rapid7 / metasploit-framework

Metasploit Framework
https://www.metasploit.com/
Other
33.8k stars 13.9k forks source link

Travis isn't executing "rake spec" tests #8444

Closed renpic closed 7 years ago

renpic commented 7 years ago

Steps to reproduce

This was taken from a bundle exec rake spec SPEC_OPTS="--tag content" build.

The rake spec is never executed. You can pick any recent job log, and you will see the same situation.

Due to an error, instead of executing bundle exec rake spec, Travis will just execute bundle, and that will only print the name and version of installed gems.

More details

From the job log, we can see the variable CMD only contains the first word:

$ export CMD=bundle

And effectively that is what gets run instead of the tests:

$ git diff --exit-code db/schema.rb && $CMD
Warning: the running version of Bundler (1.13.6) is older than the version that created the lockfile (1.15.0). We suggest you upgrade to the latest version of Bundler by running `gem install bundler`.
Fetching gem metadata from https://rubygems.org/............
Fetching version metadata from https://rubygems.org/...
Fetching dependency metadata from https://rubygems.org/..
Resolving dependencies...
Using rake 12.0.0
Using i18n 0.8.1
Using minitest 5.10.2
Using thread_safe 0.3.6
Using builder 3.2.3

[...]

Using metasploit-model 2.0.4
Using rspec-rails 3.6.0
Using metasploit_data_models 2.0.14
Using metasploit-credential 2.0.9
Using metasploit-framework 4.14.22 from source at `.`
Bundle complete! 17 Gemfile dependencies, 117 gems now installed.
Gems in the groups coverage, development and pcap were not installed.
Bundled gems are installed into ./vendor/bundle.

travis_time:end:0b7429c0:start=1495543742931945760,finish=1495543746354067825,duration=3422122065

The command "git diff --exit-code db/schema.rb && $CMD" exited with 0.

Expected behavior

The tests should be run instead of just showing installed gems.

Current behavior

The travis.yml defines four builds, for the following tasks:

Only the last job is correcly executed (the docker-compose), as it is properly escaped.

System stuff

Metasploit version

Current github master.

I installed Metasploit with:

OS

Travis is running the tests on Ubuntu Trusty (14.04 LTS). Probably not relevant here.

Additional notes

I have a small PR. Maybe it is not perfect, but it is a step in the right direction, as it will get the rake spec builds running again.

The issue was edited for clarity; the title was changed too.

renpic commented 7 years ago

Full log of Travis job after last commit (f176315):

travis_fold:start:worker_info
Worker information
hostname: production-5-worker-org-c-2-gce:2c3715ab-23d0-47e6-8fe0-8ba16fb26228
version: v2.7.0 https://github.com/travis-ci/worker/tree/66fc24311e055643710f4e0567f6888c927d3ab8
instance: testing-gce-f51ccd22-c886-4810-a592-096242bb2211:travis-ci-sugilite-trusty-1480960799
startup: 21.468343871s
travis_fold:end:worker_info
travis_fold:start:system_info
Build system information
Build language: ruby
Build group: stable
Build dist: trusty
Build id: 236480632
Job id: 236480634
travis-build version: 6b85b561c
Build image provisioning date and time
Mon Dec  5 18:47:20 UTC 2016
Operating System Details
Distributor ID: Ubuntu
Description:    Ubuntu 14.04.5 LTS
Release:    14.04
Codename:   trusty
Linux Version
4.4.0-51-generic
Cookbooks Version
998099c https://github.com/travis-ci/travis-cookbooks/tree/998099c
git version
git version 2.11.0
bash version
GNU bash, version 4.3.11(1)-release (x86_64-pc-linux-gnu)
Copyright (C) 2013 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>

This is free software; you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
gcc version
gcc (Ubuntu 4.8.4-2ubuntu1~14.04.3) 4.8.4
Copyright (C) 2013 Free Software Foundation, Inc.
This is free software; see the source for copying conditions.  There is NO
warranty; not even for MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.

docker version
Client:
 Version:      1.12.3
 API version:  1.24
 Go version:   go1.6.3
 Git commit:   6b644ec
 Built:        Wed Oct 26 21:44:32 2016
 OS/Arch:      linux/amd64

Server:
 Version:      1.12.3
 API version:  1.24
 Go version:   go1.6.3
 Git commit:   6b644ec
 Built:        Wed Oct 26 21:44:32 2016
 OS/Arch:      linux/amd64
clang version
clang version 3.5.0 (tags/RELEASE_350/final)
Target: x86_64-unknown-linux-gnu
Thread model: posix
jq version
jq-1.5
bats version
Bats 0.4.0
gimme version
v1.0.0
nvm version
0.32.0
perlbrew version
/home/travis/perl5/perlbrew/bin/perlbrew  - App::perlbrew/0.73
postgresql client version
psql (PostgreSQL) 9.6.1
phpenv version
rbenv 1.1.0
rvm version
rvm 1.27.0 (latest) by Wayne E. Seguin <wayneeseguin@gmail.com>, Michal Papis <mpapis@gmail.com> [https://rvm.io/]
default ruby version
ruby 2.3.1p112 (2016-04-26 revision 54768) [x86_64-linux]
Pre-installed Ruby versions
jruby-9.1.2.0
ruby-1.9.3-p551
ruby-2.0.0-p648
ruby-2.1.10
ruby-2.2.5
ruby-2.3.1
Pre-installed Node.js versions
iojs-v1.6
iojs-v1.6.4
v0.10
v0.10.40
v0.11.16
v0.12.2
v0.12.7
v0.6.21
v0.8.28
v4.1.2
v4.6.2
v6.9.1
Pre-installed Go versions
1.2.2
1.3.3
1.4.3
1.5.4
1.6.3
1.7
mysql version
mysql  Ver 14.14 Distrib 5.6.33, for debian-linux-gnu (x86_64) using  EditLine wrapper
Pre-installed PostgreSQL versions
9.2.19
9.3.15
9.4.10
9.5.5
9.6.1
Redis version
redis-server 3.0.6
MongoDB version
MongoDB 3.2.11
RabbitMQ Version
3.6.6
Installed Firefox version
firefox 38.4.0esr
ant version
Apache Ant(TM) version 1.9.3 compiled on April 8 2014
mvn version
Apache Maven 3.1.1 (0728685237757ffbf44136acec0402957f723d9a; 2013-09-17 15:22:22+0000)
Maven home: /usr/local/maven
Java version: 1.8.0_111, vendor: Oracle Corporation
Java home: /usr/lib/jvm/java-8-oracle/jre
Default locale: en_US, platform encoding: UTF-8
OS name: "linux", version: "4.4.0-51-generic", arch: "amd64", family: "unix"
gradle version

------------------------------------------------------------
Gradle 2.13
------------------------------------------------------------

Build time:   2016-04-25 04:10:10 UTC
Build number: none
Revision:     3b427b1481e46232107303c90be7b05079b05b1c

Groovy:       2.4.4
Ant:          Apache Ant(TM) version 1.9.6 compiled on June 29 2015
JVM:          1.8.0_111 (Oracle Corporation 25.111-b14)
OS:           Linux 4.4.0-51-generic amd64

kerl list installations
17.0
17.1
17.3
17.4
17.5
18.0
18.1
18.2
18.2.1
R14B02
R14B03
R14B04
R15B
R15B01
R15B02
R15B03
R16B
R16B01
R16B02
R16B03
R16B03-1
kiex list

kiex elixirs

   elixir-1.0.3
=* elixir-1.0.4

# => - current
# =* - current && default
#  * - default

rebar --version
rebar 2.6.4 17 20160831_145136 git 2.6.4-dirty
lein version
WARNING: You're currently running as root; probably by accident.
Press control-C to abort or Enter to continue as root.
Set LEIN_ROOT to disable this warning.
Leiningen 2.7.1 on Java 1.8.0_111 Java HotSpot(TM) 64-Bit Server VM
perlbrew list
  5.8 (5.8.8)
  5.10 (5.10.1)
  5.12 (5.12.5)
  5.14 (5.14.4)
  5.16 (5.16.3)
  5.18 (5.18.4)
  5.20 (5.20.3)
  5.20-extras (5.20.3)
  5.20-shrplib (5.20.3)
  5.20.3
  5.22 (5.22.0)
  5.22-extras (5.22.0)
  5.22-shrplib (5.22.0)
  5.22.0
phpenv versions
  system
  5.4
  5.4.45
  5.5.37
  5.6
* 5.6.24 (set by /home/travis/.phpenv/version)
  7.0
  7.0.7
  hhvm
  hhvm-stable
composer --version
Composer version 1.2.0 2016-07-19 01:28:52
travis_fold:end:system_info

travis_fold:start:fix.CVE-2015-7547
$ export DEBIAN_FRONTEND=noninteractive
Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  libc-dev-bin libc6-dev
Suggested packages:
  glibc-doc
The following packages will be upgraded:
  libc-dev-bin libc6 libc6-dev
3 upgraded, 0 newly installed, 0 to remove and 200 not upgraded.
Need to get 6,715 kB of archives.
After this operation, 28.7 kB of additional disk space will be used.
Get:1 http://us-central1.gce.archive.ubuntu.com/ubuntu/ trusty-updates/main libc6-dev amd64 2.19-0ubuntu6.11 [1,912 kB]
Get:2 http://us-central1.gce.archive.ubuntu.com/ubuntu/ trusty-updates/main libc-dev-bin amd64 2.19-0ubuntu6.11 [69.0 kB]
Get:3 http://us-central1.gce.archive.ubuntu.com/ubuntu/ trusty-updates/main libc6 amd64 2.19-0ubuntu6.11 [4,734 kB]
Fetched 6,715 kB in 0s (51.8 MB/s)
Preconfiguring packages ...
(Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 88286 files and directories currently installed.)
Preparing to unpack .../libc6-dev_2.19-0ubuntu6.11_amd64.deb ...
Unpacking libc6-dev:amd64 (2.19-0ubuntu6.11) over (2.19-0ubuntu6.9) ...
Preparing to unpack .../libc-dev-bin_2.19-0ubuntu6.11_amd64.deb ...
Unpacking libc-dev-bin (2.19-0ubuntu6.11) over (2.19-0ubuntu6.9) ...
Preparing to unpack .../libc6_2.19-0ubuntu6.11_amd64.deb ...
Unpacking libc6:amd64 (2.19-0ubuntu6.11) over (2.19-0ubuntu6.9) ...
Processing triggers for man-db (2.6.7.1-1ubuntu1) ...
Setting up libc6:amd64 (2.19-0ubuntu6.11) ...
Setting up libc-dev-bin (2.19-0ubuntu6.11) ...
Setting up libc6-dev:amd64 (2.19-0ubuntu6.11) ...
Processing triggers for libc-bin (2.19-0ubuntu6.9) ...
travis_fold:end:fix.CVE-2015-7547
travis_fold:start:git.checkout
travis_time:start:03f951d4
$ git clone --depth=5 --branch=master https://github.com/rapid7/metasploit-framework.git rapid7/metasploit-framework
Cloning into 'rapid7/metasploit-framework'...
remote: Counting objects: 9721, done.
remote: Compressing objects:   0% (1/8334)   
remote: Compressing objects:   1% (84/8334)   
remote: Compressing objects:   2% (167/8334)   
remote: Compressing objects:   3% (251/8334)   
remote: Compressing objects:   4% (334/8334)   
remote: Compressing objects:   5% (417/8334)   
remote: Compressing objects:   6% (501/8334)   
remote: Compressing objects:   7% (584/8334)   
remote: Compressing objects:   8% (667/8334)   
remote: Compressing objects:   9% (751/8334)   
remote: Compressing objects:  10% (834/8334)   
remote: Compressing objects:  11% (917/8334)   
remote: Compressing objects:  12% (1001/8334)   
remote: Compressing objects:  13% (1084/8334)   
remote: Compressing objects:  14% (1167/8334)   
remote: Compressing objects:  15% (1251/8334)   
remote: Compressing objects:  16% (1334/8334)   
remote: Compressing objects:  17% (1417/8334)   
remote: Compressing objects:  18% (1501/8334)   
remote: Compressing objects:  19% (1584/8334)   
remote: Compressing objects:  20% (1667/8334)   
remote: Compressing objects:  21% (1751/8334)   
remote: Compressing objects:  22% (1834/8334)   
remote: Compressing objects:  23% (1917/8334)   
remote: Compressing objects:  24% (2001/8334)   
remote: Compressing objects:  25% (2084/8334)   
remote: Compressing objects:  26% (2167/8334)   
remote: Compressing objects:  27% (2251/8334)   
remote: Compressing objects:  28% (2334/8334)   
remote: Compressing objects:  29% (2417/8334)   
remote: Compressing objects:  30% (2501/8334)   
remote: Compressing objects:  31% (2584/8334)   
remote: Compressing objects:  32% (2667/8334)   
remote: Compressing objects:  33% (2751/8334)   
remote: Compressing objects:  34% (2834/8334)   
remote: Compressing objects:  35% (2917/8334)   
remote: Compressing objects:  36% (3001/8334)   
remote: Compressing objects:  37% (3084/8334)   
remote: Compressing objects:  38% (3167/8334)   
remote: Compressing objects:  39% (3251/8334)   
remote: Compressing objects:  40% (3334/8334)   
remote: Compressing objects:  41% (3417/8334)   
remote: Compressing objects:  42% (3501/8334)   
remote: Compressing objects:  43% (3584/8334)   
remote: Compressing objects:  44% (3667/8334)   
remote: Compressing objects:  45% (3751/8334)   
remote: Compressing objects:  46% (3834/8334)   
remote: Compressing objects:  47% (3917/8334)   
remote: Compressing objects:  48% (4001/8334)   
remote: Compressing objects:  49% (4084/8334)   
remote: Compressing objects:  50% (4167/8334)   
remote: Compressing objects:  51% (4251/8334)   
remote: Compressing objects:  52% (4334/8334)   
remote: Compressing objects:  53% (4418/8334)   
remote: Compressing objects:  54% (4501/8334)   
remote: Compressing objects:  55% (4584/8334)   
remote: Compressing objects:  56% (4668/8334)   
remote: Compressing objects:  57% (4751/8334)   
remote: Compressing objects:  58% (4834/8334)   
remote: Compressing objects:  59% (4918/8334)   
remote: Compressing objects:  60% (5001/8334)   
remote: Compressing objects:  60% (5028/8334)   
remote: Compressing objects:  61% (5084/8334)   
remote: Compressing objects:  62% (5168/8334)   
remote: Compressing objects:  63% (5251/8334)   
remote: Compressing objects:  64% (5334/8334)   
remote: Compressing objects:  65% (5418/8334)   
remote: Compressing objects:  66% (5501/8334)   
remote: Compressing objects:  67% (5584/8334)   
remote: Compressing objects:  68% (5668/8334)   
remote: Compressing objects:  69% (5751/8334)   
remote: Compressing objects:  70% (5834/8334)   
remote: Compressing objects:  71% (5918/8334)   
remote: Compressing objects:  72% (6001/8334)   
remote: Compressing objects:  73% (6084/8334)   
remote: Compressing objects:  74% (6168/8334)   
remote: Compressing objects:  75% (6251/8334)   
remote: Compressing objects:  76% (6334/8334)   
remote: Compressing objects:  77% (6418/8334)   
remote: Compressing objects:  78% (6501/8334)   
remote: Compressing objects:  79% (6584/8334)   
remote: Compressing objects:  80% (6668/8334)   
remote: Compressing objects:  81% (6751/8334)   
remote: Compressing objects:  82% (6834/8334)   
remote: Compressing objects:  83% (6918/8334)   
remote: Compressing objects:  84% (7001/8334)   
remote: Compressing objects:  85% (7084/8334)   
remote: Compressing objects:  86% (7168/8334)   
remote: Compressing objects:  87% (7251/8334)   
remote: Compressing objects:  88% (7334/8334)   
remote: Compressing objects:  89% (7418/8334)   
remote: Compressing objects:  90% (7501/8334)   
remote: Compressing objects:  91% (7584/8334)   
remote: Compressing objects:  92% (7668/8334)   
remote: Compressing objects:  93% (7751/8334)   
remote: Compressing objects:  94% (7834/8334)   
remote: Compressing objects:  95% (7918/8334)   
remote: Compressing objects:  96% (8001/8334)   
remote: Compressing objects:  97% (8084/8334)   
remote: Compressing objects:  98% (8168/8334)   
remote: Compressing objects:  99% (8251/8334)   
remote: Compressing objects: 100% (8334/8334)   
remote: Compressing objects: 100% (8334/8334), done.
Receiving objects:   0% (1/9721)   
Receiving objects:   1% (98/9721)   
Receiving objects:   2% (195/9721)   
Receiving objects:   3% (292/9721)   
Receiving objects:   4% (389/9721)   
Receiving objects:   5% (487/9721)   
Receiving objects:   6% (584/9721)   
Receiving objects:   7% (681/9721)   
Receiving objects:   8% (778/9721)   
Receiving objects:   9% (875/9721)   
Receiving objects:  10% (973/9721)   
Receiving objects:  11% (1070/9721)   
Receiving objects:  12% (1167/9721)   
Receiving objects:  13% (1264/9721)   
Receiving objects:  14% (1361/9721)   
Receiving objects:  15% (1459/9721)   
Receiving objects:  16% (1556/9721)   
Receiving objects:  17% (1653/9721)   
Receiving objects:  18% (1750/9721)   
Receiving objects:  19% (1847/9721)   
Receiving objects:  20% (1945/9721)   
Receiving objects:  21% (2042/9721)   
Receiving objects:  22% (2139/9721)   
Receiving objects:  23% (2236/9721)   
Receiving objects:  24% (2334/9721)   
Receiving objects:  25% (2431/9721)   
Receiving objects:  26% (2528/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  27% (2625/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  28% (2722/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  29% (2820/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  30% (2917/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  31% (3014/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  32% (3111/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  33% (3208/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  34% (3306/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  35% (3403/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  36% (3500/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  37% (3597/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  38% (3694/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  39% (3792/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  40% (3889/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  41% (3986/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  42% (4083/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  43% (4181/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  44% (4278/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  45% (4375/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  46% (4472/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  47% (4569/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  48% (4667/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  49% (4764/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  50% (4861/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  51% (4958/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  52% (5055/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  53% (5153/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  54% (5250/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  55% (5347/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  56% (5444/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  57% (5541/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  58% (5639/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  59% (5736/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  60% (5833/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  61% (5930/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  62% (6028/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  63% (6125/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  64% (6222/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  65% (6319/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  66% (6416/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  66% (6501/9721), 10.79 MiB | 21.58 MiB/s   
Receiving objects:  67% (6514/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  68% (6611/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  69% (6708/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  70% (6805/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  71% (6902/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  72% (7000/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  73% (7097/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  74% (7194/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  75% (7291/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  76% (7388/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  77% (7486/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  78% (7583/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  79% (7680/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  80% (7777/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  81% (7875/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  82% (7972/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  83% (8069/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  84% (8166/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  85% (8263/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  86% (8361/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  87% (8458/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  88% (8555/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  89% (8652/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  90% (8749/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  91% (8847/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  92% (8944/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  93% (9041/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  94% (9138/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  95% (9235/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  96% (9333/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  97% (9430/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  98% (9527/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects:  99% (9624/9721), 20.37 MiB | 20.37 MiB/s   
remote: Total 9721 (delta 1471), reused 4118 (delta 828), pack-reused 0
Receiving objects: 100% (9721/9721), 20.37 MiB | 20.37 MiB/s   
Receiving objects: 100% (9721/9721), 24.96 MiB | 20.37 MiB/s, done.
Resolving deltas:   0% (0/1471)   
Resolving deltas:   1% (15/1471)   
Resolving deltas:   2% (30/1471)   
Resolving deltas:   3% (48/1471)   
Resolving deltas:   4% (59/1471)   
Resolving deltas:   5% (78/1471)   
Resolving deltas:   6% (89/1471)   
Resolving deltas:   7% (103/1471)   
Resolving deltas:   8% (122/1471)   
Resolving deltas:  10% (150/1471)   
Resolving deltas:  11% (163/1471)   
Resolving deltas:  12% (177/1471)   
Resolving deltas:  13% (194/1471)   
Resolving deltas:  15% (223/1471)   
Resolving deltas:  16% (236/1471)   
Resolving deltas:  17% (253/1471)   
Resolving deltas:  18% (265/1471)   
Resolving deltas:  19% (280/1471)   
Resolving deltas:  20% (298/1471)   
Resolving deltas:  21% (312/1471)   
Resolving deltas:  22% (324/1471)   
Resolving deltas:  23% (339/1471)   
Resolving deltas:  24% (357/1471)   
Resolving deltas:  25% (372/1471)   
Resolving deltas:  26% (394/1471)   
Resolving deltas:  27% (398/1471)   
Resolving deltas:  28% (413/1471)   
Resolving deltas:  29% (428/1471)   
Resolving deltas:  30% (442/1471)   
Resolving deltas:  31% (457/1471)   
Resolving deltas:  32% (474/1471)   
Resolving deltas:  33% (486/1471)   
Resolving deltas:  34% (501/1471)   
Resolving deltas:  35% (522/1471)   
Resolving deltas:  36% (532/1471)   
Resolving deltas:  37% (550/1471)   
Resolving deltas:  38% (567/1471)   
Resolving deltas:  39% (577/1471)   
Resolving deltas:  40% (597/1471)   
Resolving deltas:  41% (607/1471)   
Resolving deltas:  42% (619/1471)   
Resolving deltas:  43% (633/1471)   
Resolving deltas:  44% (648/1471)   
Resolving deltas:  45% (666/1471)   
Resolving deltas:  46% (677/1471)   
Resolving deltas:  47% (692/1471)   
Resolving deltas:  48% (707/1471)   
Resolving deltas:  49% (721/1471)   
Resolving deltas:  50% (736/1471)   
Resolving deltas:  51% (752/1471)   
Resolving deltas:  52% (766/1471)   
Resolving deltas:  53% (780/1471)   
Resolving deltas:  54% (796/1471)   
Resolving deltas:  55% (811/1471)   
Resolving deltas:  56% (824/1471)   
Resolving deltas:  57% (841/1471)   
Resolving deltas:  58% (854/1471)   
Resolving deltas:  59% (868/1471)   
Resolving deltas:  60% (883/1471)   
Resolving deltas:  61% (898/1471)   
Resolving deltas:  62% (913/1471)   
Resolving deltas:  63% (927/1471)   
Resolving deltas:  64% (942/1471)   
Resolving deltas:  65% (959/1471)   
Resolving deltas:  66% (972/1471)   
Resolving deltas:  67% (986/1471)   
Resolving deltas:  68% (1002/1471)   
Resolving deltas:  69% (1015/1471)   
Resolving deltas:  70% (1033/1471)   
Resolving deltas:  71% (1045/1471)   
Resolving deltas:  72% (1060/1471)   
Resolving deltas:  73% (1074/1471)   
Resolving deltas:  74% (1089/1471)   
Resolving deltas:  75% (1104/1471)   
Resolving deltas:  76% (1118/1471)   
Resolving deltas:  77% (1133/1471)   
Resolving deltas:  78% (1148/1471)   
Resolving deltas:  79% (1164/1471)   
Resolving deltas:  80% (1181/1471)   
Resolving deltas:  81% (1199/1471)   
Resolving deltas:  82% (1209/1471)   
Resolving deltas:  83% (1221/1471)   
Resolving deltas:  84% (1241/1471)   
Resolving deltas:  85% (1253/1471)   
Resolving deltas:  86% (1272/1471)   
Resolving deltas:  87% (1281/1471)   
Resolving deltas:  88% (1295/1471)   
Resolving deltas:  89% (1314/1471)   
Resolving deltas:  90% (1328/1471)   
Resolving deltas:  91% (1340/1471)   
Resolving deltas:  92% (1354/1471)   
Resolving deltas:  93% (1369/1471)   
Resolving deltas:  94% (1383/1471)   
Resolving deltas:  95% (1398/1471)   
Resolving deltas:  96% (1413/1471)   
Resolving deltas:  97% (1427/1471)   
Resolving deltas:  98% (1442/1471)   
Resolving deltas:  99% (1458/1471)   
Resolving deltas: 100% (1471/1471)   
Resolving deltas: 100% (1471/1471), done.

travis_time:end:03f951d4:start=1495824011034769666,finish=1495824015790423191,duration=4755653525
$ cd rapid7/metasploit-framework
$ git checkout -qf f176315942cc4b7493d226e3dac5cbc0876bdb44
travis_fold:end:git.checkout
travis_fold:start:git.submodule
travis_time:start:18a6b834
$ git submodule update --init --recursive
Submodule 'external/source/ReflectiveDLLInjection' (https://github.com/rapid7/ReflectiveDLLInjection.git) registered for path 'external/source/ReflectiveDLLInjection'
Cloning into '/home/travis/build/rapid7/metasploit-framework/external/source/ReflectiveDLLInjection'...
Submodule path 'external/source/ReflectiveDLLInjection': checked out '88e8e5f109793f09b35cb17a621f33647d644103'

travis_time:end:18a6b834:start=1495824016252453870,finish=1495824016853846922,duration=601393052
travis_fold:end:git.submodule
travis_fold:start:apt
Installing APT Packages (BETA)
$ export DEBIAN_FRONTEND=noninteractive
travis_time:start:03a033ec
$ sudo -E apt-get -yq update &>> ~/apt-get-update.log

travis_time:end:03a033ec:start=1495824016860292354,finish=1495824026850411611,duration=9990119257
travis_time:start:04b95cb8
$ sudo -E apt-get -yq --no-install-suggests --no-install-recommends --force-yes install libpcap-dev graphviz
Reading package lists...
Building dependency tree...
Reading state information...
The following extra packages will be installed:
  libpcap0.8-dev
Suggested packages:
  graphviz-doc
The following NEW packages will be installed:
  graphviz libpcap-dev libpcap0.8-dev
0 upgraded, 3 newly installed, 0 to remove and 200 not upgraded.
Need to get 669 kB of archives.
After this operation, 2,547 kB of additional disk space will be used.
Get:1 http://us-central1.gce.archive.ubuntu.com/ubuntu/ trusty-updates/main graphviz amd64 2.36.0-0ubuntu3.2 [461 kB]
Get:2 http://us-central1.gce.archive.ubuntu.com/ubuntu/ trusty/main libpcap0.8-dev amd64 1.5.3-2 [205 kB]
Get:3 http://us-central1.gce.archive.ubuntu.com/ubuntu/ trusty/main libpcap-dev all 1.5.3-2 [3,390 B]
Fetched 669 kB in 0s (22.1 MB/s)
Selecting previously unselected package graphviz.
(Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 88286 files and directories currently installed.)
Preparing to unpack .../graphviz_2.36.0-0ubuntu3.2_amd64.deb ...
Unpacking graphviz (2.36.0-0ubuntu3.2) ...
Selecting previously unselected package libpcap0.8-dev.
Preparing to unpack .../libpcap0.8-dev_1.5.3-2_amd64.deb ...
Unpacking libpcap0.8-dev (1.5.3-2) ...
Selecting previously unselected package libpcap-dev.
Preparing to unpack .../libpcap-dev_1.5.3-2_all.deb ...
Unpacking libpcap-dev (1.5.3-2) ...
Processing triggers for man-db (2.6.7.1-1ubuntu1) ...
Setting up graphviz (2.36.0-0ubuntu3.2) ...
Setting up libpcap0.8-dev (1.5.3-2) ...
Setting up libpcap-dev (1.5.3-2) ...

travis_time:end:04b95cb8:start=1495824026854690406,finish=1495824030642072029,duration=3787381623
travis_fold:end:apt
travis_fold:start:services
travis_time:start:018a1ae4
$ sudo service docker start
start: Job is already running: docker

travis_time:end:018a1ae4:start=1495824030646835866,finish=1495824030662745888,duration=15910022
travis_fold:end:services
travis_fold:start:postgresql
Starting PostgreSQL v9.6
travis_time:start:0822903a
$ sudo service postgresql stop
 * Stopping PostgreSQL 9.2 database server        
[ OK ]
 * Stopping PostgreSQL 9.3 database server        
[ OK ]
 * Stopping PostgreSQL 9.4 database server        
[ OK ]
 * Stopping PostgreSQL 9.5 database server        
[ OK ]
 * Stopping PostgreSQL 9.6 database server        
[ OK ]

travis_time:end:0822903a:start=1495824033669449472,finish=1495824035025946128,duration=1356496656
travis_time:start:02fd44e4
$ sudo service postgresql start 9.6
 * Starting PostgreSQL 9.6 database server        
[ OK ]

travis_time:end:02fd44e4:start=1495824035030563596,finish=1495824037259216235,duration=2228652639
travis_time:start:068691bc
$ sudo -u postgres createuser -s -p 5432 travis &>/dev/null

travis_time:end:068691bc:start=1495824037263542742,finish=1495824037313676826,duration=50134084
travis_time:start:018e0d29
$ sudo -u postgres createdb -O travis -p 5432 travis &>/dev/null

travis_time:end:018e0d29:start=1495824037318178190,finish=1495824037569963321,duration=251785131
travis_time:start:21352620
$ sudo -u postgres createuser -s -p 5433 travis &>/dev/null

travis_time:end:21352620:start=1495824037574257648,finish=1495824037613295379,duration=39037731
travis_time:start:08791bc0
$ sudo -u postgres createdb -O travis -p 5433 travis &>/dev/null

travis_time:end:08791bc0:start=1495824037617846985,finish=1495824037655792689,duration=37945704
travis_fold:end:postgresql

Setting environment variables from .travis.yml
$ export CMD=bundle
$ export SPEC_OPTS="--tag content"

travis_fold:start:rvm
travis_time:start:0af7a237
$ rvm use 2.2 --install --binary --fuzzy
Using /home/travis/.rvm/gems/ruby-2.2.5

travis_time:end:0af7a237:start=1495824037668011865,finish=1495824038165840925,duration=497829060
travis_fold:end:rvm
$ export BUNDLE_GEMFILE=$PWD/Gemfile
travis_fold:start:cache.1
Setting up build cache
$ export CASHER_DIR=$HOME/.casher
travis_time:start:02021806
$ Installing caching utilities

travis_time:end:02021806:start=1495824038475865082,finish=1495824038617148960,duration=141283878
travis_time:start:0e6debce

travis_time:end:0e6debce:start=1495824038623283654,finish=1495824038627694677,duration=4411023
travis_time:start:1d67d1e0
attempting to download cache archive
fetching master/cache-linux-trusty-51483dc0bc70ff5648c581254112727102f6ff0dddfff81ad68e7ce68ab41b9c--rvm-2.2--gemfile-Gemfile.tgz
found cache

travis_time:end:1d67d1e0:start=1495824038632469082,finish=1495824039610114341,duration=977645259
travis_fold:end:cache.1

travis_fold:start:cache.bundler
travis_time:start:1d841753

travis_time:end:1d841753:start=1495824039615479784,finish=1495824039619841802,duration=4362018
travis_time:start:2178ae14
adding /home/travis/build/rapid7/metasploit-framework/vendor/bundle to cache
creating directory /home/travis/build/rapid7/metasploit-framework/vendor/bundle

travis_time:end:2178ae14:start=1495824039625177792,finish=1495824042907410581,duration=3282232789
travis_fold:end:cache.bundler
$ ruby --version
ruby 2.2.5p319 (2016-04-26 revision 54774) [x86_64-linux]
$ rvm --version
rvm 1.27.0 (latest) by Wayne E. Seguin <wayneeseguin@gmail.com>, Michal Papis <mpapis@gmail.com> [https://rvm.io/]
$ bundle --version
Bundler version 1.13.6
$ gem --version
2.4.8
travis_fold:start:before_install.1
travis_time:start:136ddb00
$ echo 'gem: --no-ri --no-rdoc' > ~/.gemrc

travis_time:end:136ddb00:start=1495824043414281339,finish=1495824043475677588,duration=61396249
travis_fold:end:before_install.1
travis_fold:start:before_install.2
travis_time:start:0069541e
$ rake --version
rake, version 11.3.0

travis_time:end:0069541e:start=1495824043480994870,finish=1495824043593570977,duration=112576107
travis_fold:end:before_install.2
travis_fold:start:before_install.3
travis_time:start:01166440
$ ln -sf ../../tools/dev/pre-commit-hook.rb ./.git/hooks/post-merge

travis_time:end:01166440:start=1495824043598730775,finish=1495824043603660934,duration=4930159
travis_fold:end:before_install.3
travis_fold:start:before_install.4
travis_time:start:0bcc9a7e
$ ls -la ./.git/hooks
total 52
drwxrwxr-x 2 travis travis 4096 May 26 18:40 .
drwxrwxr-x 9 travis travis 4096 May 26 18:40 ..
-rwxrwxr-x 1 travis travis  478 May 26 18:40 applypatch-msg.sample
-rwxrwxr-x 1 travis travis  896 May 26 18:40 commit-msg.sample
lrwxrwxrwx 1 travis travis   34 May 26 18:40 post-merge -> ../../tools/dev/pre-commit-hook.rb
-rwxrwxr-x 1 travis travis  189 May 26 18:40 post-update.sample
-rwxrwxr-x 1 travis travis  424 May 26 18:40 pre-applypatch.sample
-rwxrwxr-x 1 travis travis 1642 May 26 18:40 pre-commit.sample
-rwxrwxr-x 1 travis travis 1239 May 26 18:40 prepare-commit-msg.sample
-rwxrwxr-x 1 travis travis 1348 May 26 18:40 pre-push.sample
-rwxrwxr-x 1 travis travis 4898 May 26 18:40 pre-rebase.sample
-rwxrwxr-x 1 travis travis  544 May 26 18:40 pre-receive.sample
-rwxrwxr-x 1 travis travis 3610 May 26 18:40 update.sample

travis_time:end:0bcc9a7e:start=1495824043608875655,finish=1495824043614893973,duration=6018318
travis_fold:end:before_install.4
travis_fold:start:before_install.5
travis_time:start:1c8a845c
$ ./.git/hooks/post-merge
[*] Running msftidy.rb in ./.git/hooks/post-merge mode
--- No Metasploit modules to check ---

travis_time:end:1c8a845c:start=1495824043620003190,finish=1495824043662202654,duration=42199464
travis_fold:end:before_install.5
travis_fold:start:install.bundler
travis_time:start:07762a14
$ bundle install --without coverage development pcap --path=${BUNDLE_PATH:-vendor/bundle}
Warning: the running version of Bundler (1.13.6) is older than the version that created the lockfile (1.15.0). We suggest you upgrade to the latest version of Bundler by running `gem install bundler`.
Fetching https://github.com/pry/pry
Fetching gem metadata from https://rubygems.org/...........
Fetching version metadata from https://rubygems.org/..
Fetching dependency metadata from https://rubygems.org/.
Resolving dependencies...
Using rake 12.0.0
Using i18n 0.8.1
Using minitest 5.10.2
Using thread_safe 0.3.6
Using builder 3.2.3
Using erubis 2.7.0
Using mini_portile2 2.1.0
Using rack 1.6.8
Using arel 6.0.4
Using public_suffix 2.0.5
Using ffi 1.9.18
Using contracts 0.16.0
Using gherkin 4.1.3
Using cucumber-wire 0.0.1
Using diff-lcs 1.3
Using multi_json 1.12.1
Using multi_test 0.1.2
Using rspec-support 3.6.0
Using thor 0.19.4
Using backports 3.8.0
Using bcrypt 3.1.11
Using bindata 2.4.0
Using bit-struct 0.15.0 from https://github.com/busterb/bit-struct (at ruby-2.4@707133a)
Using mime-types-data 3.2016.0521
Using multipart-post 2.0.0
Using filesize 0.1.1
Using fivemat 1.3.3
Using rkelly-remix 0.0.7
Using json 2.1.0
Using metasm 1.0.3
Using pg 0.20.0
Using pg_array_parser 0.0.9
Using rubyntlm 0.6.2
Using rubyzip 1.2.1
Using metasploit-payloads 1.2.29
Using metasploit_payloads-mettle 0.1.9
Using msgpack 1.1.0
Using nessus_rest 0.1.6
Using net-ssh 4.1.0
Using network_interface 0.0.1
Using nexpose 6.0.0
Using openssl-ccm 1.2.1
Using openvas-omp 0.0.4
Using pcaprub 0.12.4
Using patch_finder 1.0.2
Using rb-readline 0.5.4
Using redcarpet 3.4.0
Using rex-text 0.2.15
Using rex-core 0.1.10
Using rex-struct2 0.1.2
Using rex-java 0.1.5
Using rex-registry 0.1.3
Using robots 0.10.1
Using windows_error 0.1.2
Using sqlite3 1.3.13
Using sshkey 1.9.0
Using method_source 0.8.1 from https://github.com/banister/method_source (at master@0cc6cc8)
Using timecop 0.8.1
Using bundler 1.13.6
Using tzinfo 1.2.3
Using nokogiri 1.7.2
Using rack-test 0.6.3
Using addressable 2.5.1
Using childprocess 0.5.9
Using cucumber-core 1.5.0
Using rspec-expectations 3.6.0
Using rspec-core 3.6.0
Using rspec-mocks 3.6.0
Using mime-types 3.1
Using faraday 0.12.1
Using jsobfu 0.4.2
Using packetfu 1.1.13
Using rex-arch 0.1.4
Using rex-mime 0.1.5
Using rex-ole 0.1.6
Using rex-random_identifier 0.1.2
Using rex-zip 0.1.3
Using rex-rop_builder 0.1.3
Using rex-socket 0.1.6
Using ruby_smb 0.0.17
Using activesupport 4.2.8
Using tzinfo-data 1.2017.2
Using loofah 2.0.3
Using xpath 2.1.0
Using recog 2.1.8
Using cucumber 2.4.0
Using sawyer 0.8.1
Using rex-bin_tools 0.1.3
Using rex-encoder 0.1.4
Using rex-nop 0.1.1
Using rex-powershell 0.1.72
Using rex-sslscan 0.1.4
Using rails-deprecated_sanitizer 1.0.3
Using activemodel 4.2.8
Using factory_girl 4.8.0
Using shoulda-matchers 3.1.1
Using rails-html-sanitizer 1.0.3
Using capybara 2.14.0
Using aruba 0.14.2
Using octokit 4.7.0
Using rex-exploitation 0.1.14
Using rails-dom-testing 1.0.8
Using activerecord 4.2.8
Using actionview 4.2.8
Using arel-helpers 2.4.0
Using postgres_ext 3.0.0
Using actionpack 4.2.8
Using railties 4.2.8
Using cucumber-rails 1.5.0
Using factory_girl_rails 4.8.0
Using metasploit-concern 2.0.4
Using metasploit-model 2.0.4
Using rspec-rails 3.6.0
Using metasploit_data_models 2.0.14
Using metasploit-credential 2.0.9
Using metasploit-framework 4.14.23 from source at `.`
Bundle complete! 17 Gemfile dependencies, 116 gems now installed.
Gems in the groups coverage, development and pcap were not installed.
Bundled gems are installed into ./vendor/bundle.

travis_time:end:07762a14:start=1495824043667495353,finish=1495824049088542552,duration=5421047199
travis_fold:end:install.bundler
travis_fold:start:before_script.1
travis_time:start:220326c8
$ cp config/database.yml.travis config/database.yml

travis_time:end:220326c8:start=1495824049096293280,finish=1495824049101968444,duration=5675164
travis_fold:end:before_script.1
travis_fold:start:before_script.2
travis_time:start:09ea74e0
$ bundle exec rake --version
rake, version 12.0.0

travis_time:end:09ea74e0:start=1495824049107516705,finish=1495824049738037368,duration=630520663
travis_fold:end:before_script.2
travis_fold:start:before_script.3
travis_time:start:0f8e9ba4
$ bundle exec rake db:create
YARD not defined, so yard tasks cannot be setup.

travis_time:end:0f8e9ba4:start=1495824049743433027,finish=1495824053296588883,duration=3553155856
travis_fold:end:before_script.3
travis_fold:start:before_script.4
travis_time:start:0fe0dd1b
$ bundle exec rake db:migrate
YARD not defined, so yard tasks cannot be setup.
== 0 CreateTables: migrating ==================================================
-- create_table(:hosts)
   -> 0.0034s
-- add_index(:hosts, :address, {:unique=>true})
   -> 0.0020s
-- create_table(:clients)
   -> 0.0020s
-- create_table(:services)
   -> 0.0019s
-- create_table(:vulns)
   -> 0.0019s
-- create_table(:refs)
   -> 0.0020s
-- create_table(:vulns_refs, {:id=>false})
   -> 0.0009s
-- create_table(:notes)
   -> 0.0017s
== 0 CreateTables: migrated (0.0164s) =========================================

== 1 AddWmapTables: migrating =================================================
-- create_table(:wmap_targets)
   -> 0.0019s
-- create_table(:wmap_requests)
   -> 0.0021s
== 1 AddWmapTables: migrated (0.0043s) ========================================

== 2 AddWorkspaces: migrating =================================================
-- create_table(:workspaces)
   -> 0.0019s
-- change_table(:hosts)
   -> 0.0006s
-- remove_index(:hosts, {:column=>:address})
   -> 0.0016s
== 2 AddWorkspaces: migrated (0.0045s) ========================================

== 3 MoveNotes: migrating =====================================================
-- remove_column(:notes, :host_id)
   -> 0.0005s
-- change_table(:notes)
   -> 0.0033s
== 3 MoveNotes: migrated (0.0041s) ============================================

== 4 AddEventsTable: migrating ================================================
-- create_table(:events)
   -> 0.0020s
== 4 AddEventsTable: migrated (0.0022s) =======================================

== 5 ExpandInfo: migrating ====================================================
-- remove_column(:events, :info)
   -> 0.0005s
-- change_table(:events)
   -> 0.0007s
-- remove_column(:notes, :data)
   -> 0.0005s
-- change_table(:notes)
   -> 0.0005s
-- remove_column(:vulns, :data)
   -> 0.0005s
-- change_table(:vulns)
   -> 0.0006s
-- remove_column(:hosts, :info)
   -> 0.0004s
-- change_table(:hosts)
   -> 0.0005s
-- remove_column(:services, :info)
   -> 0.0005s
-- change_table(:services)
   -> 0.0013s
== 5 ExpandInfo: migrated (0.0068s) ===========================================

== 6 AddTimestamps: migrating =================================================
-- rename_column(:clients, :created, :created_at)
   -> 0.0019s
-- rename_column(:hosts, :created, :created_at)
   -> 0.0012s
-- rename_column(:notes, :created, :created_at)
   -> 0.0011s
-- rename_column(:refs, :created, :created_at)
   -> 0.0013s
-- rename_column(:services, :created, :created_at)
   -> 0.0012s
-- rename_column(:vulns, :created, :created_at)
   -> 0.0013s
-- rename_column(:wmap_requests, :created, :created_at)
   -> 0.0012s
-- add_column(:wmap_targets, :created_at, :datetime)
   -> 0.0006s
-- add_column(:clients, :updated_at, :datetime)
   -> 0.0005s
-- add_column(:events, :updated_at, :datetime)
   -> 0.0004s
-- add_column(:hosts, :updated_at, :datetime)
   -> 0.0006s
-- add_column(:notes, :updated_at, :datetime)
   -> 0.0005s
-- add_column(:refs, :updated_at, :datetime)
   -> 0.0007s
-- add_column(:services, :updated_at, :datetime)
   -> 0.0004s
-- add_column(:vulns, :updated_at, :datetime)
   -> 0.0006s
-- add_column(:wmap_requests, :updated_at, :datetime)
   -> 0.0004s
-- add_column(:wmap_targets, :updated_at, :datetime)
   -> 0.0005s
== 6 AddTimestamps: migrated (0.0162s) ========================================

== 7 AddLoots: migrating ======================================================
-- create_table(:loots)
   -> 0.0025s
== 7 AddLoots: migrated (0.0026s) =============================================

== 8 CreateUsers: migrating ===================================================
-- create_table(:users)
   -> 0.0020s
== 8 CreateUsers: migrated (0.0021s) ==========================================

== 9 AddLootsCtype: migrating =================================================
-- add_column(:loots, :content_type, :string)
   -> 0.0007s
== 9 AddLootsCtype: migrated (0.0008s) ========================================

== 10 AddAlertFields: migrating ===============================================
-- add_column(:notes, :critical, :boolean)
   -> 0.0007s
-- add_column(:notes, :seen, :boolean)
   -> 0.0004s
-- add_column(:events, :critical, :boolean)
   -> 0.0006s
-- add_column(:events, :seen, :boolean)
   -> 0.0004s
== 10 AddAlertFields: migrated (0.0025s) ======================================

== 11 AddReports: migrating ===================================================
-- create_table(:reports)
   -> 0.0025s
== 11 AddReports: migrated (0.0025s) ==========================================

== 12 AddTasks: migrating =====================================================
-- create_table(:tasks)
   -> 0.0026s
== 12 AddTasks: migrated (0.0026s) ============================================

== 13 AddTasksResult: migrating ===============================================
-- add_column(:tasks, :result, :text)
   -> 0.0006s
== 13 AddTasksResult: migrated (0.0007s) ======================================

== 14 AddLootsFields: migrating ===============================================
-- add_column(:loots, :name, :text)
   -> 0.0006s
-- add_column(:loots, :info, :text)
   -> 0.0005s
== 14 AddLootsFields: migrated (0.0013s) ======================================

== 15 RenameUser: migrating ===================================================
-- remove_column(:events, :user)
   -> 0.0005s
-- change_table(:events)
   -> 0.0006s
== 15 RenameUser: migrated (0.0013s) ==========================================

== 16 AddHostPurpose: migrating ===============================================
-- add_column(:hosts, :purpose, :text)
   -> 0.0006s
== 16 AddHostPurpose: migrated (0.0007s) ======================================

== 17 ExpandInfo2: migrating ==================================================
-- remove_column(:events, :info)
   -> 0.0005s
-- change_table(:events)
   -> 0.0007s
-- remove_column(:notes, :data)
   -> 0.0005s
-- change_table(:notes)
   -> 0.0006s
-- remove_column(:vulns, :data)
   -> 0.0006s
-- change_table(:vulns)
   -> 0.0005s
-- remove_column(:hosts, :info)
   -> 0.0004s
-- change_table(:hosts)
   -> 0.0006s
-- remove_column(:services, :info)
   -> 0.0004s
-- change_table(:services)
   -> 0.0006s
== 17 ExpandInfo2: migrated (0.0061s) =========================================

== 18 AddWorkspaceUserInfo: migrating =========================================
-- change_table(:workspaces)
   -> 0.0006s
-- change_table(:users)
   -> 0.0016s
== 18 AddWorkspaceUserInfo: migrated (0.0024s) ================================

== 19 AddWorkspaceDesc: migrating =============================================
-- change_table(:workspaces)
   -> 0.0007s
-- change_table(:hosts)
   -> 0.0006s
== 19 AddWorkspaceDesc: migrated (0.0015s) ====================================

== 20 AddUserPreferences: migrating ===========================================
-- add_column(:users, :prefs, :string, {:limit=>524288})
   -> 0.0006s
== 20 AddUserPreferences: migrated (0.0007s) ==================================

== 21 StandardizeInfoAndData: migrating =======================================
-- remove_column(:vulns, :data)
   -> 0.0005s
-- change_table(:vulns)
   -> 0.0007s
== 21 StandardizeInfoAndData: migrated (0.0014s) ==============================

== 22 EnlargeEventInfo: migrating =============================================
-- change_column(:events, :info, :text)
   -> 0.0006s
== 22 EnlargeEventInfo: migrated (0.0007s) ====================================

== 23 AddReportDownloadedAt: migrating ========================================
-- add_column(:reports, :downloaded_at, :timestamp)
   -> 0.0007s
== 23 AddReportDownloadedAt: migrated (0.0008s) ===============================

== 24 ConvertServiceInfoToText: migrating =====================================
-- change_column(:services, :info, :text)
   -> 0.0006s
== 24 ConvertServiceInfoToText: migrated (0.0007s) ============================

== 25 AddUserAdmin: migrating =================================================
-- add_column(:users, :admin, :boolean, {:default=>true})
   -> 0.0024s
-- create_table(:project_members, {:id=>false})
   -> 0.0007s
== 25 AddUserAdmin: migrated (0.0033s) ========================================

== 26 AddCredsTable: migrating ================================================
-- create_table(:creds)
   -> 0.0023s
== 26 AddCredsTable: migrated (0.0025s) =======================================

== 20100819123300 MigrateCredData: migrating ==================================
-- Migrating 0 credentials.
-- Migrating 0 notes.
-- Deleting migrated auth notes.
== 20100819123300 MigrateCredData: migrated (0.0032s) =========================

== 20100824151500 AddExploitedTable: migrating ================================
-- create_table(:exploited_hosts)
   -> 0.0020s
== 20100824151500 AddExploitedTable: migrated (0.0021s) =======================

== 20100908001428 AddOwnerToWorkspaces: migrating =============================
-- add_column(:workspaces, :owner_id, :integer)
   -> 0.0006s
== 20100908001428 AddOwnerToWorkspaces: migrated (0.0007s) ====================

== 20100911122000 AddReportTemplates: migrating ===============================
-- create_table(:report_templates)
   -> 0.0022s
== 20100911122000 AddReportTemplates: migrated (0.0023s) ======================

== 20100916151530 RequireAdminFlag: migrating =================================
-- change_column(:users, :admin, :boolean, {:null=>false, :default=>true})
   -> 0.0037s
== 20100916151530 RequireAdminFlag: migrated (0.0081s) ========================

== 20100916175000 AddCampaignsAndTemplates: migrating =========================
-- create_table(:campaigns)
   -> 0.0035s
-- create_table(:email_templates)
   -> 0.0018s
-- create_table(:attachments)
   -> 0.0029s
-- create_table(:attachments_email_templates, {:id=>false})
   -> 0.0007s
-- create_table(:email_addresses)
   -> 0.0027s
-- create_table(:web_templates)
   -> 0.0023s
== 20100916175000 AddCampaignsAndTemplates: migrated (0.0142s) ================

== 20100920012100 AddGenerateExeColumn: migrating =============================
-- add_column(:email_templates, :generate_exe, :boolean, {:null=>false, :default=>false})
   -> 0.0024s
== 20100920012100 AddGenerateExeColumn: migrated (0.0025s) ====================

== 20100926214000 AddTemplatePrefs: migrating =================================
-- remove_column(:email_templates, :generate_exe)
   -> 0.0006s
-- add_column(:email_templates, :prefs, :text)
   -> 0.0005s
-- add_column(:web_templates, :prefs, :text)
   -> 0.0005s
== 20100926214000 AddTemplatePrefs: migrated (0.0018s) ========================

== 20101001000000 AddWebTables: migrating =====================================
-- create_table(:web_sites)
   -> 0.0026s
-- create_table(:web_pages)
   -> 0.0024s
-- create_table(:web_forms)
   -> 0.0018s
-- create_table(:web_vulns)
   -> 0.0026s
== 20101001000000 AddWebTables: migrated (0.0097s) ============================

== 20101002000000 AddQuery: migrating =========================================
-- add_column(:web_forms, :query, :text)
   -> 0.0012s
-- add_column(:web_vulns, :query, :text)
   -> 0.0005s
== 20101002000000 AddQuery: migrated (0.0019s) ================================

== 20101007000000 AddVulnInfo: migrating ======================================
-- add_column(:web_vulns, :category, :text)
   -> 0.0006s
-- add_column(:web_vulns, :confidence, :text)
   -> 0.0004s
-- add_column(:web_vulns, :description, :text)
   -> 0.0010s
-- add_column(:web_vulns, :blame, :text)
   -> 0.0004s
== 20101007000000 AddVulnInfo: migrated (0.0028s) =============================

== 20101008111800 AddClientsToCampaigns: migrating ============================
-- add_column(:clients, :campaign_id, :integer)
   -> 0.0005s
== 20101008111800 AddClientsToCampaigns: migrated (0.0006s) ===================

== 20101009023300 AddCampaignAttachments: migrating ===========================
-- add_column(:attachments, :campaign_id, :integer)
   -> 0.0006s
== 20101009023300 AddCampaignAttachments: migrated (0.0007s) ==================

== 20101104135100 AddImportedCreds: migrating =================================
-- create_table(:imported_creds)
   -> 0.0030s
== 20101104135100 AddImportedCreds: migrated (0.0031s) ========================

== 20101203000000 FixWebTables: migrating =====================================
-- change_column(:web_pages, :path, :text)
   -> 0.0005s
-- change_column(:web_pages, :query, :text)
   -> 0.0004s
-- change_column(:web_pages, :cookie, :text)
   -> 0.0005s
-- change_column(:web_pages, :auth, :text)
   -> 0.0004s
-- change_column(:web_pages, :ctype, :text)
   -> 0.0004s
-- change_column(:web_pages, :location, :text)
   -> 0.0004s
-- change_column(:web_pages, :path, :text)
   -> 0.0010s
-- change_column(:web_vulns, :path, :text)
   -> 0.0004s
-- change_column(:web_vulns, :pname, :text)
   -> 0.0005s
-- add_column(:web_pages, :request, :text)
   -> 0.0006s
-- add_column(:web_vulns, :request, :text)
   -> 0.0004s
== 20101203000000 FixWebTables: migrated (0.0064s) ============================

== 20101203000001 ExpandHostComment: migrating ================================
-- change_column(:hosts, :comments, :text)
   -> 0.0005s
== 20101203000001 ExpandHostComment: migrated (0.0006s) =======================

== 20101206212033 AddLimitToNetworkToWorkspaces: migrating ====================
-- add_column(:workspaces, :limit_to_network, :boolean, {:null=>false, :default=>false})
   -> 0.0029s
== 20101206212033 AddLimitToNetworkToWorkspaces: migrated (0.0030s) ===========

== 20110112154300 AddModuleUuidToTasks: migrating =============================
-- add_column(:tasks, :module_uuid, :string, {:limit=>8})
   -> 0.0007s
== 20110112154300 AddModuleUuidToTasks: migrated (0.0008s) ====================

== 20110204112800 AddHostTags: migrating ======================================
-- create_table(:tags)
   -> 0.0033s
-- create_table(:hosts_tags, {:id=>false})
   -> 0.0013s
== 20110204112800 AddHostTags: migrated (0.0047s) =============================

== 20110317144932 AddSessionTable: migrating ==================================
-- create_table(:sessions)
   -> 0.0032s
-- create_table(:session_events)
   -> 0.0019s
== 20110317144932 AddSessionTable: migrated (0.0094s) =========================

== 20110414180600 AddLocalIdToSessionTable: migrating =========================
-- add_column(:sessions, :local_id, :integer)
   -> 0.0007s
== 20110414180600 AddLocalIdToSessionTable: migrated (0.0008s) ================

== 20110415175705 AddRoutesTable: migrating ===================================
-- create_table(:routes)
   -> 0.0024s
-- remove_column(:sessions, :routes)
   -> 0.0005s
== 20110415175705 AddRoutesTable: migrated (0.0029s) ==========================

== 20110422000000 ConvertBinary: migrating ====================================
-- rename_column(:web_pages, :body, :body_text)
   -> 0.0014s
-- rename_column(:web_pages, :request, :request_text)
   -> 0.0011s
-- rename_column(:web_vulns, :request, :request_text)
   -> 0.0012s
-- rename_column(:web_vulns, :proof, :proof_text)
   -> 0.0011s
-- add_column(:web_pages, :body, :binary)
   -> 0.0005s
-- add_column(:web_pages, :request, :binary)
   -> 0.0005s
-- add_column(:web_vulns, :request, :binary)
   -> 0.0006s
-- add_column(:web_vulns, :proof, :binary)
   -> 0.0006s
-- remove_column(:web_pages, :body_text)
   -> 0.0006s
-- remove_column(:web_pages, :request_text)
   -> 0.0006s
-- remove_column(:web_vulns, :request_text)
   -> 0.0004s
-- remove_column(:web_vulns, :proof_text)
   -> 0.0004s
== 20110422000000 ConvertBinary: migrated (0.0169s) ===========================

== 20110425095900 AddLastSeenToSessions: migrating ============================
-- add_column(:sessions, :last_seen, :timestamp)
   -> 0.0006s
== 20110425095900 AddLastSeenToSessions: migrated (0.0007s) ===================

== 20110513143900 TrackSuccessfulExploits: migrating ==========================
-- add_column(:vulns, :exploited_at, :timestamp)
   -> 0.0010s
== 20110513143900 TrackSuccessfulExploits: migrated (0.0035s) =================

== 20110517160800 RenameAndPruneNessusVulns: migrating ========================
== 20110517160800 RenameAndPruneNessusVulns: migrated (0.0021s) ===============

== 20110527000000 AddTaskIdToReportsTable: migrating ==========================
-- add_column(:reports, :task_id, :integer)
   -> 0.0007s
== 20110527000000 AddTaskIdToReportsTable: migrated (0.0007s) =================

== 20110527000001 AddApiKeysTable: migrating ==================================
-- create_table(:api_keys)
   -> 0.0020s
== 20110527000001 AddApiKeysTable: migrated (0.0020s) =========================

== 20110606000001 AddMacrosTable: migrating ===================================
-- create_table(:macros)
   -> 0.0019s
== 20110606000001 AddMacrosTable: migrated (0.0021s) ==========================

== 20110622000000 AddSettingsToTasksTable: migrating ==========================
-- add_column(:tasks, :settings, :binary)
   -> 0.0007s
== 20110622000000 AddSettingsToTasksTable: migrated (0.0008s) =================

== 20110624000001 AddListenersTable: migrating ================================
-- create_table(:listeners)
   -> 0.0033s
== 20110624000001 AddListenersTable: migrated (0.0034s) =======================

== 20110625000001 AddMacroToListenersTable: migrating =========================
-- add_column(:listeners, :macro, :text)
   -> 0.0006s
== 20110625000001 AddMacroToListenersTable: migrated (0.0007s) ================

== 20110630000001 AddNexposeConsolesTable: migrating ==========================
-- create_table(:nexpose_consoles)
   -> 0.0028s
== 20110630000001 AddNexposeConsolesTable: migrated (0.0036s) =================

== 20110630000002 AddNameToNexposeConsolesTable: migrating ====================
-- add_column(:nexpose_consoles, :name, :text)
   -> 0.0007s
== 20110630000002 AddNameToNexposeConsolesTable: migrated (0.0008s) ===========

== 20110717000001 AddProfilesTable: migrating =================================
-- create_table(:profiles)
   -> 0.0023s
== 20110717000001 AddProfilesTable: migrated (0.0031s) ========================

== 20110727163801 ExpandCredPtypeColumn: migrating ============================
-- change_column(:creds, :ptype, :string, {:limit=>256})
   -> 0.0006s
== 20110727163801 ExpandCredPtypeColumn: migrated (0.0007s) ===================

== 20110730000001 AddInitialIndexes: migrating ================================
-- add_index(:hosts, :address)
   -> 0.0026s
-- add_index(:hosts, :address6)
   -> 0.0018s
-- add_index(:hosts, :name)
   -> 0.0019s
-- add_index(:hosts, :state)
   -> 0.0024s
-- add_index(:hosts, :os_name)
   -> 0.0036s
-- add_index(:hosts, :os_flavor)
   -> 0.0019s
-- add_index(:hosts, :purpose)
   -> 0.0027s
-- add_index(:services, :port)
   -> 0.0019s
-- add_index(:services, :proto)
   -> 0.0019s
-- add_index(:services, :state)
   -> 0.0020s
-- add_index(:services, :name)
   -> 0.0026s
-- add_index(:notes, :ntype)
   -> 0.0018s
-- add_index(:vulns, :name)
   -> 0.0025s
-- add_index(:refs, :name)
   -> 0.0019s
-- add_index(:web_sites, :vhost)
   -> 0.0021s
-- add_index(:web_sites, :comments)
   -> 0.0025s
-- add_index(:web_sites, :options)
   -> 0.0019s
-- add_index(:web_pages, :path)
   -> 0.0020s
-- add_index(:web_pages, :query)
   -> 0.0027s
-- add_index(:web_forms, :path)
   -> 0.0019s
-- add_index(:web_vulns, :path)
   -> 0.0019s
-- add_index(:web_vulns, :method)
   -> 0.0023s
-- add_index(:web_vulns, :name)
   -> 0.0019s
== 20110730000001 AddInitialIndexes: migrated (0.0526s) =======================

== 20110812000001 PruneIndexes: migrating =====================================
-- indexes(:hosts)
   -> 0.0034s
-- indexes(:services)
   -> 0.0023s
-- indexes(:vulns)
   -> 0.0013s
== 20110812000001 PruneIndexes: migrated (0.0080s) ============================

== 20110922000000 ExpandNotes: migrating ======================================
-- change_column(:notes, :data, :text)
   -> 0.0005s
== 20110922000000 ExpandNotes: migrated (0.0006s) =============================

== 20110928101300 AddModRefTable: migrating ===================================
-- create_table(:mod_refs)
   -> 0.0021s
== 20110928101300 AddModRefTable: migrated (0.0022s) ==========================

== 20111011110000 AddDisplayNameToReportsTable: migrating =====================
-- add_column(:reports, :name, :string, {:limit=>63})
   -> 0.0006s
== 20111011110000 AddDisplayNameToReportsTable: migrated (0.0040s) ============

== 20111203000000 InetColumns: migrating ======================================
-- change_column(:hosts, :address, "INET using address::INET")
   -> 0.0033s
-- remove_column(:hosts, :address6)
   -> 0.0005s
== 20111203000000 InetColumns: migrated (0.0040s) =============================

== 20111204000000 MoreInetColumns: migrating ==================================
-- change_column(:wmap_requests, :address, "INET using address::INET")
   -> 0.0021s
-- remove_column(:wmap_requests, :address6)
   -> 0.0004s
-- change_column(:wmap_targets, :address, "INET using address::INET")
   -> 0.0019s
-- remove_column(:wmap_targets, :address6)
   -> 0.0004s
== 20111204000000 MoreInetColumns: migrated (0.0052s) =========================

== 20111210000000 AddScopeToHosts: migrating ==================================
-- add_column(:hosts, :scope, :text)
   -> 0.0007s
== 20111210000000 AddScopeToHosts: migrated (0.0008s) =========================

== 20120126110000 AddVirtualHostToHosts: migrating ============================
-- add_column(:hosts, :virtual_host, :text)
   -> 0.0007s
== 20120126110000 AddVirtualHostToHosts: migrated (0.0008s) ===================

== 20120411173220 RenameWorkspaceMembers: migrating ===========================
-- rename_table(:project_members, :workspace_members)
   -> 0.0042s
== 20120411173220 RenameWorkspaceMembers: migrated (0.0043s) ==================

== 20120601152442 AddCounterCachesToHosts: migrating ==========================
-- add_column(:hosts, :note_count, :integer, {:default=>0})
   -> 0.0035s
-- add_column(:hosts, :vuln_count, :integer, {:default=>0})
   -> 0.0035s
-- add_column(:hosts, :service_count, :integer, {:default=>0})
   -> 0.0030s
== 20120601152442 AddCounterCachesToHosts: migrated (0.0140s) =================

== 20120625000000 AddVulnDetails: migrating ===================================
-- create_table(:vuln_details)
   -> 0.0030s
== 20120625000000 AddVulnDetails: migrated (0.0031s) ==========================

== 20120625000001 AddHostDetails: migrating ===================================
-- create_table(:host_details)
   -> 0.0017s
== 20120625000001 AddHostDetails: migrated (0.0018s) ==========================

== 20120625000002 ExpandDetails: migrating ====================================
-- add_column(:vuln_details, :nx_vuln_status, :text)
   -> 0.0012s
-- add_column(:vuln_details, :nx_proof_key, :text)
   -> 0.0004s
-- add_column(:vuln_details, :src, :string)
   -> 0.0005s
-- add_column(:host_details, :src, :string)
   -> 0.0009s
== 20120625000002 ExpandDetails: migrated (0.0034s) ===========================

== 20120625000003 ExpandDetails2: migrating ===================================
-- add_column(:host_details, :nx_site_name, :string)
   -> 0.0006s
-- add_column(:host_details, :nx_site_importance, :string)
   -> 0.0006s
-- add_column(:host_details, :nx_scan_template, :string)
   -> 0.0010s
-- add_column(:host_details, :nx_risk_score, :float)
   -> 0.0005s
-- add_column(:vuln_details, :nx_scan_id, :integer)
   -> 0.0005s
-- add_column(:vuln_details, :nx_vulnerable_since, :timestamp)
   -> 0.0005s
-- add_column(:vuln_details, :nx_pci_compliance_status, :string)
   -> 0.0012s
== 20120625000003 ExpandDetails2: migrated (0.0054s) ==========================

== 20120625000004 AddVulnAttempts: migrating ==================================
-- create_table(:vuln_attempts)
   -> 0.0020s
== 20120625000004 AddVulnAttempts: migrated (0.0022s) =========================

== 20120625000005 AddVulnAndHostCounterCaches: migrating ======================
-- add_column(:hosts, :host_detail_count, :integer, {:default=>0})
   -> 0.0033s
-- add_column(:vulns, :vuln_detail_count, :integer, {:default=>0})
   -> 0.0022s
-- add_column(:vulns, :vuln_attempt_count, :integer, {:default=>0})
   -> 0.0059s
== 20120625000005 AddVulnAndHostCounterCaches: migrated (0.0117s) =============

== 20120625000006 AddModuleDetails: migrating =================================
-- create_table(:module_details)
   -> 0.0025s
-- add_index(:module_details, :refname)
   -> 0.0020s
-- add_index(:module_details, :name)
   -> 0.0018s
-- add_index(:module_details, :description)
   -> 0.0020s
-- add_index(:module_details, :mtype)
   -> 0.0018s
-- create_table(:module_authors)
   -> 0.0019s
-- add_index(:module_authors, :module_detail_id)
   -> 0.0025s
-- create_table(:module_mixins)
   -> 0.0019s
-- add_index(:module_mixins, :module_detail_id)
   -> 0.0020s
-- create_table(:module_targets)
   -> 0.0024s
-- add_index(:module_targets, :module_detail_id)
   -> 0.0018s
-- create_table(:module_actions)
   -> 0.0017s
-- add_index(:module_actions, :module_detail_id)
   -> 0.0023s
-- create_table(:module_refs)
   -> 0.0016s
-- add_index(:module_refs, :module_detail_id)
   -> 0.0018s
-- add_index(:module_refs, :name)
   -> 0.0020s
-- create_table(:module_archs)
   -> 0.0018s
-- add_index(:module_archs, :module_detail_id)
   -> 0.0018s
-- create_table(:module_platforms)
   -> 0.0019s
-- add_index(:module_platforms, :module_detail_id)
   -> 0.0019s
== 20120625000006 AddModuleDetails: migrated (0.0406s) ========================

== 20120625000007 AddExploitAttempts: migrating ===============================
-- create_table(:exploit_attempts)
   -> 0.0025s
-- add_column(:hosts, :exploit_attempt_count, :integer, {:default=>0})
   -> 0.0034s
== 20120625000007 AddExploitAttempts: migrated (0.0060s) ======================

== 20120625000008 AddFailMessage: migrating ===================================
-- add_column(:vuln_attempts, :fail_detail, :text)
   -> 0.0006s
-- add_column(:exploit_attempts, :fail_detail, :text)
   -> 0.0005s
== 20120625000008 AddFailMessage: migrated (0.0015s) ==========================

== 20120718202805 AddOwnerAndPayloadToWebVulns: migrating =====================
-- add_column(:web_vulns, :owner, :string)
   -> 0.0007s
-- add_column(:web_vulns, :payload, :text)
   -> 0.0007s
== 20120718202805 AddOwnerAndPayloadToWebVulns: migrated (0.0015s) ============

== 20130228214900 ChangeRequiredColumnsToNullFalseInWebVulns: migrating =======
-- change_column_null(:web_vulns, :category, false)
   -> 0.0005s
-- change_column_null(:web_vulns, :confidence, false)
   -> 0.0004s
-- change_column_null(:web_vulns, :method, false)
   -> 0.0005s
-- change_column_null(:web_vulns, :name, false)
   -> 0.0003s
-- change_column_null(:web_vulns, :params, false)
   -> 0.0006s
-- change_column_null(:web_vulns, :path, false)
   -> 0.0004s
-- change_column_null(:web_vulns, :pname, false)
   -> 0.0004s
-- change_column_null(:web_vulns, :proof, false)
   -> 0.0003s
-- change_column_null(:web_vulns, :risk, false)
   -> 0.0005s
== 20130228214900 ChangeRequiredColumnsToNullFalseInWebVulns: migrated (0.0046s) 

== 20130412154159 ChangeForeignKeyInModuleActions: migrating ==================
-- rename_column(:module_actions, :module_detail_id, :detail_id)
   -> 0.0023s
== 20130412154159 ChangeForeignKeyInModuleActions: migrated (0.0024s) =========

== 20130412171844 ChangeForeignKeyInModuleArchs: migrating ====================
-- rename_column(:module_archs, :module_detail_id, :detail_id)
   -> 0.0023s
== 20130412171844 ChangeForeignKeyInModuleArchs: migrated (0.0023s) ===========

== 20130412173121 ChangeForeignKeyInModuleAuthors: migrating ==================
-- rename_column(:module_authors, :module_detail_id, :detail_id)
   -> 0.0019s
== 20130412173121 ChangeForeignKeyInModuleAuthors: migrated (0.0020s) =========

== 20130412173640 ChangeForeignKeyInModuleMixins: migrating ===================
-- rename_column(:module_mixins, :module_detail_id, :detail_id)
   -> 0.0020s
== 20130412173640 ChangeForeignKeyInModuleMixins: migrated (0.0021s) ==========

== 20130412174254 ChangeForeignKeyInModulePlatforms: migrating ================
-- rename_column(:module_platforms, :module_detail_id, :detail_id)
   -> 0.0020s
== 20130412174254 ChangeForeignKeyInModulePlatforms: migrated (0.0020s) =======

== 20130412174719 ChangeForeignKeyInModuleRefs: migrating =====================
-- rename_column(:module_refs, :module_detail_id, :detail_id)
   -> 0.0022s
== 20130412174719 ChangeForeignKeyInModuleRefs: migrated (0.0023s) ============

== 20130412175040 ChangeForeignKeyInModuleTargets: migrating ==================
-- rename_column(:module_targets, :module_detail_id, :detail_id)
   -> 0.0021s
== 20130412175040 ChangeForeignKeyInModuleTargets: migrated (0.0021s) =========

== 20130423211152 AddCredsCounterCache: migrating =============================
-- add_column(:hosts, :cred_count, :integer, {:default=>0})
   -> 0.0036s
== 20130423211152 AddCredsCounterCache: migrated (0.0064s) ====================

== 20130430151353 ChangeRequiredColumnsToNullFalseInHosts: migrating ==========
-- change_column_null(:hosts, :address, false)
   -> 0.0005s
-- change_column_null(:hosts, :workspace_id, false)
   -> 0.0005s
== 20130430151353 ChangeRequiredColumnsToNullFalseInHosts: migrated (0.0011s) =

== 20130430162145 EnforceAddressUniquenessInWorkspaceInHosts: migrating =======
-- change_table(:hosts)
   -> 0.0037s
== 20130430162145 EnforceAddressUniquenessInWorkspaceInHosts: migrated (0.0047s) 

== 20130510021637 RemoveCampaigns: migrating ==================================
-- drop_table(:attachments)
   -> 0.0010s
-- drop_table(:attachments_email_templates)
   -> 0.0006s
-- drop_table(:email_addresses)
   -> 0.0010s
-- drop_table(:email_templates)
   -> 0.0008s
-- drop_table(:web_templates)
   -> 0.0009s
-- drop_table(:campaigns)
   -> 0.0016s
== 20130510021637 RemoveCampaigns: migrated (0.0064s) =========================

== 20130515164311 ChangeWebVulnsConfidenceToInteger: migrating ================
-- execute("ALTER TABLE web_vulns ALTER COLUMN confidence TYPE integer USING confidence::integer")
   -> 0.0024s
== 20130515164311 ChangeWebVulnsConfidenceToInteger: migrated (0.0025s) =======

== 20130515172727 ValidMdmWebVulnParams: migrating ============================
== 20130515172727 ValidMdmWebVulnParams: migrated (0.0068s) ===================

== 20130516204810 MakingVulnsRefsARealArModel: migrating ======================
-- add_column(:vulns_refs, :id, :primary_key)
   -> 0.0021s
== 20130516204810 MakingVulnsRefsARealArModel: migrated (0.0021s) =============

== 20130522001343 CreateTaskCreds: migrating ==================================
-- create_table(:task_creds)
   -> 0.0015s
== 20130522001343 CreateTaskCreds: migrated (0.0016s) =========================

== 20130522032517 CreateTaskHosts: migrating ==================================
-- create_table(:task_hosts)
   -> 0.0016s
== 20130522032517 CreateTaskHosts: migrated (0.0022s) =========================

== 20130522041110 CreateTaskServices: migrating ===============================
-- create_table(:task_services)
   -> 0.0021s
== 20130522041110 CreateTaskServices: migrated (0.0022s) ======================

== 20130525015035 RemoveCampaignIdFromClients: migrating ======================
-- remove_column(:clients, :campaign_id)
   -> 0.0006s
== 20130525015035 RemoveCampaignIdFromClients: migrated (0.0007s) =============

== 20130525212420 DropTableImportedCreds: migrating ===========================
-- drop_table(:imported_creds)
   -> 0.0010s
== 20130525212420 DropTableImportedCreds: migrated (0.0010s) ==================

== 20130531144949 MakingHostTagsARealArModel: migrating =======================
-- add_column(:hosts_tags, :id, :primary_key)
   -> 0.0020s
== 20130531144949 MakingHostTagsARealArModel: migrated (0.0021s) ==============

== 20130604145732 CreateTaskSessions: migrating ===============================
-- create_table(:task_sessions)
   -> 0.0016s
== 20130604145732 CreateTaskSessions: migrated (0.0021s) ======================

== 20130717150737 RemovePnameValidation: migrating ============================
-- change_column(:web_vulns, :pname, :text, {:null=>true})
   -> 0.0008s
== 20130717150737 RemovePnameValidation: migrated (0.0009s) ===================

== 20131002004641 CreateAutomaticExploitationMatches: migrating ===============
-- create_table(:automatic_exploitation_matches)
   -> 0.0022s
-- add_index(:automatic_exploitation_matches, :ref_id)
   -> 0.0019s
== 20131002004641 CreateAutomaticExploitationMatches: migrated (0.0043s) ======

== 20131002164449 CreateAutomaticExploitationMatchSets: migrating =============
-- create_table(:automatic_exploitation_match_sets)
   -> 0.0016s
-- add_index(:automatic_exploitation_match_sets, :user_id)
   -> 0.0019s
-- add_index(:automatic_exploitation_match_sets, :workspace_id)
   -> 0.0017s
== 20131002164449 CreateAutomaticExploitationMatchSets: migrated (0.0055s) ====

== 20131008213344 CreateAutomaticExploitationRuns: migrating ==================
-- create_table(:automatic_exploitation_runs)
   -> 0.0016s
== 20131008213344 CreateAutomaticExploitationRuns: migrated (0.0017s) =========

== 20131011184338 ModuleDetailOnAutomaticExploitationMatch: migrating =========
-- rename_column(:automatic_exploitation_matches, :ref_id, :module_detail_id)
   -> 0.0019s
-- add_column(:automatic_exploitation_matches, :match_set_id, :integer)
   -> 0.0005s
== 20131011184338 ModuleDetailOnAutomaticExploitationMatch: migrated (0.0026s) 

== 20131017150735 CreateAutomaticExploitationMatchResults: migrating ==========
-- create_table(:automatic_exploitation_match_results)
   -> 0.0021s
== 20131017150735 CreateAutomaticExploitationMatchResults: migrated (0.0021s) =

== 20131021185657 MakeMatchPolymorphic: migrating =============================
-- add_column(:automatic_exploitation_matches, :matchable_type, :string)
   -> 0.0006s
-- add_column(:automatic_exploitation_matches, :matchable_id, :integer)
   -> 0.0005s
== 20131021185657 MakeMatchPolymorphic: migrated (0.0012s) ====================

== 20140331173835 CreateMetasploitCredentialPublics: migrating ================
-- create_table(:metasploit_credential_publics)
   -> 0.0019s
-- change_table(:metasploit_credential_publics)
   -> 0.0020s
== 20140331173835 CreateMetasploitCredentialPublics: migrated (0.0041s) =======

== 20140407212345 CreateMetasploitCredentialPrivates: migrating ===============
-- create_table(:metasploit_credential_privates)
   -> 0.0019s
-- change_table(:metasploit_credential_privates)
   -> 0.0019s
== 20140407212345 CreateMetasploitCredentialPrivates: migrated (0.0039s) ======

== 20140410132401 CreateMetasploitCredentialRealms: migrating =================
-- create_table(:metasploit_credential_realms)
   -> 0.0020s
== 20140410132401 CreateMetasploitCredentialRealms: migrated (0.0021s) ========

== 20140410161611 UniqueMetasploitCredentialRealms: migrating =================
-- change_table(:metasploit_credential_realms)
   -> 0.0019s
== 20140410161611 UniqueMetasploitCredentialRealms: migrated (0.0020s) ========

== 20140410191213 CreateMetasploitCredentialOriginManuals: migrating ==========
-- create_table(:metasploit_credential_origin_manuals)
   -> 0.0016s
-- add_index(:metasploit_credential_origin_manuals, :user_id)
   -> 0.0017s
== 20140410191213 CreateMetasploitCredentialOriginManuals: migrated (0.0035s) =

== 20140410205410 CreateMetasploitCredentialOriginImports: migrating ==========
-- create_table(:metasploit_credential_origin_imports)
   -> 0.0019s
-- add_index(:metasploit_credential_origin_imports, :task_id)
   -> 0.0018s
== 20140410205410 CreateMetasploitCredentialOriginImports: migrated (0.0039s) =

== 20140411142102 CreateMetasploitCredentialOriginSessions: migrating =========
-- create_table(:metasploit_credential_origin_sessions)
   -> 0.0019s
-- add_index(:metasploit_credential_origin_sessions, [:session_id, :post_reference_name], {:name=>:unique_metasploit_credential_origin_sessions, :unique=>true})
   -> 0.0019s
== 20140411142102 CreateMetasploitCredentialOriginSessions: migrated (0.0040s) 

== 20140411205325 CreateMetasploitCredentialOriginServices: migrating =========
-- create_table(:metasploit_credential_origin_services)
   -> 0.0023s
-- add_index(:metasploit_credential_origin_services, [:service_id, :module_full_name], {:name=>:unique_metasploit_credential_origin_services, :unique=>true})
   -> 0.0020s
== 20140411205325 CreateMetasploitCredentialOriginServices: migrated (0.0044s) 

== 20140414192550 CreateMetasploitCredentialCores: migrating ==================
-- create_table(:metasploit_credential_cores)
   -> 0.0022s
-- change_table(:metasploit_credential_cores)
   -> 0.0088s
== 20140414192550 CreateMetasploitCredentialCores: migrated (0.0111s) =========

== 20140417140933 CreateMetasploitCredentialLogins: migrating =================
-- create_table(:metasploit_credential_logins)
   -> 0.0022s
-- change_table(:metasploit_credential_logins)
   -> 0.0037s
== 20140417140933 CreateMetasploitCredentialLogins: migrated (0.0060s) ========

== 20140520140817 AddLoginsCounterCacheToCores: migrating =====================
-- add_column(:metasploit_credential_cores, :logins_count, :integer, {:default=>0})
   -> 0.0032s
== 20140520140817 AddLoginsCounterCacheToCores: migrated (0.0055s) ============

== 20140603163708 AddJtrFormatToMetasploitCredentialPrivates: migrating =======
-- add_column(:metasploit_credential_privates, :jtr_format, :string)
   -> 0.0007s
== 20140603163708 AddJtrFormatToMetasploitCredentialPrivates: migrated (0.0008s) 

== 20140605173747 CreateMetasploitCredentialOriginCrackedPasswords: migrating =
-- create_table(:metasploit_credential_origin_cracked_passwords)
   -> 0.0016s
-- add_index(:metasploit_credential_origin_cracked_passwords, :metasploit_credential_core_id, {:name=>:originating_credential_cores})
   -> 0.0020s
== 20140605173747 CreateMetasploitCredentialOriginCrackedPasswords: migrated (0.0038s) 

== 20140702184622 CreateCredentialCoresTasksJoinTable: migrating ==============
-- create_table(:credential_cores_tasks, {:force=>true, :id=>false})
   -> 0.0012s
== 20140702184622 CreateCredentialCoresTasksJoinTable: migrated (0.0013s) =====

== 20140703144541 CreateCredentialLoginsTasksJoinTable: migrating =============
-- create_table(:credential_logins_tasks, {:force=>true, :id=>false})
   -> 0.0013s
== 20140703144541 CreateCredentialLoginsTasksJoinTable: migrated (0.0014s) ====

== 20140722174919 OldCredsToNewCreds: migrating ===============================
== 20140722174919 OldCredsToNewCreds: migrated (0.0078s) ======================

== 20140728191933 UniqueMetasploitCredentialCores: migrating ==================
-- execute("CREATE UNIQUE INDEX unique_complete_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, private_id, public_id) WHERE private_id IS NOT NULL AND public_id IS NOT NULL")
   -> 0.0009s
-- execute("CREATE UNIQUE INDEX unique_private_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, private_id) WHERE private_id IS NOT NULL AND public_id IS NULL")
   -> 0.0006s
-- execute("CREATE UNIQUE INDEX unique_public_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, public_id) WHERE private_id IS NULL AND public_id IS NOT NULL")
   -> 0.0007s
== 20140728191933 UniqueMetasploitCredentialCores: migrated (0.0024s) =========

== 20140801150537 UniqueMetasploitCredentialCoresWithRealmId: migrating =======
-- execute("DROP INDEX unique_complete_metasploit_credential_cores")
   -> 0.0005s
-- execute("DROP INDEX unique_private_metasploit_credential_cores")
   -> 0.0003s
-- execute("DROP INDEX unique_public_metasploit_credential_cores")
   -> 0.0005s
-- execute("CREATE UNIQUE INDEX unique_private_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, private_id) WHERE realm_id IS NULL AND public_id IS NULL AND private_id IS NOT NULL")
   -> 0.0007s
-- execute("CREATE UNIQUE INDEX unique_public_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, public_id) WHERE realm_id IS NULL AND public_id IS NOT NULL AND private_id IS NULL")
   -> 0.0007s
-- execute("CREATE UNIQUE INDEX unique_realmless_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, public_id, private_id) WHERE realm_id IS NULL AND public_id IS NOT NULL AND private_id IS NOT NULL")
   -> 0.0006s
-- execute("CREATE UNIQUE INDEX unique_publicless_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, realm_id, private_id) WHERE realm_id IS NOT NULL AND public_id IS NULL AND private_id IS NOT NULL")
   -> 0.0006s
-- execute("CREATE UNIQUE INDEX unique_privateless_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, realm_id, public_id) WHERE realm_id IS NOT NULL AND public_id IS NOT NULL AND private_id IS NULL")
   -> 0.0006s
-- execute("CREATE UNIQUE INDEX unique_complete_metasploit_credential_cores ON metasploit_credential_cores (workspace_id, realm_id, public_id, private_id) WHERE realm_id IS NOT NULL AND public_id IS NOT NULL AND private_id IS NOT NULL")
   -> 0.0007s
== 20140801150537 UniqueMetasploitCredentialCoresWithRealmId: migrated (0.0064s) 

== 20140905031549 AddDetectedArchToHost: migrating ============================
-- add_column(:hosts, :detected_arch, :string, {:null=>true})
   -> 0.0007s
== 20140905031549 AddDetectedArchToHost: migrated (0.0007s) ===================

== 20140922170030 AddTypetoPublic: migrating ==================================
-- change_table(:metasploit_credential_publics)
-- execute("UPDATE metasploit_credential_publics SET type = 'Metasploit::Credential::Username'")
   -> 0.0004s
-- change_column(:metasploit_credential_publics, :type, :string, {:null=>false})
   -> 0.0008s
   -> 0.0020s
== 20140922170030 AddTypetoPublic: migrated (0.0021s) =========================

== 20150106201450 OldCredsToNewCreds2: migrating ==============================
== 20150106201450 OldCredsToNewCreds2: migrated (0.0009s) =====================

== 20150112203945 RemoveDuplicateServices: migrating ==========================
-- add_index(:services, [:host_id, :port, :proto], {:unique=>true})
   -> 0.0020s
== 20150112203945 RemoveDuplicateServices: migrated (0.0059s) =================

== 20150205192745 DropServiceUniquenessIndex: migrating =======================
-- remove_index(:services, :host_id_and_port_and_proto)
   -> 0.0013s
== 20150205192745 DropServiceUniquenessIndex: migrated (0.0014s) ==============

== 20150209195939 AddVulnIdToNote: migrating ==================================
-- add_column(:notes, :vuln_id, :integer)
   -> 0.0006s
-- add_index(:notes, :vuln_id)
   -> 0.0019s
== 20150209195939 AddVulnIdToNote: migrated (0.0026s) =========================

== 20150212214222 RemoveDuplicateServices2: migrating =========================
-- add_index(:services, [:host_id, :port, :proto], {:unique=>true})
   -> 0.0019s
== 20150212214222 RemoveDuplicateServices2: migrated (0.0028s) ================

== 20150219173821 CreateModuleRuns: migrating =================================
-- create_table(:module_runs)
   -> 0.0023s
-- add_index(:module_runs, :session_id)
   -> 0.0019s
-- add_index(:module_runs, :user_id)
   -> 0.0018s
== 20150219173821 CreateModuleRuns: migrated (0.0063s) ========================

== 20150219215039 AddModuleRunToSession: migrating ============================
-- change_table(:sessions)
   -> 0.0007s
-- add_index(:sessions, :module_run_id)
   -> 0.0019s
== 20150219215039 AddModuleRunToSession: migrated (0.0027s) ===================

== 20150226151459 AddModuleRunFkToLoot: migrating =============================
-- change_table(:loots)
   -> 0.0023s
== 20150226151459 AddModuleRunFkToLoot: migrated (0.0023s) ====================

== 20150312155312 AddModuleFullNameToMatch: migrating =========================
-- add_column(:automatic_exploitation_matches, :module_fullname, :text)
   -> 0.0006s
-- add_index(:automatic_exploitation_matches, :module_fullname)
   -> 0.0018s
== 20150312155312 AddModuleFullNameToMatch: migrated (0.0025s) ================

== 20150317145455 RenameModuleIndices: migrating ==============================
== 20150317145455 RenameModuleIndices: migrated (0.0011s) =====================

== 20150326183742 AddMissingAeIndices: migrating ==============================
-- add_index(:automatic_exploitation_match_results, :match_id)
   -> 0.0018s
-- add_index(:automatic_exploitation_match_results, :run_id)
   -> 0.0019s
-- add_index(:automatic_exploitation_runs, :match_set_id)
   -> 0.0018s
-- add_index(:automatic_exploitation_runs, :user_id)
   -> 0.0020s
-- add_index(:automatic_exploitation_runs, :workspace_id)
   -> 0.0017s
== 20150326183742 AddMissingAeIndices: migrated (0.0098s) =====================

== 20150421211719 RenameAutomaticExploitationIndex: migrating =================
-- index_name_exists?(:automatic_exploitation_matches, :index_automatic_exploitation_matches_on_ref_id, false)
   -> 0.0008s
== 20150421211719 RenameAutomaticExploitationIndex: migrated (0.0008s) ========

== 20150514182921 AddOriginToMdmVuln: migrating ===============================
-- add_column(:vulns, :origin_id, :integer)
   -> 0.0006s
-- add_column(:vulns, :origin_type, :string)
   -> 0.0004s
-- add_index(:vulns, :origin_id)
   -> 0.0018s
== 20150514182921 AddOriginToMdmVuln: migrated (0.0030s) ======================

== 20160415153312 RemoveNotNullFromWebVulnPArams: migrating ===================
-- change_column_null(:web_vulns, :params, true)
   -> 0.0005s
== 20160415153312 RemoveNotNullFromWebVulnPArams: migrated (0.0005s) ==========

== 20161004165612 AddFingerprintedToWorkspace: migrating ======================
-- add_column(:workspaces, :import_fingerprint, :boolean, {:default=>false})
   -> 0.0026s
== 20161004165612 AddFingerprintedToWorkspace: migrated (0.0026s) =============

== 20161107153145 RecreateIndexOnPrivateDataAndType: migrating ================
-- remove_index(:metasploit_credential_privates, [:type, :data])
   -> 0.0012s
-- change_table(:metasploit_credential_privates)
   -> 0.0020s
== 20161107153145 RecreateIndexOnPrivateDataAndType: migrated (0.0034s) =======

== 20161107203710 CreateIndexOnPrivateDataAndTypeForSshKey: migrating =========
-- execute("CREATE UNIQUE INDEX \"index_metasploit_credential_privates_on_type_and_data_sshkey\" ON\n\"metasploit_credential_privates\" (\"type\", decode(md5(data), 'hex'))\nWHERE type in ('Metasploit::Credential::SSHKey')\n")
   -> 0.0007s
== 20161107203710 CreateIndexOnPrivateDataAndTypeForSshKey: migrated (0.0008s) 

== 20161227212223 AddOsFamilyToHosts: migrating ===============================
-- add_column(:hosts, :os_family, :string)
   -> 0.0007s
== 20161227212223 AddOsFamilyToHosts: migrated (0.0008s) ======================

travis_time:end:0fe0dd1b:start=1495824053301940106,finish=1495824058385529857,duration=5083589751
travis_fold:end:before_script.4
travis_time:start:0120bd6c
$ git diff --exit-code db/schema.rb && $CMD
Warning: the running version of Bundler (1.13.6) is older than the version that created the lockfile (1.15.0). We suggest you upgrade to the latest version of Bundler by running `gem install bundler`.
Fetching gem metadata from https://rubygems.org/............
Fetching version metadata from https://rubygems.org/...
Fetching dependency metadata from https://rubygems.org/..
Resolving dependencies...
Using rake 12.0.0
Using i18n 0.8.1
Using minitest 5.10.2
Using thread_safe 0.3.6
Using builder 3.2.3
Using erubis 2.7.0
Using mini_portile2 2.1.0
Using rack 1.6.8
Using arel 6.0.4
Using public_suffix 2.0.5
Using ffi 1.9.18
Using contracts 0.16.0
Using gherkin 4.1.3
Using cucumber-wire 0.0.1
Using diff-lcs 1.3
Using multi_json 1.12.1
Using multi_test 0.1.2
Using rspec-support 3.6.0
Using thor 0.19.4
Using backports 3.8.0
Using bcrypt 3.1.11
Using bindata 2.4.0
Using bit-struct 0.15.0 from https://github.com/busterb/bit-struct (at ruby-2.4@707133a)
Using mime-types-data 3.2016.0521
Using multipart-post 2.0.0
Using filesize 0.1.1
Using fivemat 1.3.3
Using rkelly-remix 0.0.7
Using json 2.1.0
Using metasm 1.0.3
Using pg 0.20.0
Using pg_array_parser 0.0.9
Using rubyntlm 0.6.2
Using rubyzip 1.2.1
Using metasploit-payloads 1.2.29
Using metasploit_payloads-mettle 0.1.9
Using msgpack 1.1.0
Using nessus_rest 0.1.6
Using net-ssh 4.1.0
Using network_interface 0.0.1
Using nexpose 6.0.0
Using openssl-ccm 1.2.1
Using openvas-omp 0.0.4
Using pcaprub 0.12.4
Using patch_finder 1.0.2
Using rb-readline 0.5.4
Using redcarpet 3.4.0
Using rex-text 0.2.15
Using rex-core 0.1.10
Using rex-struct2 0.1.2
Using rex-java 0.1.5
Using rex-registry 0.1.3
Using robots 0.10.1
Using windows_error 0.1.2
Using sqlite3 1.3.13
Using sshkey 1.9.0
Using method_source 0.8.1 from https://github.com/banister/method_source (at master@0cc6cc8)
Using timecop 0.8.1
Using bundler 1.13.6
Using tzinfo 1.2.3
Using nokogiri 1.7.2
Using rack-test 0.6.3
Using addressable 2.5.1
Using childprocess 0.5.9
Using cucumber-core 1.5.0
Using rspec-expectations 3.6.0
Using rspec-core 3.6.0
Using rspec-mocks 3.6.0
Using mime-types 3.1
Using faraday 0.12.1
Using jsobfu 0.4.2
Using packetfu 1.1.13
Using rex-arch 0.1.4
Using rex-mime 0.1.5
Using rex-ole 0.1.6
Using rex-random_identifier 0.1.2
Using rex-zip 0.1.3
Using rex-rop_builder 0.1.3
Using rex-socket 0.1.6
Using ruby_smb 0.0.17
Using activesupport 4.2.8
Using tzinfo-data 1.2017.2
Using loofah 2.0.3
Using xpath 2.1.0
Using recog 2.1.8
Using cucumber 2.4.0
Using sawyer 0.8.1
Using rex-bin_tools 0.1.3
Using rex-encoder 0.1.4
Using rex-nop 0.1.1
Using rex-powershell 0.1.72
Using rex-sslscan 0.1.4
Using rails-deprecated_sanitizer 1.0.3
Using activemodel 4.2.8
Using factory_girl 4.8.0
Using shoulda-matchers 3.1.1
Using rails-html-sanitizer 1.0.3
Using capybara 2.14.0
Using aruba 0.14.2
Using octokit 4.7.0
Using rex-exploitation 0.1.14
Using rails-dom-testing 1.0.8
Using activerecord 4.2.8
Using actionview 4.2.8
Using arel-helpers 2.4.0
Using postgres_ext 3.0.0
Using actionpack 4.2.8
Using railties 4.2.8
Using cucumber-rails 1.5.0
Using factory_girl_rails 4.8.0
Using metasploit-concern 2.0.4
Using metasploit-model 2.0.4
Using rspec-rails 3.6.0
Using metasploit_data_models 2.0.14
Using metasploit-credential 2.0.9
Using metasploit-framework 4.14.23 from source at `.`
Bundle complete! 17 Gemfile dependencies, 116 gems now installed.
Gems in the groups coverage, development and pcap were not installed.
Bundled gems are installed into ./vendor/bundle.

travis_time:end:0120bd6c:start=1495824058390743475,finish=1495824063656183383,duration=5265439908

The command "git diff --exit-code db/schema.rb && $CMD" exited with 0.
travis_fold:start:cache.2
store build cache
$ bundle clean
Warning: the running version of Bundler (1.13.6) is older than the version that created the lockfile (1.15.0). We suggest you upgrade to the latest version of Bundler by running `gem install bundler`.
Resolving dependencies...
travis_time:start:38765a3c

travis_time:end:38765a3c:start=1495824064273421212,finish=1495824064278291746,duration=4870534
travis_time:start:15a3d3a0
change detected (content changed, file is created, or file is deleted):
/home/travis/build/rapid7/metasploit-framework/vendor/bundle/ruby/2.2.0/bundler/gems/bit-struct-707133ae6af5/.git/index
/home/travis/build/rapid7/metasploit-framework/vendor/bundle/ruby/2.2.0/bundler/gems/bit-struct-707133ae6af5/.git/logs/HEAD
/home/travis/build/rapid7/metasploit-framework/vendor/bundle/ruby/2.2.0/bundler/gems/method_source-0cc6cc8e15d0/.git/index
/home/travis/build/rapid7/metasploit-framework/vendor/bundle/ruby/2.2.0/bundler/gems/method_source-0cc6cc8e15d0/.git/logs/HEAD
/home/travis/build/rapid7/metasploit-framework/vendor/bundle/ruby/2.2.0/bundler/gems/pry-f19d3e2ae86a/.git/index
/home/travis/build/rapid7/metasploit-framework/vendor/bundle/ruby/2.2.0/bundler/gems/pry-f19d3e2ae86a/.git/logs/HEAD


changes detected, packing new archive
.
.
uploading archive

travis_time:end:15a3d3a0:start=1495824064283423246,finish=1495824076997461039,duration=12714037793
travis_fold:end:cache.2

Done. Your build exited with 0.
renpic commented 7 years ago

Sorry for the escape chars inside the pasted log. But it should be possible to see that the rake spec tests are not executed.

alrosenthal-r7 commented 7 years ago

Release Notes

This fix resolves an issue that prevented the rake spec builds from running.