Drupal Quality Assurance

[03:57:11] Log initialized (/var/lib/drupaltestbot/sites/default/files/review.test_1130333.pifr_simpletest.do_not_merge-protected_node-fix_bulk_test-2534644-7.patch.1440327431.log)
[03:57:11] Review timestamp: (Sun, 08/23/2015 - 03:57)
[03:57:11] Review host: (ec2-54-69-10-31)
[03:57:11] Operations:Array
(
    [0] => setup
    [1] => fetch
    [2] => checkout
    [3] => check
    [4] => apply
    [5] => syntax
    [6] => install
    [7] => review
)

[03:57:11] Result Codes: Array
(
    [fail] => 9
    [pass] => 10
)

[03:57:11] Environment variables and review information initialized.
[03:57:11] core_url = [git://git.drupal.org/project/drupal.git];  Test repository = [git://git.drupal.org/project/protected_node.git]
[03:57:11] Project directory is [protected_node]
[03:57:11] Review started.
[03:57:11] Test: Array
(
    [test_id] => 1130333
    [review] => Array
        (
            [plugin] => pifr_simpletest
            [argument] => Array
                (
                    [test.title] => 
                    [test.directory.review] => Array
                        (
                            [0] => sites/default/modules/protected_node
                        )

                    [test.directory.apply] => 
                    [test.directory.dependency] => 
                    [test.files] => Array
                        (
                        )

                    [test.extensions] => Array
                        (
                            [0] => php
                            [1] => inc
                            [2] => install
                            [3] => module
                            [4] => test
                        )

                    [drupal.core.version] => 7
                    [drupal.core.url] => git://git.drupal.org/project/drupal.git
                    [drupal.modules] => Array
                        (
                        )

                    [drupal.user] => admin
                    [drupal.pass] => 
                    [drupal.variables] => Array
                        (
                        )

                    [simpletest.tests] => Array
                        (
                        )

                    [simpletest.db] => 
                    [test.php.version] => 5.3
                )

        )

    [vcs] => Array
        (
            [main] => Array
                (
                    [repository] => Array
                        (
                            [type] => git
                            [url] => git://git.drupal.org/project/drupal.git
                        )

                    [vcs_identifier] => 7.x
                )

            [dependencies] => Array
                (
                    [1] => Array
                        (
                            [repository] => Array
                                (
                                    [type] => git
                                    [url] => git://git.drupal.org/project/views.git
                                )

                            [vcs_identifier] => 7.x-3.11
                        )

                    [2] => Array
                        (
                            [repository] => Array
                                (
                                    [type] => git
                                    [url] => git://git.drupal.org/project/ctools.git
                                )

                            [vcs_identifier] => 7.x-1.7
                        )

                    [3] => Array
                        (
                            [repository] => Array
                                (
                                    [type] => git
                                    [url] => git://git.drupal.org/project/rules.git
                                )

                            [vcs_identifier] => 7.x-2.9
                        )

                    [4] => Array
                        (
                            [repository] => Array
                                (
                                    [type] => git
                                    [url] => git://git.drupal.org/project/entity.git
                                )

                            [vcs_identifier] => 7.x-1.6
                        )

                    [5] => Array
                        (
                            [repository] => Array
                                (
                                    [type] => git
                                    [url] => git://git.drupal.org/project/protected_node.git
                                )

                            [vcs_identifier] => 7.x-1.x
                        )

                )

        )

    [files] => Array
        (
            [0] => https://www.drupal.org/files/issues/do_not_merge-protected_node-fix_bulk_test-2534644-7.patch
        )

)

[03:57:11] Operations: Array
(
    [0] => setup
    [1] => fetch
    [2] => checkout
    [3] => check
    [4] => apply
    [5] => syntax
    [6] => install
    [7] => review
)

[03:57:11] Invoking operation [setup]...
[03:57:11] Command [chmod -R u+rw sites/default/files/checkout 2>&1] succeeded.
[03:57:11] Command [rm -rf sites/default/files/checkout 2>&1] succeeded.
[03:57:11] Command [rm -rf /tmp/po* 2>&1] succeeded.
[03:57:11] Command [rm -rf sites/default/files/review 2>&1] succeeded.
[03:57:11] Database backend [mysql] loaded.
[03:57:11] Invoking operation [fetch]...
[03:57:11] Fetched [do_not_merge-protected_node-fix_bulk_test-2534644-7.patch].
[03:57:11] Invoking operation [checkout]...
[03:57:11] Version control system backend [git] loaded.
[03:57:13] Command [git clone 'git://git.drupal.org/project/drupal.git' 'checkout' --reference /var/cache/git/reference 2>&1] succeeded.
[03:57:14] Command [git --work-tree='checkout' --git-dir='checkout/.git' checkout '7.x' 2>&1] succeeded.
[03:57:14] Command [git --work-tree='checkout' --git-dir='checkout/.git' status 2>&1] succeeded.
[03:57:14] Command [git --work-tree='checkout' --git-dir='checkout/.git' log --oneline -1 2>&1] succeeded
  Duration: 0 seconds
  Directory: [/var/lib/drupaltestbot/sites/default/files]
  Completion status: [0]
  Output: [731dfac Merge tag '7.39' into 7.x].
[03:57:14] Main branch [7.x] checkout [complete].
[03:57:21] Command [git clone 'git://git.drupal.org/project/views.git' '/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/views' --reference /var/cache/git/reference 2>&1] succeeded.
[03:57:21] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/views' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/views/.git' checkout '7.x-3.11' 2>&1] succeeded.
[03:57:21] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/views' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/views/.git' status 2>&1] succeeded.
[03:57:21] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/views' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/views/.git' log --oneline -1 2>&1] succeeded
  Duration: 0 seconds
  Directory: [/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules]
  Completion status: [0]
  Output: [cef693b Issue by das-peter: Ensure that we do not end up with broken views data cache entries.].
[03:57:21] Dependency branch [7.x-3.11] checkout [complete].
[03:57:36] Command [git clone 'git://git.drupal.org/project/ctools.git' '/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/ctools' --reference /var/cache/git/reference 2>&1] succeeded.
[03:57:36] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/ctools' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/ctools/.git' checkout '7.x-1.7' 2>&1] succeeded.
[03:57:36] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/ctools' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/ctools/.git' status 2>&1] succeeded.
[03:57:36] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/ctools' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/ctools/.git' log --oneline -1 2>&1] succeeded
  Duration: 0 seconds
  Directory: [/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules]
  Completion status: [0]
  Output: [7b975e4 ctools 1.7].
[03:57:36] Dependency branch [7.x-1.7] checkout [complete].
[03:57:50] Command [git clone 'git://git.drupal.org/project/rules.git' '/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/rules' --reference /var/cache/git/reference 2>&1] succeeded.
[03:57:50] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/rules' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/rules/.git' checkout '7.x-2.9' 2>&1] succeeded.
[03:57:50] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/rules' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/rules/.git' status 2>&1] succeeded.
[03:57:50] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/rules' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/rules/.git' log --oneline -1 2>&1] succeeded
  Duration: 0 seconds
  Directory: [/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules]
  Completion status: [0]
  Output: [db14bda Issue #2324587 by klausi, das-peter, fago: Rules might be triggered too early in the bootstrap].
[03:57:50] Dependency branch [7.x-2.9] checkout [complete].
[03:58:05] Command [git clone 'git://git.drupal.org/project/entity.git' '/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/entity' --reference /var/cache/git/reference 2>&1] succeeded.
[03:58:05] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/entity' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/entity/.git' checkout '7.x-1.6' 2>&1] succeeded.
[03:58:05] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/entity' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/entity/.git' status 2>&1] succeeded.
[03:58:05] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/entity' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/entity/.git' log --oneline -1 2>&1] succeeded
  Duration: 0 seconds
  Directory: [/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules]
  Completion status: [0]
  Output: [724e719 Patch by klausi: Sanitize field labels before passing them to the Token API.].
[03:58:05] Dependency branch [7.x-1.6] checkout [complete].
[03:58:19] Command [git clone 'git://git.drupal.org/project/protected_node.git' '/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/protected_node' --reference /var/cache/git/reference 2>&1] succeeded.
[03:58:19] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/protected_node' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/protected_node/.git' checkout '7.x-1.x' 2>&1] succeeded.
[03:58:19] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/protected_node' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/protected_node/.git' status 2>&1] succeeded.
[03:58:19] Command [git --work-tree='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/protected_node' --git-dir='/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules/protected_node/.git' log --oneline -1 2>&1] succeeded
  Duration: 0 seconds
  Directory: [/var/lib/drupaltestbot/sites/default/files/checkout/sites/default/modules]
  Completion status: [0]
  Output: [bc8e34d Issue #2548229 by digitgopher, Grimreaper: Flood control support].
[03:58:19] Dependency branch [7.x-1.x] checkout [complete].
[03:58:19] Invoking operation [check]...
[03:58:19] Invoking operation [apply]...
[03:58:19] Command [git apply --check -p1 /var/lib/drupaltestbot/sites/default/files/review/do_not_merge-protected_node-fix_bulk_test-2534644-7.patch 2>&1] succeeded.
[03:58:19] Command [git apply -v -p1 /var/lib/drupaltestbot/sites/default/files/review/do_not_merge-protected_node-fix_bulk_test-2534644-7.patch 2>&1] succeeded.
[03:58:19] Applied [do_not_merge-protected_node-fix_bulk_test-2534644-7.patch] to:
 > protected_node.fork.inc
 > protected_node.redirect.inc
 > tests/protected_node.bulk.test
 > tests/protected_node.fork.test
[03:58:19] Invoking operation [syntax]...
[03:58:19] Command [php -l -f './sites/default/modules/protected_node/protected_node.fork.inc' 2>&1] succeeded.
[03:58:19] Command [php -l -f './sites/default/modules/protected_node/protected_node.redirect.inc' 2>&1] succeeded.
[03:58:19] Command [php -l -f './sites/default/modules/protected_node/tests/protected_node.bulk.test' 2>&1] succeeded.
[03:58:19] Command [php -l -f './sites/default/modules/protected_node/tests/protected_node.fork.test' 2>&1] succeeded.
[03:58:19] Checked [4 of 4] relevant file(s) for syntax.
[03:58:19] Invoking operation [install]...
[03:58:19] drush si command=cd sites/default/files/checkout && drush si -y --db-url=mysql://drupaltestbot-my:kYQMxYXyYtmr@localhost/drupaltestbotmysql --clean-url=0 --account-name=admin --account-pass=drupal --account-mail=admin@example.com
[03:58:23] Command [cd sites/default/files/checkout && drush si -y --db-url=mysql://drupaltestbot-my:kYQMxYXyYtmr@localhost/drupaltestbotmysql --clean-url=0 --account-name=admin --account-pass=drupal --account-mail=admin@example.com 2>&1] succeeded
  Duration: 4 seconds
  Directory: [/var/lib/drupaltestbot]
  Completion status: [0]
  Output: [You are about to create a /var/lib/drupaltestbot/sites/default/files/checkout/sites/default/settings.php file and DROP all tables in your 'drupaltestbotmysql' database. Do you want to continue? (y/n): y
Starting Drupal installation. This takes a while. Consider using the        [ok]
--notify global option.
Installation complete.  User name: admin  User password: drupal             [ok]].
[03:58:23] Command [cd /var/lib/drupaltestbot 2>&1] succeeded.
[03:58:23] Command [cd sites/default/files/checkout && drush vset simpletest_clear_results '0' 2>&1] succeeded
  Duration: 0 seconds
  Directory: [/var/lib/drupaltestbot]
  Completion status: [0]
  Output: [simpletest_clear_results was set to "0".                               [success]].
[03:58:23] Command [cd /var/lib/drupaltestbot 2>&1] succeeded.
[03:58:24] Command [cd sites/default/files/checkout && drush vset simpletest_verbose '0' 2>&1] succeeded
  Duration: 1 seconds
  Directory: [/var/lib/drupaltestbot]
  Completion status: [0]
  Output: [simpletest_verbose was set to "0".                                     [success]].
[03:58:24] Command [cd /var/lib/drupaltestbot 2>&1] succeeded.
[03:58:24] Invoking operation [review]...
[03:58:25] Command [cd sites/default/files/checkout && drush en -y simpletest 2>&1] succeeded
  Duration: 1 seconds
  Directory: [/var/lib/drupaltestbot]
  Completion status: [0]
  Output: [The following extensions will be enabled: simpletest
Do you really want to continue? (y/n): y
simpletest was enabled successfully.                                        [ok]
simpletest defines the following permissions: administer unit tests].
[03:58:25] Command [cd /var/lib/drupaltestbot 2>&1] succeeded.
[03:58:25] Scanning sites/default/files/checkout/sites/default/modules/protected_node for .test files.
[03:58:25] Scanning sites/default/files/checkout/sites/default/modules/protected_node for /Tests/*.php files.
[03:58:25] Cleaning run-tests.sh environment.
[03:58:25] Command [/usr/bin/php ./scripts/run-tests.sh --concurrency 8 --php /usr/bin/php --url http://ec2-54-69-10-31.us-west-2.compute.amazonaws.com/checkout --file sites/default/modules/protected_node/protected_node_rules/tests/protected_node_rules.test,sites/default/modules/protected_node/tests/protected_node.fork.test,sites/default/modules/protected_node/tests/protected_node.bulk.test,sites/default/modules/protected_node/tests/protected_node.view_mode.test,sites/default/modules/protected_node/tests/protected_node.test,sites/default/modules/protected_node/tests/protected_node.statistics.test,sites/default/modules/protected_node/tests/protected_node.private_file.test,sites/default/modules/protected_node/tests/protected_node.per_type.test,sites/default/modules/protected_node/tests/protected_node.per_node.test,sites/default/modules/protected_node/tests/protected_node.page_text.test,sites/default/modules/protected_node/tests/protected_node.mail_test.test,sites/default/modules/protected_node/tests/protected_node.global.test --clean 2>&1] succeeded.
[03:58:25] Initiating run-tests.sh.
[03:59:13] Command [/usr/bin/php ./scripts/run-tests.sh --concurrency 8 --php /usr/bin/php --url http://ec2-54-69-10-31.us-west-2.compute.amazonaws.com/checkout --file sites/default/modules/protected_node/protected_node_rules/tests/protected_node_rules.test,sites/default/modules/protected_node/tests/protected_node.fork.test,sites/default/modules/protected_node/tests/protected_node.bulk.test,sites/default/modules/protected_node/tests/protected_node.view_mode.test,sites/default/modules/protected_node/tests/protected_node.test,sites/default/modules/protected_node/tests/protected_node.statistics.test,sites/default/modules/protected_node/tests/protected_node.private_file.test,sites/default/modules/protected_node/tests/protected_node.per_type.test,sites/default/modules/protected_node/tests/protected_node.per_node.test,sites/default/modules/protected_node/tests/protected_node.page_text.test,sites/default/modules/protected_node/tests/protected_node.mail_test.test,sites/default/modules/protected_node/tests/protected_node.global.test 2>&1] succeeded
  Duration: 48 seconds
  Directory: [/var/lib/drupaltestbot/sites/default/files/checkout]
  Completion status: [0]
  Output: [Drupal test run
---------------

Tests to be run:
 - Protected node bulk actions feature (ProtectedNodeBulkPassword)
 - Protected node fork feature (ProtectedNodeFork)
 - Protected node global password feature (ProtectedNodeGlobalPassword)
 - Protected node email feature (ProtectedNodeMail)
 - Protected node password page display options (ProtectedNodePageDisplay)
 - Protected node per node feature (ProtectedNodePerNodePassword)
 - Protected node per type feature (ProtectedNodePerTypePassword)
 - Protected node private file (ProtectedNodePrivateFile)
 - Protected node rules feature (ProtectedNodeRules)
 - Protected node statistic overview (ProtectedNodeStatistics)
 - Protected node view mode feature (ProtectedNodeViewMode)

Test run started:
 Sunday, August 23, 2015 - 10:58

Test summary
------------

Protected node bulk actions feature 59 passes, 0 fails, 0 exceptions, and 9 debug messages
Protected node email feature 86 passes, 0 fails, and 0 exceptions
Protected node fork feature 197 passes, 0 fails, 0 exceptions, and 18 debug messages
Protected node global password feature 168 passes, 0 fails, 0 exceptions, and 2 debug messages
Protected node per node feature 183 passes, 0 fails, 0 exceptions, and 2 debug messages
Protected node rules feature 160 passes, 0 fails, 0 exceptions, and 6 debug messages
Protected node per type feature 184 passes, 0 fails, 0 exceptions, and 2 debug messages
Protected node private file 240 passes, 0 fails, 0 exceptions, and 4 debug messages
Protected node statistic overview 126 passes, 0 fails, and 0 exceptions
Protected node view mode feature 96 passes, 0 fails, and 0 exceptions
Protected node password page display options 289 passes, 0 fails, and 0 exceptions

Test run duration: 48 sec].
[03:59:13] Command [/usr/bin/php ./scripts/run-tests.sh --php /usr/bin/php --url http://ec2-54-69-10-31.us-west-2.compute.amazonaws.com/checkout --file sites/default/modules/protected_node/protected_node_rules/tests/protected_node_rules.test,sites/default/modules/protected_node/tests/protected_node.fork.test,sites/default/modules/protected_node/tests/protected_node.bulk.test,sites/default/modules/protected_node/tests/protected_node.view_mode.test,sites/default/modules/protected_node/tests/protected_node.test,sites/default/modules/protected_node/tests/protected_node.statistics.test,sites/default/modules/protected_node/tests/protected_node.private_file.test,sites/default/modules/protected_node/tests/protected_node.per_type.test,sites/default/modules/protected_node/tests/protected_node.per_node.test,sites/default/modules/protected_node/tests/protected_node.page_text.test,sites/default/modules/protected_node/tests/protected_node.mail_test.test,sites/default/modules/protected_node/tests/protected_node.global.test --list 2>&1] succeeded.
[03:59:13] Review complete. test_id=1130333 result code=10 details=Array
(
    [@pass] => 1788
    [@fail] => 0
    [@exception] => 0
    [@debug] => 43
)

[03:59:13] Static variables reset.