builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1474373655.78 results: success (0) buildid: 20160920035754 builduid: 5698a15ca76a4ab9967bc37c3ca41c23 revision: 0f66d9a52316fd7fe265ee667d34b7ac29a78dcc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.777485) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.777983) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.778296) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.793056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.793349) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 05:14:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-09-20 05:14:16 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099393 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.906849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.907207) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.956950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:15.957396) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0f66d9a52316fd7fe265ee667d34b7ac29a78dcc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0f66d9a52316fd7fe265ee667d34b7ac29a78dcc --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 05:14:16,459 truncating revision to first 12 chars 2016-09-20 05:14:16,459 Setting DEBUG logging. 2016-09-20 05:14:16,459 attempt 1/10 2016-09-20 05:14:16,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0f66d9a52316?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 05:14:16,917 unpacking tar archive at: mozilla-inbound-0f66d9a52316/testing/mozharness/ program finished with exit code 0 elapsedTime=0.790150 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:16.762710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:16.763054) ========= script_repo_revision: 0f66d9a52316fd7fe265ee667d34b7ac29a78dcc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:16.763513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:16.763841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 05:14:16.774409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-09-20 05:14:16.774735) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:17 INFO - MultiFileLogger online at 20160920 05:14:17 in /builds/slave/test 05:14:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 05:14:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:17 INFO - {'append_to_log': False, 05:14:17 INFO - 'base_work_dir': '/builds/slave/test', 05:14:17 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 05:14:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:17 INFO - 'branch': 'Mozilla-Inbound', 05:14:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:17 INFO - 'config_files': ('talos/linux_config.py',), 05:14:17 INFO - 'default_actions': ('clobber', 05:14:17 INFO - 'read-buildbot-config', 05:14:17 INFO - 'download-and-extract', 05:14:17 INFO - 'populate-webroot', 05:14:17 INFO - 'create-virtualenv', 05:14:17 INFO - 'install', 05:14:17 INFO - 'run-tests'), 05:14:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:17 INFO - 'download_minidump_stackwalk': True, 05:14:17 INFO - 'download_symbols': 'ondemand', 05:14:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:17 INFO - 'installer_path': 'installer.exe', 05:14:17 INFO - 'log_level': 'info', 05:14:17 INFO - 'log_name': 'talos', 05:14:17 INFO - 'log_to_console': True, 05:14:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:17 INFO - 'opt_config_files': (), 05:14:17 INFO - 'pip_index': False, 05:14:17 INFO - 'sps_profile': False, 05:14:17 INFO - 'sps_profile_interval': 0, 05:14:17 INFO - 'suite': 'dromaeojs-e10s', 05:14:17 INFO - 'system_bits': '32', 05:14:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:17 INFO - 'title': 'talos-linux64-ix-007', 05:14:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:17 INFO - 'use_talos_json': True, 05:14:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:17 INFO - 'work_dir': 'build'} 05:14:17 INFO - [mozharness: 2016-09-20 12:14:17.365612Z] Running clobber step. 05:14:17 INFO - Running pre-action listener: _resource_record_pre_action 05:14:17 INFO - Running main action method: clobber 05:14:17 INFO - rmtree: /builds/slave/test/build 05:14:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:14:17 INFO - Running post-action listener: _resource_record_post_action 05:14:17 INFO - [mozharness: 2016-09-20 12:14:17.826681Z] Finished clobber step (success) 05:14:17 INFO - [mozharness: 2016-09-20 12:14:17.826783Z] Running read-buildbot-config step. 05:14:17 INFO - Running pre-action listener: _resource_record_pre_action 05:14:17 INFO - Running main action method: read_buildbot_config 05:14:17 INFO - Using buildbot properties: 05:14:17 INFO - { 05:14:17 INFO - "project": "", 05:14:17 INFO - "product": "firefox", 05:14:17 INFO - "script_repo_revision": "production", 05:14:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 05:14:17 INFO - "repository": "", 05:14:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 05:14:17 INFO - "buildid": "20160920035754", 05:14:17 INFO - "stage_platform": "linux64-pgo", 05:14:17 INFO - "basedir": "/builds/slave/test", 05:14:17 INFO - "buildnumber": 1665, 05:14:17 INFO - "platform": "ubuntu64_hw", 05:14:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:14:17 INFO - "slavebuilddir": "test", 05:14:17 INFO - "branch": "mozilla-inbound", 05:14:17 INFO - "revision": "0f66d9a52316fd7fe265ee667d34b7ac29a78dcc", 05:14:17 INFO - "slavename": "talos-linux64-ix-007", 05:14:17 INFO - "builduid": "5698a15ca76a4ab9967bc37c3ca41c23", 05:14:17 INFO - "repo_path": "integration/mozilla-inbound" 05:14:17 INFO - } 05:14:17 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:14:17 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 05:14:17 INFO - Running post-action listener: _resource_record_post_action 05:14:17 INFO - [mozharness: 2016-09-20 12:14:17.829151Z] Finished read-buildbot-config step (success) 05:14:17 INFO - [mozharness: 2016-09-20 12:14:17.829240Z] Running download-and-extract step. 05:14:17 INFO - Running pre-action listener: _resource_record_pre_action 05:14:17 INFO - Running main action method: download_and_extract 05:14:17 INFO - mkdir: /builds/slave/test/build/tests 05:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:17 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:14:17 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:14:17 INFO - Downloaded 1361 bytes. 05:14:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:14:17 INFO - Using the following test package requirements: 05:14:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:14:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:14:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:17 INFO - u'jsshell-linux-x86_64.zip'], 05:14:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:14:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:14:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:14:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:14:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:14:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:14:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:14:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:17 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:14:17 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:19 INFO - Downloaded 21825715 bytes. 05:14:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:20 INFO - Return code: 0 05:14:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:20 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:14:20 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:14:20 INFO - Downloaded 21825715 bytes. 05:14:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:14:22 INFO - Return code: 0 05:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:22 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:22 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:14:22 INFO - Downloaded 14413723 bytes. 05:14:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:14:22 INFO - Return code: 0 05:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:22 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:14:22 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:14:23 INFO - Downloaded 59342831 bytes. 05:14:23 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:14:23 INFO - mkdir: /builds/slave/test/properties 05:14:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:23 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:23 INFO - Contents: 05:14:23 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:14:23 INFO - Running post-action listener: _resource_record_post_action 05:14:23 INFO - Running post-action listener: set_extra_try_arguments 05:14:23 INFO - [mozharness: 2016-09-20 12:14:23.758420Z] Finished download-and-extract step (success) 05:14:23 INFO - [mozharness: 2016-09-20 12:14:23.758656Z] Running populate-webroot step. 05:14:23 INFO - Running pre-action listener: _resource_record_pre_action 05:14:23 INFO - Running main action method: populate_webroot 05:14:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:23 INFO - '--tppagecycles', 05:14:23 INFO - '7'], 05:14:23 INFO - 'tests': ['tsvgm']}}, 05:14:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:23 INFO - 'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:23 INFO - 'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['damp', 'tps']}, 05:14:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:23 INFO - 'tests': ['damp', 'tps']}, 05:14:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['dromaeo_dom']}, 05:14:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['basic_compositor_video']}, 05:14:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:14:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['a11yr', 05:14:23 INFO - 'ts_paint', 05:14:23 INFO - 'tpaint', 05:14:23 INFO - 'sessionrestore', 05:14:23 INFO - 'sessionrestore_no_auto_restore', 05:14:23 INFO - 'tabpaint']}, 05:14:23 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:23 INFO - 'ts_paint', 05:14:23 INFO - 'tpaint', 05:14:23 INFO - 'sessionrestore', 05:14:23 INFO - 'sessionrestore_no_auto_restore', 05:14:23 INFO - 'tabpaint']}, 05:14:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:23 INFO - 'ts_paint', 05:14:23 INFO - 'tpaint', 05:14:23 INFO - 'sessionrestore', 05:14:23 INFO - 'sessionrestore_no_auto_restore', 05:14:23 INFO - 'tabpaint']}, 05:14:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:23 INFO - 'ts_paint', 05:14:23 INFO - 'tpaint', 05:14:23 INFO - 'sessionrestore', 05:14:23 INFO - 'sessionrestore_no_auto_restore', 05:14:23 INFO - 'tabpaint']}, 05:14:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['a11yr', 05:14:23 INFO - 'ts_paint', 05:14:23 INFO - 'tpaint', 05:14:23 INFO - 'sessionrestore', 05:14:23 INFO - 'sessionrestore_no_auto_restore', 05:14:23 INFO - 'tabpaint']}, 05:14:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['a11yr', 05:14:23 INFO - 'ts_paint', 05:14:23 INFO - 'tpaint', 05:14:23 INFO - 'sessionrestore', 05:14:23 INFO - 'sessionrestore_no_auto_restore', 05:14:23 INFO - 'tabpaint']}, 05:14:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['tsvgx', 05:14:23 INFO - 'tsvgr_opacity', 05:14:23 INFO - 'tart', 05:14:23 INFO - 'tscrollx', 05:14:23 INFO - 'cart']}, 05:14:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:23 INFO - 'tsvgr_opacity', 05:14:23 INFO - 'tart', 05:14:23 INFO - 'tscrollx', 05:14:23 INFO - 'cart']}, 05:14:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:23 INFO - 'talos_options': ['--disable-e10s'], 05:14:23 INFO - 'tests': ['tp5o']}, 05:14:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:23 INFO - 'tests': ['tp5o']}, 05:14:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:23 INFO - 'talos_options': ['--disable-e10s', 05:14:23 INFO - '--xperf_path', 05:14:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:23 INFO - 'tests': ['tp5n']}, 05:14:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:23 INFO - 'talos_options': ['--xperf_path', 05:14:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:23 INFO - 'tests': ['tp5n']}}, 05:14:23 INFO - 'talos.zip': {'path': '', 05:14:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:23 INFO - Running post-action listener: _resource_record_post_action 05:14:23 INFO - [mozharness: 2016-09-20 12:14:23.780840Z] Finished populate-webroot step (success) 05:14:23 INFO - [mozharness: 2016-09-20 12:14:23.780929Z] Running create-virtualenv step. 05:14:23 INFO - Running pre-action listener: _resource_record_pre_action 05:14:23 INFO - Running main action method: create_virtualenv 05:14:23 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:14:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:23 INFO - Using real prefix '/usr' 05:14:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:24 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:26 INFO - Installing pip.................done. 05:14:26 INFO - Return code: 0 05:14:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:14:26 INFO - Using env: {'DISPLAY': ':0', 05:14:26 INFO - 'HOME': '/home/cltbld', 05:14:26 INFO - 'LANG': 'en_US.UTF-8', 05:14:26 INFO - 'LANGUAGE': 'en_US:en', 05:14:26 INFO - 'LOGNAME': 'cltbld', 05:14:26 INFO - 'MAIL': '/var/mail/cltbld', 05:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:26 INFO - 'MOZ_NO_REMOTE': '1', 05:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:26 INFO - 'NO_EM_RESTART': '1', 05:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:26 INFO - 'PWD': '/builds/slave/test', 05:14:26 INFO - 'SHELL': '/bin/bash', 05:14:26 INFO - 'SHLVL': '1', 05:14:26 INFO - 'TERM': 'linux', 05:14:26 INFO - 'TMOUT': '86400', 05:14:26 INFO - 'USER': 'cltbld', 05:14:26 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:26 INFO - '_': '/tools/buildbot/bin/python'} 05:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:14:26 INFO - Cleaning up... 05:14:26 INFO - Return code: 0 05:14:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:14:26 INFO - Using env: {'DISPLAY': ':0', 05:14:26 INFO - 'HOME': '/home/cltbld', 05:14:26 INFO - 'LANG': 'en_US.UTF-8', 05:14:26 INFO - 'LANGUAGE': 'en_US:en', 05:14:26 INFO - 'LOGNAME': 'cltbld', 05:14:26 INFO - 'MAIL': '/var/mail/cltbld', 05:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:26 INFO - 'MOZ_NO_REMOTE': '1', 05:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:26 INFO - 'NO_EM_RESTART': '1', 05:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:26 INFO - 'PWD': '/builds/slave/test', 05:14:26 INFO - 'SHELL': '/bin/bash', 05:14:26 INFO - 'SHLVL': '1', 05:14:26 INFO - 'TERM': 'linux', 05:14:26 INFO - 'TMOUT': '86400', 05:14:26 INFO - 'USER': 'cltbld', 05:14:26 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:26 INFO - '_': '/tools/buildbot/bin/python'} 05:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:26 INFO - Downloading/unpacking psutil>=3.1.1 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:28 INFO - Installing collected packages: psutil 05:14:28 INFO - Running setup.py install for psutil 05:14:28 INFO - building 'psutil._psutil_linux' extension 05:14:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:14:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:14:29 INFO - building 'psutil._psutil_posix' extension 05:14:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:14:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:14:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:29 INFO - Successfully installed psutil 05:14:29 INFO - Cleaning up... 05:14:29 INFO - Return code: 0 05:14:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:14:29 INFO - Using env: {'DISPLAY': ':0', 05:14:29 INFO - 'HOME': '/home/cltbld', 05:14:29 INFO - 'LANG': 'en_US.UTF-8', 05:14:29 INFO - 'LANGUAGE': 'en_US:en', 05:14:29 INFO - 'LOGNAME': 'cltbld', 05:14:29 INFO - 'MAIL': '/var/mail/cltbld', 05:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:29 INFO - 'MOZ_NO_REMOTE': '1', 05:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:29 INFO - 'NO_EM_RESTART': '1', 05:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:29 INFO - 'PWD': '/builds/slave/test', 05:14:29 INFO - 'SHELL': '/bin/bash', 05:14:29 INFO - 'SHLVL': '1', 05:14:29 INFO - 'TERM': 'linux', 05:14:29 INFO - 'TMOUT': '86400', 05:14:29 INFO - 'USER': 'cltbld', 05:14:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:29 INFO - '_': '/tools/buildbot/bin/python'} 05:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:14:31 INFO - Installing collected packages: mozsystemmonitor 05:14:31 INFO - Running setup.py install for mozsystemmonitor 05:14:31 INFO - Successfully installed mozsystemmonitor 05:14:31 INFO - Cleaning up... 05:14:31 INFO - Return code: 0 05:14:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:14:31 INFO - Using env: {'DISPLAY': ':0', 05:14:31 INFO - 'HOME': '/home/cltbld', 05:14:31 INFO - 'LANG': 'en_US.UTF-8', 05:14:31 INFO - 'LANGUAGE': 'en_US:en', 05:14:31 INFO - 'LOGNAME': 'cltbld', 05:14:31 INFO - 'MAIL': '/var/mail/cltbld', 05:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:31 INFO - 'MOZ_NO_REMOTE': '1', 05:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:31 INFO - 'NO_EM_RESTART': '1', 05:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:31 INFO - 'PWD': '/builds/slave/test', 05:14:31 INFO - 'SHELL': '/bin/bash', 05:14:31 INFO - 'SHLVL': '1', 05:14:31 INFO - 'TERM': 'linux', 05:14:31 INFO - 'TMOUT': '86400', 05:14:31 INFO - 'USER': 'cltbld', 05:14:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:31 INFO - '_': '/tools/buildbot/bin/python'} 05:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:31 INFO - Downloading/unpacking jsonschema==2.5.1 05:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:34 INFO - warning: no files found matching '*.txt' 05:14:34 INFO - no previously-included directories found matching 'build' 05:14:34 INFO - no previously-included directories found matching 'dist' 05:14:34 INFO - no previously-included directories found matching '.git*' 05:14:34 INFO - Installing collected packages: jsonschema, functools32 05:14:34 INFO - Running setup.py install for functools32 05:14:34 INFO - warning: no files found matching '*.txt' 05:14:34 INFO - no previously-included directories found matching 'build' 05:14:34 INFO - no previously-included directories found matching 'dist' 05:14:34 INFO - no previously-included directories found matching '.git*' 05:14:34 INFO - Successfully installed jsonschema functools32 05:14:34 INFO - Cleaning up... 05:14:34 INFO - Return code: 0 05:14:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:14:34 INFO - Using env: {'DISPLAY': ':0', 05:14:34 INFO - 'HOME': '/home/cltbld', 05:14:34 INFO - 'LANG': 'en_US.UTF-8', 05:14:34 INFO - 'LANGUAGE': 'en_US:en', 05:14:34 INFO - 'LOGNAME': 'cltbld', 05:14:34 INFO - 'MAIL': '/var/mail/cltbld', 05:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:34 INFO - 'MOZ_NO_REMOTE': '1', 05:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:34 INFO - 'NO_EM_RESTART': '1', 05:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:34 INFO - 'PWD': '/builds/slave/test', 05:14:34 INFO - 'SHELL': '/bin/bash', 05:14:34 INFO - 'SHLVL': '1', 05:14:34 INFO - 'TERM': 'linux', 05:14:34 INFO - 'TMOUT': '86400', 05:14:34 INFO - 'USER': 'cltbld', 05:14:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:34 INFO - '_': '/tools/buildbot/bin/python'} 05:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:14:34 INFO - Cleaning up... 05:14:34 INFO - Return code: 0 05:14:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:14:34 INFO - Using env: {'DISPLAY': ':0', 05:14:34 INFO - 'HOME': '/home/cltbld', 05:14:34 INFO - 'LANG': 'en_US.UTF-8', 05:14:34 INFO - 'LANGUAGE': 'en_US:en', 05:14:34 INFO - 'LOGNAME': 'cltbld', 05:14:34 INFO - 'MAIL': '/var/mail/cltbld', 05:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:34 INFO - 'MOZ_NO_REMOTE': '1', 05:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:34 INFO - 'NO_EM_RESTART': '1', 05:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:34 INFO - 'PWD': '/builds/slave/test', 05:14:34 INFO - 'SHELL': '/bin/bash', 05:14:34 INFO - 'SHLVL': '1', 05:14:34 INFO - 'TERM': 'linux', 05:14:34 INFO - 'TMOUT': '86400', 05:14:34 INFO - 'USER': 'cltbld', 05:14:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:34 INFO - '_': '/tools/buildbot/bin/python'} 05:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:37 INFO - Downloading docopt-0.6.1.tar.gz 05:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:37 INFO - Running setup.py install for blobuploader 05:14:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:37 INFO - Running setup.py install for requests 05:14:37 INFO - Running setup.py install for docopt 05:14:37 INFO - Successfully installed blobuploader requests docopt 05:14:37 INFO - Cleaning up... 05:14:37 INFO - Return code: 0 05:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:38 INFO - Using env: {'DISPLAY': ':0', 05:14:38 INFO - 'HOME': '/home/cltbld', 05:14:38 INFO - 'LANG': 'en_US.UTF-8', 05:14:38 INFO - 'LANGUAGE': 'en_US:en', 05:14:38 INFO - 'LOGNAME': 'cltbld', 05:14:38 INFO - 'MAIL': '/var/mail/cltbld', 05:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:38 INFO - 'MOZ_NO_REMOTE': '1', 05:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:38 INFO - 'NO_EM_RESTART': '1', 05:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:38 INFO - 'PWD': '/builds/slave/test', 05:14:38 INFO - 'SHELL': '/bin/bash', 05:14:38 INFO - 'SHLVL': '1', 05:14:38 INFO - 'TERM': 'linux', 05:14:38 INFO - 'TMOUT': '86400', 05:14:38 INFO - 'USER': 'cltbld', 05:14:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:38 INFO - '_': '/tools/buildbot/bin/python'} 05:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:38 INFO - Running setup.py (path:/tmp/pip-oOYH4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:38 INFO - Running setup.py (path:/tmp/pip-f0ZAdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:38 INFO - Running setup.py (path:/tmp/pip-9bPJsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:38 INFO - Running setup.py (path:/tmp/pip-nTWHzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:38 INFO - Running setup.py (path:/tmp/pip-DgShlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:38 INFO - Running setup.py (path:/tmp/pip-2n04dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:38 INFO - Running setup.py (path:/tmp/pip-QrqDaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:38 INFO - Running setup.py (path:/tmp/pip-Mqp7eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:38 INFO - Running setup.py (path:/tmp/pip-uLfwlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:38 INFO - Running setup.py (path:/tmp/pip-p5zPEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:38 INFO - Running setup.py (path:/tmp/pip-Sf9_cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:39 INFO - Running setup.py (path:/tmp/pip-_oJveP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:39 INFO - Running setup.py (path:/tmp/pip-NLpwKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:39 INFO - Running setup.py (path:/tmp/pip-W3wI82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:39 INFO - Running setup.py (path:/tmp/pip-C8FUQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:39 INFO - Running setup.py (path:/tmp/pip-ChF964-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:39 INFO - Running setup.py (path:/tmp/pip-kaea7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:39 INFO - Running setup.py install for manifestparser 05:14:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:39 INFO - Running setup.py install for mozcrash 05:14:39 INFO - Running setup.py install for mozdebug 05:14:39 INFO - Running setup.py install for mozdevice 05:14:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:39 INFO - Running setup.py install for mozfile 05:14:39 INFO - Running setup.py install for mozhttpd 05:14:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Running setup.py install for mozinfo 05:14:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Running setup.py install for mozInstall 05:14:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Running setup.py install for mozleak 05:14:40 INFO - Running setup.py install for mozlog 05:14:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Running setup.py install for moznetwork 05:14:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Running setup.py install for mozprocess 05:14:40 INFO - Running setup.py install for mozprofile 05:14:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Running setup.py install for mozrunner 05:14:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:14:40 INFO - Running setup.py install for mozscreenshot 05:14:41 INFO - Running setup.py install for moztest 05:14:41 INFO - Running setup.py install for mozversion 05:14:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:14:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:14:41 INFO - Cleaning up... 05:14:41 INFO - Return code: 0 05:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:41 INFO - Using env: {'DISPLAY': ':0', 05:14:41 INFO - 'HOME': '/home/cltbld', 05:14:41 INFO - 'LANG': 'en_US.UTF-8', 05:14:41 INFO - 'LANGUAGE': 'en_US:en', 05:14:41 INFO - 'LOGNAME': 'cltbld', 05:14:41 INFO - 'MAIL': '/var/mail/cltbld', 05:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:41 INFO - 'MOZ_NO_REMOTE': '1', 05:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:41 INFO - 'NO_EM_RESTART': '1', 05:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:41 INFO - 'PWD': '/builds/slave/test', 05:14:41 INFO - 'SHELL': '/bin/bash', 05:14:41 INFO - 'SHLVL': '1', 05:14:41 INFO - 'TERM': 'linux', 05:14:41 INFO - 'TMOUT': '86400', 05:14:41 INFO - 'USER': 'cltbld', 05:14:41 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:41 INFO - '_': '/tools/buildbot/bin/python'} 05:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:41 INFO - Running setup.py (path:/tmp/pip-W4hnTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:41 INFO - Running setup.py (path:/tmp/pip-xOahGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:41 INFO - Running setup.py (path:/tmp/pip-srAqT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:41 INFO - Running setup.py (path:/tmp/pip-YrUZoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:41 INFO - Running setup.py (path:/tmp/pip-IIqUqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:41 INFO - Running setup.py (path:/tmp/pip-gEin0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:41 INFO - Running setup.py (path:/tmp/pip-vUjMm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:41 INFO - Running setup.py (path:/tmp/pip-OIRgSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:42 INFO - Running setup.py (path:/tmp/pip-rrQExc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:42 INFO - Running setup.py (path:/tmp/pip-pIFiYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:42 INFO - Running setup.py (path:/tmp/pip-zTIXwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:42 INFO - Running setup.py (path:/tmp/pip-odGTmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:42 INFO - Running setup.py (path:/tmp/pip-fv2_dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:42 INFO - Running setup.py (path:/tmp/pip-ip5ycA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:42 INFO - Running setup.py (path:/tmp/pip-XcVlSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:42 INFO - Running setup.py (path:/tmp/pip-etk2jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:42 INFO - Running setup.py (path:/tmp/pip-sxsxzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:44 INFO - Downloading blessings-1.6.tar.gz 05:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:44 INFO - Installing collected packages: blessings 05:14:44 INFO - Running setup.py install for blessings 05:14:44 INFO - Successfully installed blessings 05:14:44 INFO - Cleaning up... 05:14:44 INFO - Return code: 0 05:14:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:45 INFO - Reading from file tmpfile_stdout 05:14:45 INFO - Current package versions: 05:14:45 INFO - argparse == 1.2.1 05:14:45 INFO - blessings == 1.6 05:14:45 INFO - blobuploader == 1.2.4 05:14:45 INFO - docopt == 0.6.1 05:14:45 INFO - functools32 == 3.2.3-2 05:14:45 INFO - jsonschema == 2.5.1 05:14:45 INFO - manifestparser == 1.1 05:14:45 INFO - mozInstall == 1.12 05:14:45 INFO - mozcrash == 0.17 05:14:45 INFO - mozdebug == 0.1 05:14:45 INFO - mozdevice == 0.48 05:14:45 INFO - mozfile == 1.2 05:14:45 INFO - mozhttpd == 0.7 05:14:45 INFO - mozinfo == 0.9 05:14:45 INFO - mozleak == 0.1 05:14:45 INFO - mozlog == 3.3 05:14:45 INFO - moznetwork == 0.27 05:14:45 INFO - mozprocess == 0.23 05:14:45 INFO - mozprofile == 0.28 05:14:45 INFO - mozrunner == 6.12 05:14:45 INFO - mozscreenshot == 0.1 05:14:45 INFO - mozsystemmonitor == 0.3 05:14:45 INFO - moztest == 0.7 05:14:45 INFO - mozversion == 1.4 05:14:45 INFO - psutil == 3.1.1 05:14:45 INFO - requests == 1.2.3 05:14:45 INFO - wsgiref == 0.1.2 05:14:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:14:45 INFO - Using env: {'DISPLAY': ':0', 05:14:45 INFO - 'HOME': '/home/cltbld', 05:14:45 INFO - 'LANG': 'en_US.UTF-8', 05:14:45 INFO - 'LANGUAGE': 'en_US:en', 05:14:45 INFO - 'LOGNAME': 'cltbld', 05:14:45 INFO - 'MAIL': '/var/mail/cltbld', 05:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:45 INFO - 'MOZ_NO_REMOTE': '1', 05:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:45 INFO - 'NO_EM_RESTART': '1', 05:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:45 INFO - 'PWD': '/builds/slave/test', 05:14:45 INFO - 'SHELL': '/bin/bash', 05:14:45 INFO - 'SHLVL': '1', 05:14:45 INFO - 'TERM': 'linux', 05:14:45 INFO - 'TMOUT': '86400', 05:14:45 INFO - 'USER': 'cltbld', 05:14:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:45 INFO - '_': '/tools/buildbot/bin/python'} 05:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:14:45 INFO - Cleaning up... 05:14:45 INFO - Return code: 0 05:14:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1333030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:14:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:14:45 INFO - Using env: {'DISPLAY': ':0', 05:14:45 INFO - 'HOME': '/home/cltbld', 05:14:45 INFO - 'LANG': 'en_US.UTF-8', 05:14:45 INFO - 'LANGUAGE': 'en_US:en', 05:14:45 INFO - 'LOGNAME': 'cltbld', 05:14:45 INFO - 'MAIL': '/var/mail/cltbld', 05:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:45 INFO - 'MOZ_NO_REMOTE': '1', 05:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:45 INFO - 'NO_EM_RESTART': '1', 05:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:45 INFO - 'PWD': '/builds/slave/test', 05:14:45 INFO - 'SHELL': '/bin/bash', 05:14:45 INFO - 'SHLVL': '1', 05:14:45 INFO - 'TERM': 'linux', 05:14:45 INFO - 'TMOUT': '86400', 05:14:45 INFO - 'USER': 'cltbld', 05:14:45 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:45 INFO - '_': '/tools/buildbot/bin/python'} 05:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:14:45 INFO - Cleaning up... 05:14:45 INFO - Return code: 0 05:14:45 INFO - Running post-action listener: _resource_record_post_action 05:14:45 INFO - Running post-action listener: _start_resource_monitoring 05:14:45 INFO - Starting resource monitoring. 05:14:45 INFO - [mozharness: 2016-09-20 12:14:45.495882Z] Finished create-virtualenv step (success) 05:14:45 INFO - [mozharness: 2016-09-20 12:14:45.496312Z] Running install step. 05:14:45 INFO - Running pre-action listener: _resource_record_pre_action 05:14:45 INFO - Running main action method: install 05:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:45 INFO - Reading from file tmpfile_stdout 05:14:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:14:45 INFO - Reading from file tmpfile_stdout 05:14:45 INFO - Output received: 05:14:45 INFO - Usage: mozinstall [options] installer 05:14:45 INFO - Options: 05:14:45 INFO - -h, --help show this help message and exit 05:14:45 INFO - -d DEST, --destination=DEST 05:14:45 INFO - Directory to install application into. [default: 05:14:45 INFO - "/builds/slave/test"] 05:14:45 INFO - --app=APP Application being installed. [default: firefox] 05:14:45 INFO - mkdir: /builds/slave/test/build/application 05:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:15:02 INFO - Reading from file tmpfile_stdout 05:15:02 INFO - Output received: 05:15:02 INFO - /builds/slave/test/build/application/firefox/firefox 05:15:02 INFO - Running post-action listener: _resource_record_post_action 05:15:02 INFO - [mozharness: 2016-09-20 12:15:02.702328Z] Finished install step (success) 05:15:02 INFO - [mozharness: 2016-09-20 12:15:02.702605Z] Running run-tests step. 05:15:02 INFO - Running pre-action listener: _resource_record_pre_action 05:15:02 INFO - Running main action method: run_tests 05:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:02 INFO - Python 2.7.3 05:15:02 INFO - Return code: 0 05:15:02 INFO - grabbing minidump binary from tooltool 05:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f1570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:15:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:15:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:15:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:02 INFO - Return code: 0 05:15:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:15:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:15:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:15:02 INFO - Using env: {'DISPLAY': ':0', 05:15:02 INFO - 'HOME': '/home/cltbld', 05:15:02 INFO - 'LANG': 'en_US.UTF-8', 05:15:02 INFO - 'LANGUAGE': 'en_US:en', 05:15:02 INFO - 'LOGNAME': 'cltbld', 05:15:02 INFO - 'MAIL': '/var/mail/cltbld', 05:15:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:02 INFO - 'MOZ_NO_REMOTE': '1', 05:15:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:02 INFO - 'NO_EM_RESTART': '1', 05:15:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:02 INFO - 'PWD': '/builds/slave/test', 05:15:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:02 INFO - 'SHELL': '/bin/bash', 05:15:02 INFO - 'SHLVL': '1', 05:15:02 INFO - 'TERM': 'linux', 05:15:02 INFO - 'TMOUT': '86400', 05:15:02 INFO - 'USER': 'cltbld', 05:15:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790', 05:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:02 INFO - '_': '/tools/buildbot/bin/python'} 05:15:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:15:02 INFO - mozversion application_buildid: 20160920021430 05:15:02 INFO - mozversion application_changeset: 0f66d9a52316fd7fe265ee667d34b7ac29a78dcc 05:15:02 INFO - mozversion application_display_name: Nightly 05:15:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:02 INFO - mozversion application_name: Firefox 05:15:02 INFO - mozversion application_remotingname: firefox 05:15:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:15:02 INFO - mozversion application_vendor: Mozilla 05:15:02 INFO - mozversion application_version: 51.0a1 05:15:02 INFO - mozversion platform_buildid: 20160920021430 05:15:02 INFO - mozversion platform_changeset: 0f66d9a52316fd7fe265ee667d34b7ac29a78dcc 05:15:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 05:15:02 INFO - mozversion platform_version: 51.0a1 05:15:02 INFO - using testdate: 1474373702 05:15:02 INFO - actual date: 1474373702 05:15:02 INFO - starting webserver on 'localhost:39580' 05:15:02 INFO - SUITE-START | Running 2 tests 05:15:02 INFO - TEST-START | dromaeo_css 05:15:02 INFO - operating with platform_type : linux_ 05:15:02 INFO - Initialising browser for dromaeo_css test... 05:15:02 INFO - TEST-INFO | started process 20266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxROL4b/profile http://localhost:39580/getInfo.html) 05:15:07 INFO - PROCESS | 20266 | __metrics Screen width/height:1600/1200 05:15:07 INFO - PROCESS | 20266 | colorDepth:24 05:15:07 INFO - PROCESS | 20266 | Browser inner width/height: 1024/697 05:15:07 INFO - PROCESS | 20266 | __metrics 05:15:07 ERROR - PROCESS | 20266 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:15:08 INFO - TEST-INFO | 20266: exit 0 05:15:08 INFO - Browser initialized. 05:15:08 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:08 INFO - TEST-INFO | started process 20388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxROL4b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:20 INFO - PROCESS | 20388 | RSS: Main: 163737600 05:15:20 INFO - PROCESS | 20388 | 05:16:09 INFO - PROCESS | 20388 | 1474373769919 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:18:19 INFO - PROCESS | 20388 | Cycle 1(1): loaded http://localhost:39580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39580/tests/dromaeo/cssquery-ext.html) 05:18:21 INFO - PROCESS | 20388 | RSS: Main: 166879232 05:18:21 INFO - PROCESS | 20388 | 05:21:23 INFO - PROCESS | 20388 | Cycle 1(1): loaded http://localhost:39580/tests/dromaeo/cssquery-ext.html (next: http://localhost:39580/tests/dromaeo/cssquery-jquery.html) 05:21:23 INFO - PROCESS | 20388 | RSS: Main: 166440960 05:21:23 INFO - PROCESS | 20388 | 05:24:25 INFO - PROCESS | 20388 | Cycle 1(1): loaded http://localhost:39580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39580/tests/dromaeo/cssquery-mootools.html) 05:24:26 INFO - PROCESS | 20388 | RSS: Main: 169472000 05:24:26 INFO - PROCESS | 20388 | 05:27:28 INFO - PROCESS | 20388 | Cycle 1(1): loaded http://localhost:39580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39580/tests/dromaeo/cssquery-prototype.html) 05:27:28 INFO - PROCESS | 20388 | RSS: Main: 163770368 05:27:28 INFO - PROCESS | 20388 | 05:30:31 INFO - PROCESS | 20388 | Cycle 1(1): loaded http://localhost:39580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39580/tests/dromaeo/cssquery-yui.html) 05:30:31 INFO - PROCESS | 20388 | RSS: Main: 166461440 05:30:31 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | Cycle 1(1): loaded http://localhost:39580/tests/dromaeo/cssquery-yui.html (next: http://localhost:39580/tests/dromaeo/cssquery-dojo.html) 05:33:34 INFO - PROCESS | 20388 | RSS: Main: 169549824 05:33:34 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | __start_tp_report 05:33:34 INFO - PROCESS | 20388 | _x_x_mozilla_page_load 05:33:34 INFO - PROCESS | 20388 | _x_x_mozilla_page_load_details 05:33:34 INFO - PROCESS | 20388 | |i|pagename|runs| 05:33:34 INFO - PROCESS | 20388 | |0;dojo.html;3072.262656962329;3095.4582947984095;3098.411301852649;3116.5792617996563;3125.8593363298637;5380.408155102936;5407.459254074591;5447.509724124833;5491.643043202194;5536.252605898202;5373.677579345242;5393.352797664276;5455.427180146087;5471.097268950618;5504.4770746779095;4909.48450412706;4986.800527978877;5023.673461225027;5034.949650503485;5099.872503187431;5042.949570504303;5050.368703912011;5140.306058682087;5158.5873130149685;5162.174052151657;5032.622553308516;5047.798088076473;5065.898682026357;5095.6942583444925;5138.434772175076;4781.235002399634;4878.195097808857;4928.383952005999;4983.252512123175;5054.545090941833;4856.8300109495995;4920.4833492483485;4921.064997650471;4970.229614409773;4992.950070499285;5416.91874621881;5509.311336082989;5516.255305533782;5517.668939863621;5518.586106042023;5787.536997040227;5801.448862358069;5855.092460668603;5859.2382990211;5886.499647529965;5853.180554722299;5876.4123587641325;5914.260717410324;5914.733836977303;5919.733611987471;5258.763355649005;5470.398256191816;5473.397926228112;5485.917711234335;5505.917411238835;5949.583529153005;5990.191324171181;6024.909626355608;6042.818715438544;6057;5769.538436925036;5777.508911742465;5786.218860453785;5791.478766910998;5795.739191736382;5669.234653321749;5826.359100498942;5850.824475265749;5859.2090067841145;5890.3815099414805;5547;5641.351244606841;5756.539476841843;5811.912821307684;5831.679257640871;5700.9429905701245;5730.169125476866;5756.453136951983;5758.625689330264;5765.567582431335;4313.870583882489;4404.207242696345;4409.1181763646755;4413.360062790877;4444;3904.8047597620007;3943.526776786804;3963.8612648557164;3966.861159859391;3971.384435412516;5493.176023596492;5551.694656793915;5562.499375056183;5588.720563971785;5591.776328946797;5865.35481097079;5894.911576326359;5901.645901245939;5910.497607703307;5916.822495325147;5352.705601191972;5362.624616276901;5388.622796404214;5517.641353312022;5549.833504994856;4989.7006179628615;4993.575546078551;5002.749862506933;5030.698158110525;5033.094043072282;5927.110933359944;5973.611715238496;5976.103584462366;5976.581639285295;5981.641101533922;5696.373398926032;5787.479126878601;5790.218320526844;5792.420757924174;5800.854978625568;6014.188084608521;6017.3681763414215;6018.247719035121;6041.6677082759115;6063.696815159313;5691.402402747652;5748.080307150836;5751.798687045934;5754.424557544212;5755.510781583613;5605.439456054362;5797.420257974169;5827.912581311199;5846.619969701956;5849.064149736022;5776.133579963039;5781.508571771446;5783.566232532493;5812.82561523155;5833.4749872511675;5718.828435146952;5748.367679555162;5761.2222349983895;5763.7982670606325;5772.6247793894945;5492.0663487206475;5636.943630563642;5709.628874123168;5717.714114294352;5741.110127930177;5804.883902322014;5805.390434004369;5815.069588865761;5822.272215973004;5841.707914604168;5632.295963004624;5644.125160600113;5655.4344565543115;5664.348599910898;5666.206731057573 05:33:34 INFO - PROCESS | 20388 | |1;ext.html;549.7987262540287;568.7696482924416;589.1545632018054;598.0431309904154;620.1101419463068;41512.58487415129;42624;42680.35979460303;42699.78650106753;42786.57213427873;41957;42378.7881060595;42423.3636495452;42479.57520424795;42590;8677.3491988101;8721;8757.168069033432;8770.386072974863;8813.38306318558;8699.217070463657;8762.780930476725;8786.736397908042;8787.25308348791;8836.381453298272;8828.514431706253;8863.069377715343;8898.243649289818;8899.510526921016;8922.420042697237;8788.560571971408;8793.999999999967;8819.51492667903;8847.690330838454;8865.246454051414;8388.245057944814;8697.304215662733;8713.041565427799;8765.386422950396;8779.912200877974;40117.59882401197;40290;40418;40441.79779101115;40712.185756285005;3580.3555360035184;3607.3146102240753;3608.350496910555;3705.2959937611768;3761.097336639214;31553.368932621448;31927.201819954687;32037.359252814815;32071.358572828412;32121;4299.419578356944;4347.1957687827535;4393.7363758174615;4406.140802543506;4445.110977804452;349029.25485372666;349435;349583;349747;350778;31424;32398.19004524906;54952.450475495534;55276;55665.72167139138;37041;37283.62716372856;37345;37368.81315593405;37408.625913740514;15360.846391536164;15474.303656335493;15563.688726225639;15613.297401616954;15613.765793513106;13015.544455943997;13025;13075.150115242479;13091.214527128403;13106.934465327613;8449.32405407566;8455.957720211483;8521.872171917426;8557.27263182624;8592.957035214784;3283.7208837248622;3316.718078963267;3331.93336133276;3363.613184483767;3466.2547552276383;983.2871168402851;985.7042887133831;1030.160419258302;1074.237291523012;1135.9318440893574;32057.51913721296;32738.508922366185;32747.83626081902;33008.53410391922;33160.336793264;1059.6079450603327;1128.1482480727;1137.113051819582;1144.0275765599174;1173.7652469506133;16898.239579218964;17157.742633860504;17159.485215443558;17263.39578114785;17407.21667524939;554937;557185;558928;561535;562709;57806.7109664449;58037.70981145067;58099.12851307234;58354.416455835744;58366.4163358361;1329.2622594460167;1350.750111229406;1354.966125846842;1382.585224432666;1388.7361401333715;30872.382552349278;32201.35597287994;32778.50832237566;32919.83540082284;33144.33711325808;49463;50831.237531436316;50957.74521127371;50963.2355514675;51146.48853511566;470676;471998;472513;473806;477851;28724.978503010014;28757.424851502434;28874.711252887202;28879.85560072186;29196.7080329194;47632.28551571799;47643;48000.7599961998;48102.759486203744;49910;40199.79900100481;41375;41980.954643542944;42297.577024229366;42331.576684233994;40675.59324406718;40915.59084409237;41174.38238426366;41673.79163104165;42334.57665423306;41521.79239103785;42101.36847947222;43178.13643727171;43393.13213735771;43417;31391.529127063568;36324.818375907955;36996.7801931885;37116.69771879244;37364.813175933945;28506.57240141441;28544.57183142296;29204.415911682074;30507.2373190672;30566.694333056384 05:33:34 INFO - PROCESS | 20388 | |2;jquery.html;394.615250131122;396.1344462349764;401.1775859488049;404.22590738735335;420.4240190938413;18274.725879111807;19644.214231430742;19757.407277781673;20103.396898093044;20249.785012899236;19393.612127757435;19506.512337191576;19910.50223744407;20080.598388032267;20169.798302016974;5701.6864072476;5769.221155144044;5889.352171261179;5971.731272092767;6009.639421634694;5989.700514974255;6010.12853136295;6019.819405417845;6020.8494787630225;6031;6571.080048793173;6619.238787539446;6636.2413960300555;6641.435477984353;6643.103181070542;6047.425494578008;6093.878122437571;6174.475169610611;6626.403623673868;6629.867402651944;5820.738066786962;5845.415458454163;5879.382664820175;5882.6470411775;5910.054391297372;15714;22095.558088838294;22815.54368912629;22981.770182298296;23173.420664483354;2440.865752383618;2447.7027175596963;2463.4210960424284;2837.8581070946575;2928.6485621725315;9846.803063938753;9867.851982220272;10063.088013277455;10132.138768204712;10458.163346932302;1854.3973208707089;1918.8368988635982;1953.5740054238356;1971.7239586457908;1991.2333751505776;71871;73672.63163684201;74088;84213.57893210556;88800;10927.945360273307;10963.287386319864;11031.558737650405;11218;11369.658910232707;15304.234788260543;15497.225138743017;15521.301541430663;15525.456609018856;15568;8192.795180120545;8417.158284171534;8429.789255268668;8454.661813527513;8520.616572254263;7925.682972681144;8001.5599142046585;8252.05101413345;8276.08963014068;8307.252347288773;4629.282461218517;4679.134360143385;4753.548412900769;4779.737114458738;4904.215325547966;1984.454275074366;2016.4353980885376;2035.5725297687354;2051.753789545264;2062.9174833006814;888.5557221389305;932.5430539035824;949.8622699708503;1024.912882404989;1029.9588016479406;20072.89963550173;20457.89771051165;20492.282770102975;20579.38261852117;20616.896915515626;952.6760901293455;982.9017098290257;1023.3450591621369;1025.738436698637;1037.9169666426667;10685.572577096984;11090.667279981613;11197.832032519518;11207.831882521768;11270.492827822767;477498;487847;509202;514378;516922;83708.58145709355;88030.55984720163;89451.55274223717;94188;99015;1000.7298029531986;1008.7125169326706;1028.7736697926593;1044.4934206909643;1044.6291566493785;17755.46733597994;18015.2793888243;18587.256509739458;18598.163082661584;18734;38619.22761544809;41370.79314603408;42761;43091.7845410771;43518;55619;56614.7169264151;59040.52398690067;59202.40797591969;60509;5679;6295.433410993032;8560.887084678952;8821.955890220508;9111.407758495676;7687.346575541142;10703.892961070289;11120.608214494658;12747.87252127504;13079;11046.33721976684;11195.328280303207;11221.55113795439;11225.15811314171;11232.382218978035;11372.886271137182;11570.537178513101;11770.17608767378;11770.234934729215;11772.352520611448;11061.502232399722;11268.661940141808;11299.039581635652;11421.885781142082;11425.143114266297;8791.296696264155;8909.643614255358;8980;12013.519459221534;12190.817137743119;10998.230123891251;11000.669979900616;11559.768804623693;11717.589884354007;11956.940215298868 05:33:34 INFO - PROCESS | 20388 | |3;mootools.html;1497.1989985357832;1524.1464779723353;1666.5833541614597;1703.488953314007;1755.648870225955;7846.764597062083;8534.530600816952;8706.608202630881;9232.399894006894;9242.537873106343;8798.648054077828;9000.739896414507;9003.729888103368;9060.72817815465;9063;2241.350008497534;2261.400728806859;2261.9208327708534;2268.0587556164173;2271.2618399020303;2293.9311820645407;2302.3898666853297;2371.7983971362455;2377.1442280778906;2388.4625959159225;2297.4600968772324;2312.6415405612156;2321.802646775026;2349.400902769791;2354.458474550854;2298.2186056740707;2299.5860745065797;2303.527776805759;2305.3545007397956;2309.4111001694628;2278.453171238907;2281.8174546036444;2286.34839070864;2324.9883750581307;2327.592671282519;8955.238804701608;8998.100189981014;9054;9064.456132632064;9111.134442227978;5211.218317252405;5319.414864364917;5364.7317634118135;5365.463453654643;5370.758315875795;3238.5466034755154;3269.3134441767256;3371.561696979377;3422.5892892852767;3464.7747896386654;1178.387238635913;1191.4638412714314;1209.0508950473836;1242.3539759325101;1247.4698253242427;12808.10343275971;12846.871531284662;12869.356532173448;12890.935545322214;12908.935455322664;4446.1330040642415;4531.728096314232;4681.906361872811;4713.316569097462;4826.444958829779;10786.975237352439;10804.837927431096;10885.074768644754;10886.129109671207;10892.509837057352;5429.267048948421;5450.127979523258;5451.863703407446;5462.371827239839;5462.508374246337;4342.6742994275555;4746.311784791255;4840.443349014909;4984.501549844987;4992.301077849104;4106.753594784323;4146.543880173179;4161.271777438997;4170.77060761655;4222.678875325548;1311.1477539599146;1320.4124164746595;1328.4287756264898;1330.2484096485648;1334.7997800329833;883.2624758326741;936.1200471556715;950.7337945375306;965.8551217317319;972.9027097290356;5925.785214031113;5993;6034.24571928509;6131.908021379683;6132.938670613326;476.99284510732366;488.68724016629386;496.7044608457962;497.70884032841195;498.3023766726612;3962.5641179470235;4105.220008198433;4110.897227569275;4122.525909520384;4223.366495025771;10916.399598022026;11158.776824463464;11240.606578769704;11253.381064041556;11259.211855170059;10734.19493537972;11179.161562882817;11214.383208923424;11218.270812397168;11249.381284029458;8148.755537333889;8611.181937715906;8636.17956294151;8651.437656552303;8681.522516261666;5701.372848986525;5851.444112809277;5861.501772349227;5873.94126058751;6028.5177185825905;10321.174306055347;10373.533191006574;10510.106640935606;10578.471076445992;10617.787644246917;10650.254482186172;10771.138308935424;10830.620928267474;10857.945710271399;10868.239223254297;7220.963895180491;7962.84074318522;7983.2415920487465;8107.1892810718455;8194.34445244391;8752.168543988311;8906.465612063297;8959.148880856308;8986.32602554824;9029.142231487998;7685.077790665156;7802.570858602831;7936.127026027248;7959.283664470226;8019.318357939641;7809.1409944907155;7869.370450364072;7874.72438464651;7941.285284324438;7957.323627491496;6838.487113466411;6965.825854353681;6968.128983877015;6971.268016858156;6975.197852247056;4841.322214889848;4941.43173535048;4947.455779864284;4995.975020125022;5206.687598744087;5076.847694569169;5131.384233891957;5175.611829112907;5227.111391063452;5261.526772503705 05:33:34 INFO - PROCESS | 20388 | |4;prototype.html;305.911285727139;312.4064277872043;320.7145640380062;321.52253902954124;326.8480156727123;5351.304330437048;5434.2935418395655;5597.188407680884;5610.382857885635;5675.893200825841;5431.017678547331;5478.890422191554;5544.667319960795;5555.861103472405;5559.77760889565;4336.154449882274;4356.8910777230585;4357.041450880801;4373.278409062501;4374.3875857379835;4017.7388469749517;4233.978830105845;4256.5527720575;4365.279728844736;4403.251447253974;4204.759595919196;4213.325867861143;4216.7680777557225;4218.303979843337;4228.710243375769;4203.516595591515;4214.578542145791;4246.766427846467;4249.851255206084;4292.12011537634;3456.948145777815;3716.8513259469587;3723.94414083789;3725.6646901778972;3740.756850804689;5325.573954083664;5331.573474122061;5357.491038351351;5368.62419630626;5384.246205531229;4838.371011768483;4871.12319782439;4892.412910450733;4899.167141585904;4918.360613120307;5501.862453438656;5715.628484148517;5746;5766.769329226868;5771.451712087345;3999.9400008999596;4003.619656132663;4018.6584140347813;4024.577419370953;4048.5748996355546;5940.405959404068;6008.068749343859;6012.879742405171;6021.397860213988;6028.668423236721;4006.719529632898;4068.8372465101656;4121.4848143982;4140.875773726793;4151.958480415157;4124.4019617155345;4137.317342638491;4145.398917156996;4147.357159640261;4176.373543968429;4804.6876952997945;4817.16947559925;4835;4835.540623640749;4842.176829938849;5665.291838520185;5811.709414529257;5818.389069147764;5822.7088645567555;5835.912461313083;1423.9145651260958;1439.9496017639333;1440.488626537585;1441.7116576684705;1444.2634256529036;849.1762989899787;895.4314010603183;907.8865141857268;913.7532866126109;916.8441364967971;4867.004528143444;4903.656744027955;4918.45870972899;4924.384451943507;4927.87680307988;5225.947740522623;5308.75244317585;5324.615599943965;5326.280952071498;5356.866078348073;4569.817207311737;4897.461279259279;4961.950380496221;4982.252662100714;4982.526659967298;2789.7489225969352;2798.3004248937764;2800.509910765608;2800.6919238883706;2818.027380833425;5391.56867450603;5396.812701205728;5402;5406;5406.297181366397;5108.7975428309355;5130.48695130484;5253.737313134328;5347.598930080182;5350.678959262456;5315.176147697113;5359.5712343012465;5391.630231105559;5399.325084364455;5425.430329815392;5157.7679004444135;5175.37895452533;5215.913634546212;5258.316418865523;5270.525652691276;4930.408350997904;5108.28484012246;5123.1054454233235;5137.87155321105;5142.6914385137015;5322.281491998686;5397.812481254118;5414.458554144554;5428.565714742732;5441.374241962225;3845.3851381061145;3954.5847685992558;3994.2410941920944;4077.347624380085;4087.036898248865;5836.04492495002;5879.823605291848;5913.698986223024;5921.733521991435;5923.555733319932;5551.8889622206525;5809.331926828469;5814.918093410499;5815.651060936358;5832.737526811388;5699.287589051369;5709.54323654115;5745.97127014379;5760.913586296293;5798.739056742373;5756.136579513107;5785.566082543742;5801.448862358069;5812.430643726255;5829.183914251923;5554.972225138848;5731.8567035824435;5765.164051212634;5909.261342332208;5913.438223368773;5724.513416359656;5766.596338256281;5772.624779389326;5785.479306862402;5807.912881306699 05:33:34 INFO - PROCESS | 20388 | |5;yui.html;734.4675110544855;764.9426293028024;769.5228958046013;785.0696924144888;795.4312666443492;13444.865551344496;14101.2244326562;14602.12387256764;14631.195284259362;14662.973591848575;13868.583942481742;13956.302184890741;14034.087784294039;14083.29583520825;14096.506622268224;788.4756636836497;806.9838603227946;821.720614990903;824.4435006370676;826.450410477032;805.1344804335363;809.8299357135008;809.8420807942454;811.4036183405193;811.411726498287;863.6156910174975;868.8827008353886;870.3602851903846;871.8082021955191;871.8953725552942;856.195176534056;861.5347712235385;863.7883718488947;864.788126908905;866.3805379153904;626.4768917953469;628.1080865171467;629.6379581740472;630.5176539946945;632.2286810091726;14212.644683882882;14221.21783301918;14260.429582816674;14302.070365426214;14354.282285885663;12474.126811123226;12771.361431928459;13021.934890325489;13050.216986980717;13098.672533186651;10063.748406289827;10163.695089147264;10357.9482102589;10871.130309575294;11082.61210857616;4219.91560168798;4234.830606775725;4279.850205242833;4314.978425107885;4507.932381014288;78519.60740196319;84421;86357.56821215917;89820.99999999935;90638.54680726553;8881.467111973303;8916.55417229136;9006.234470070118;9099.772505687411;9214.401063930956;21244.575108497742;21276.78723212779;21327.68008479874;21467.78532214689;21695.13219471235;7620.847583048308;7665.655045522964;7680.385569154566;7858.685652573948;8040.557769322743;3908.843646254175;4003.939940900889;4014.6587540059422;4055.7972101395403;4135.8966025849595;3255.3977514159956;3352.6144493383085;3376;3386.9661303387143;3406.097384193191;598.3896425645904;608.2579253310954;616.1497133955113;617.305531277313;635.5170070746266;598.6168851934765;635.3170341882495;667.1460530520941;716.4626530102423;720.992790072103;8654.134586541295;8692.584772078002;8784.912150878537;8836.425632334007;8952.68665596701;590.7991282963812;593.2613895699795;688.7451642892062;692.4702602509085;702.2871785137987;4051.9392209116886;4188.832446702158;4222.831086756495;4374.496932852762;4437;111573.44213278881;126889;132667;133082.32259344656;139038;107703;108700.64967516242;111363;112134;114606;94181;94578;95546.52226738822;96197;96468.51765741127;8147.75556733299;8159.877601836096;8202.38482113832;8463;8484.637565874416;55277;56113.82747897646;56183;56705;58196;79197.60401197957;80282.5985870067;83282.16717832744;83863;85409.57295213484;10808.729781755519;11017.173711971795;11036.11711063097;11185.32888026721;11544.826827597424;11703.414829258674;11713.238639488405;11958.820617690568;12079.51681932748;12095.75808483843;10389.272750907667;10434.269601127848;10725.30285531438;10829.837552436562;11196.608118715805;11375.772484550429;11592.768144636892;11881;12019.21875078117;12290.692732681755;11140.665780026613;11306.773864522827;11455.026322762658;11784;11930.045596352444;9518.714438566854;9579.185769209695;9844.655437059955;9924.454155021254;10481.475926203811;8692.261157801659;9165.54172291396;9964.551595178089;10021.599136034478;10107.39355638664 05:33:34 INFO - PROCESS | 20388 | __end_tp_report 05:33:34 INFO - PROCESS | 20388 | __start_cc_report 05:33:34 INFO - PROCESS | 20388 | _x_x_mozilla_cycle_collect,357 05:33:34 INFO - PROCESS | 20388 | __end_cc_report 05:33:34 INFO - PROCESS | 20388 | __startTimestamp1474374814882__endTimestamp 05:33:34 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | ------- Summary: start ------- 05:33:34 INFO - PROCESS | 20388 | Number of tests: 6 05:33:34 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | [#0] dojo.html Cycles:165 Average:5424.78 Median:5655.43 stddev:623.48 (11.0%) stddev-sans-first:597.45 05:33:34 INFO - PROCESS | 20388 | Values: 3072.3 3095.5 3098.4 3116.6 3125.9 5380.4 5407.5 5447.5 5491.6 5536.3 5373.7 5393.4 5455.4 5471.1 5504.5 4909.5 4986.8 5023.7 5034.9 5099.9 5042.9 5050.4 5140.3 5158.6 5162.2 5032.6 5047.8 5065.9 5095.7 5138.4 4781.2 4878.2 4928.4 4983.3 5054.5 4856.8 4920.5 4921.1 4970.2 4993.0 5416.9 5509.3 5516.3 5517.7 5518.6 5787.5 5801.4 5855.1 5859.2 5886.5 5853.2 5876.4 5914.3 5914.7 5919.7 5258.8 5470.4 5473.4 5485.9 5505.9 5949.6 5990.2 6024.9 6042.8 6057.0 5769.5 5777.5 5786.2 5791.5 5795.7 5669.2 5826.4 5850.8 5859.2 5890.4 5547.0 5641.4 5756.5 5811.9 5831.7 5700.9 5730.2 5756.5 5758.6 5765.6 4313.9 4404.2 4409.1 4413.4 4444.0 3904.8 3943.5 3963.9 3966.9 3971.4 5493.2 5551.7 5562.5 5588.7 5591.8 5865.4 5894.9 5901.6 5910.5 5916.8 5352.7 5362.6 5388.6 5517.6 5549.8 4989.7 4993.6 5002.7 5030.7 5033.1 5927.1 5973.6 5976.1 5976.6 5981.6 5696.4 5787.5 5790.2 5792.4 5800.9 6014.2 6017.4 6018.2 6041.7 6063.7 5691.4 5748.1 5751.8 5754.4 5755.5 5605.4 5797.4 5827.9 5846.6 5849.1 5776.1 5781.5 5783.6 5812.8 5833.5 5718.8 5748.4 5761.2 5763.8 5772.6 5492.1 5636.9 5709.6 5717.7 5741.1 5804.9 5805.4 5815.1 5822.3 5841.7 5632.3 5644.1 5655.4 5664.3 5666.2 05:33:34 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | [#1] ext.html Cycles:180 Average:60508.63 Median:41517.19 stddev:124722.15 (300.4%) stddev-sans-first:124990.78 05:33:34 INFO - PROCESS | 20388 | Values: 549.8 568.8 589.2 598.0 620.1 41512.6 42624.0 42680.4 42699.8 42786.6 41957.0 42378.8 42423.4 42479.6 42590.0 8677.3 8721.0 8757.2 8770.4 8813.4 8699.2 8762.8 8786.7 8787.3 8836.4 8828.5 8863.1 8898.2 8899.5 8922.4 8788.6 8794.0 8819.5 8847.7 8865.2 8388.2 8697.3 8713.0 8765.4 8779.9 40117.6 40290.0 40418.0 40441.8 40712.2 3580.4 3607.3 3608.4 3705.3 3761.1 31553.4 31927.2 32037.4 32071.4 32121.0 4299.4 4347.2 4393.7 4406.1 4445.1 349029.3 349435.0 349583.0 349747.0 350778.0 31424.0 32398.2 54952.5 55276.0 55665.7 37041.0 37283.6 37345.0 37368.8 37408.6 15360.8 15474.3 15563.7 15613.3 15613.8 13015.5 13025.0 13075.2 13091.2 13106.9 8449.3 8456.0 8521.9 8557.3 8593.0 3283.7 3316.7 3331.9 3363.6 3466.3 983.3 985.7 1030.2 1074.2 1135.9 32057.5 32738.5 32747.8 33008.5 33160.3 1059.6 1128.1 1137.1 1144.0 1173.8 16898.2 17157.7 17159.5 17263.4 17407.2 554937.0 557185.0 558928.0 561535.0 562709.0 57806.7 58037.7 58099.1 58354.4 58366.4 1329.3 1350.8 1355.0 1382.6 1388.7 30872.4 32201.4 32778.5 32919.8 33144.3 49463.0 50831.2 50957.7 50963.2 51146.5 470676.0 471998.0 472513.0 473806.0 477851.0 28725.0 28757.4 28874.7 28879.9 29196.7 47632.3 47643.0 48000.8 48102.8 49910.0 40199.8 41375.0 41981.0 42297.6 42331.6 40675.6 40915.6 41174.4 41673.8 42334.6 41521.8 42101.4 43178.1 43393.1 43417.0 31391.5 36324.8 36996.8 37116.7 37364.8 28506.6 28544.6 29204.4 30507.2 30566.7 05:33:34 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | [#2] jquery.html Cycles:180 Average:29290.27 Median:2455.56 stddev:82546.60 (3361.6%) stddev-sans-first:82749.65 05:33:34 INFO - PROCESS | 20388 | Values: 394.6 396.1 401.2 404.2 420.4 18274.7 19644.2 19757.4 20103.4 20249.8 19393.6 19506.5 19910.5 20080.6 20169.8 5701.7 5769.2 5889.4 5971.7 6009.6 5989.7 6010.1 6019.8 6020.8 6031.0 6571.1 6619.2 6636.2 6641.4 6643.1 6047.4 6093.9 6174.5 6626.4 6629.9 5820.7 5845.4 5879.4 5882.6 5910.1 15714.0 22095.6 22815.5 22981.8 23173.4 2440.9 2447.7 2463.4 2837.9 2928.6 9846.8 9867.9 10063.1 10132.1 10458.2 1854.4 1918.8 1953.6 1971.7 1991.2 71871.0 73672.6 74088.0 84213.6 88800.0 10927.9 10963.3 11031.6 11218.0 11369.7 15304.2 15497.2 15521.3 15525.5 15568.0 8192.8 8417.2 8429.8 8454.7 8520.6 7925.7 8001.6 8252.1 8276.1 8307.3 4629.3 4679.1 4753.5 4779.7 4904.2 1984.5 2016.4 2035.6 2051.8 2062.9 888.6 932.5 949.9 1024.9 1030.0 20072.9 20457.9 20492.3 20579.4 20616.9 952.7 982.9 1023.3 1025.7 1037.9 10685.6 11090.7 11197.8 11207.8 11270.5 477498.0 487847.0 509202.0 514378.0 516922.0 83708.6 88030.6 89451.6 94188.0 99015.0 1000.7 1008.7 1028.8 1044.5 1044.6 17755.5 18015.3 18587.3 18598.2 18734.0 38619.2 41370.8 42761.0 43091.8 43518.0 55619.0 56614.7 59040.5 59202.4 60509.0 5679.0 6295.4 8560.9 8822.0 9111.4 7687.3 10703.9 11120.6 12747.9 13079.0 11046.3 11195.3 11221.6 11225.2 11232.4 11372.9 11570.5 11770.2 11770.2 11772.4 11061.5 11268.7 11299.0 11421.9 11425.1 8791.3 8909.6 8980.0 12013.5 12190.8 10998.2 11000.7 11559.8 11717.6 11956.9 05:33:34 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | [#3] mootools.html Cycles:180 Average:5919.94 Median:2611.65 stddev:3453.47 (132.2%) stddev-sans-first:3447.17 05:33:34 INFO - PROCESS | 20388 | Values: 1497.2 1524.1 1666.6 1703.5 1755.6 7846.8 8534.5 8706.6 9232.4 9242.5 8798.6 9000.7 9003.7 9060.7 9063.0 2241.4 2261.4 2261.9 2268.1 2271.3 2293.9 2302.4 2371.8 2377.1 2388.5 2297.5 2312.6 2321.8 2349.4 2354.5 2298.2 2299.6 2303.5 2305.4 2309.4 2278.5 2281.8 2286.3 2325.0 2327.6 8955.2 8998.1 9054.0 9064.5 9111.1 5211.2 5319.4 5364.7 5365.5 5370.8 3238.5 3269.3 3371.6 3422.6 3464.8 1178.4 1191.5 1209.1 1242.4 1247.5 12808.1 12846.9 12869.4 12890.9 12908.9 4446.1 4531.7 4681.9 4713.3 4826.4 10787.0 10804.8 10885.1 10886.1 10892.5 5429.3 5450.1 5451.9 5462.4 5462.5 4342.7 4746.3 4840.4 4984.5 4992.3 4106.8 4146.5 4161.3 4170.8 4222.7 1311.1 1320.4 1328.4 1330.2 1334.8 883.3 936.1 950.7 965.9 972.9 5925.8 5993.0 6034.2 6131.9 6132.9 477.0 488.7 496.7 497.7 498.3 3962.6 4105.2 4110.9 4122.5 4223.4 10916.4 11158.8 11240.6 11253.4 11259.2 10734.2 11179.2 11214.4 11218.3 11249.4 8148.8 8611.2 8636.2 8651.4 8681.5 5701.4 5851.4 5861.5 5873.9 6028.5 10321.2 10373.5 10510.1 10578.5 10617.8 10650.3 10771.1 10830.6 10857.9 10868.2 7221.0 7962.8 7983.2 8107.2 8194.3 8752.2 8906.5 8959.1 8986.3 9029.1 7685.1 7802.6 7936.1 7959.3 8019.3 7809.1 7869.4 7874.7 7941.3 7957.3 6838.5 6965.8 6968.1 6971.3 6975.2 4841.3 4941.4 4947.5 4996.0 5206.7 5076.8 5131.4 5175.6 5227.1 5261.5 05:33:34 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | [#4] prototype.html Cycles:180 Average:4656.20 Median:5239.84 stddev:1367.28 (26.1%) stddev-sans-first:1331.56 05:33:34 INFO - PROCESS | 20388 | Values: 305.9 312.4 320.7 321.5 326.8 5351.3 5434.3 5597.2 5610.4 5675.9 5431.0 5478.9 5544.7 5555.9 5559.8 4336.2 4356.9 4357.0 4373.3 4374.4 4017.7 4234.0 4256.6 4365.3 4403.3 4204.8 4213.3 4216.8 4218.3 4228.7 4203.5 4214.6 4246.8 4249.9 4292.1 3456.9 3716.9 3723.9 3725.7 3740.8 5325.6 5331.6 5357.5 5368.6 5384.2 4838.4 4871.1 4892.4 4899.2 4918.4 5501.9 5715.6 5746.0 5766.8 5771.5 3999.9 4003.6 4018.7 4024.6 4048.6 5940.4 6008.1 6012.9 6021.4 6028.7 4006.7 4068.8 4121.5 4140.9 4152.0 4124.4 4137.3 4145.4 4147.4 4176.4 4804.7 4817.2 4835.0 4835.5 4842.2 5665.3 5811.7 5818.4 5822.7 5835.9 1423.9 1439.9 1440.5 1441.7 1444.3 849.2 895.4 907.9 913.8 916.8 4867.0 4903.7 4918.5 4924.4 4927.9 5225.9 5308.8 5324.6 5326.3 5356.9 4569.8 4897.5 4962.0 4982.3 4982.5 2789.7 2798.3 2800.5 2800.7 2818.0 5391.6 5396.8 5402.0 5406.0 5406.3 5108.8 5130.5 5253.7 5347.6 5350.7 5315.2 5359.6 5391.6 5399.3 5425.4 5157.8 5175.4 5215.9 5258.3 5270.5 4930.4 5108.3 5123.1 5137.9 5142.7 5322.3 5397.8 5414.5 5428.6 5441.4 3845.4 3954.6 3994.2 4077.3 4087.0 5836.0 5879.8 5913.7 5921.7 5923.6 5551.9 5809.3 5814.9 5815.7 5832.7 5699.3 5709.5 5746.0 5760.9 5798.7 5756.1 5785.6 5801.4 5812.4 5829.2 5555.0 5731.9 5765.2 5909.3 5913.4 5724.5 5766.6 5772.6 5785.5 5807.9 05:33:34 INFO - PROCESS | 20388 | 05:33:34 INFO - PROCESS | 20388 | [#5] yui.html Cycles:180 Average:21672.96 Median:56444.00 stddev:33870.22 (60.0%) stddev-sans-first:33928.75 05:33:34 INFO - PROCESS | 20388 | Values: 734.5 764.9 769.5 785.1 795.4 13444.9 14101.2 14602.1 14631.2 14663.0 13868.6 13956.3 14034.1 14083.3 14096.5 788.5 807.0 821.7 824.4 826.5 805.1 809.8 809.8 811.4 811.4 863.6 868.9 870.4 871.8 871.9 856.2 861.5 863.8 864.8 866.4 626.5 628.1 629.6 630.5 632.2 14212.6 14221.2 14260.4 14302.1 14354.3 12474.1 12771.4 13021.9 13050.2 13098.7 10063.7 10163.7 10357.9 10871.1 11082.6 4219.9 4234.8 4279.9 4315.0 4507.9 78519.6 84421.0 86357.6 89821.0 90638.5 8881.5 8916.6 9006.2 9099.8 9214.4 21244.6 21276.8 21327.7 21467.8 21695.1 7620.8 7665.7 7680.4 7858.7 8040.6 3908.8 4003.9 4014.7 4055.8 4135.9 3255.4 3352.6 3376.0 3387.0 3406.1 598.4 608.3 616.1 617.3 635.5 598.6 635.3 667.1 716.5 721.0 8654.1 8692.6 8784.9 8836.4 8952.7 590.8 593.3 688.7 692.5 702.3 4051.9 4188.8 4222.8 4374.5 4437.0 111573.4 126889.0 132667.0 133082.3 139038.0 107703.0 108700.6 111363.0 112134.0 114606.0 94181.0 94578.0 95546.5 96197.0 96468.5 8147.8 8159.9 8202.4 8463.0 8484.6 55277.0 56113.8 56183.0 56705.0 58196.0 79197.6 80282.6 83282.2 83863.0 85409.6 10808.7 11017.2 11036.1 11185.3 11544.8 11703.4 11713.2 11958.8 12079.5 12095.8 10389.3 10434.3 10725.3 10829.8 11196.6 11375.8 11592.8 11881.0 12019.2 12290.7 11140.7 11306.8 11455.0 11784.0 11930.0 9518.7 9579.2 9844.7 9924.5 10481.5 8692.3 9165.5 9964.6 10021.6 10107.4 05:33:34 INFO - PROCESS | 20388 | -------- Summary: end -------- 05:33:34 INFO - PROCESS | 20388 | 05:33:35 INFO - TEST-INFO | 20388: exit 0 05:33:35 INFO - TEST-OK | dromaeo_css | took 1112647ms 05:33:35 INFO - TEST-START | kraken 05:33:35 INFO - operating with platform_type : linux_ 05:33:35 INFO - Initialising browser for kraken test... 05:33:35 INFO - TEST-INFO | started process 20634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUBgR_d/profile http://localhost:39580/getInfo.html) 05:33:39 INFO - PROCESS | 20634 | __metrics Screen width/height:1600/1200 05:33:39 INFO - PROCESS | 20634 | colorDepth:24 05:33:39 INFO - PROCESS | 20634 | Browser inner width/height: 1024/697 05:33:39 INFO - PROCESS | 20634 | __metrics 05:33:40 ERROR - PROCESS | 20634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:33:41 INFO - TEST-INFO | 20634: exit 0 05:33:41 INFO - Browser initialized. 05:33:41 INFO - Running cycle 1/1 for kraken test... 05:33:41 INFO - TEST-INFO | started process 20755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUBgR_d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:52 INFO - PROCESS | 20755 | RSS: Main: 164048896 05:33:52 INFO - PROCESS | 20755 | 05:33:55 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39580/tests/kraken/driver.html?testName=audio-beat-detection) 05:33:56 INFO - PROCESS | 20755 | RSS: Main: 169275392 05:33:56 INFO - PROCESS | 20755 | 05:33:59 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39580/tests/kraken/driver.html?testName=audio-dft) 05:33:59 INFO - PROCESS | 20755 | RSS: Main: 168636416 05:33:59 INFO - PROCESS | 20755 | 05:34:02 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39580/tests/kraken/driver.html?testName=audio-fft) 05:34:03 INFO - PROCESS | 20755 | RSS: Main: 164274176 05:34:03 INFO - PROCESS | 20755 | 05:34:05 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39580/tests/kraken/driver.html?testName=audio-oscillator) 05:34:05 INFO - PROCESS | 20755 | RSS: Main: 165347328 05:34:05 INFO - PROCESS | 20755 | 05:34:08 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:08 INFO - PROCESS | 20755 | RSS: Main: 165531648 05:34:08 INFO - PROCESS | 20755 | 05:34:11 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39580/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:12 INFO - PROCESS | 20755 | RSS: Main: 165908480 05:34:12 INFO - PROCESS | 20755 | 05:34:15 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39580/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:16 INFO - PROCESS | 20755 | RSS: Main: 163201024 05:34:16 INFO - PROCESS | 20755 | 05:34:19 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39580/tests/kraken/driver.html?testName=json-parse-financial) 05:34:20 INFO - PROCESS | 20755 | RSS: Main: 164864000 05:34:20 INFO - PROCESS | 20755 | 05:34:21 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:22 INFO - PROCESS | 20755 | RSS: Main: 165453824 05:34:22 INFO - PROCESS | 20755 | 05:34:23 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39580/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:24 INFO - PROCESS | 20755 | RSS: Main: 166076416 05:34:24 INFO - PROCESS | 20755 | 05:34:26 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:27 INFO - PROCESS | 20755 | RSS: Main: 166518784 05:34:27 INFO - PROCESS | 20755 | 05:34:30 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:34:30 INFO - PROCESS | 20755 | RSS: Main: 166105088 05:34:30 INFO - PROCESS | 20755 | 05:34:33 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:34:34 INFO - PROCESS | 20755 | RSS: Main: 166821888 05:34:34 INFO - PROCESS | 20755 | 05:34:35 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:39580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39580/tests/kraken/driver.html?testName=ai-astar) 05:34:36 INFO - PROCESS | 20755 | RSS: Main: 166981632 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | __start_tp_report 05:34:36 INFO - PROCESS | 20755 | _x_x_mozilla_page_load 05:34:36 INFO - PROCESS | 20755 | _x_x_mozilla_page_load_details 05:34:36 INFO - PROCESS | 20755 | |i|pagename|runs| 05:34:36 INFO - PROCESS | 20755 | |0;ai-astar;102;115;106;113;112;114;113;114;113;111 05:34:36 INFO - PROCESS | 20755 | |1;audio-beat-detection;153;119;144;171;119;146;155;118;177;122 05:34:36 INFO - PROCESS | 20755 | |2;audio-dft;163;163;164;163;163;168;169;162;164;163 05:34:36 INFO - PROCESS | 20755 | |3;audio-fft;76;77;75;175;76;74;76;76;165;77 05:34:36 INFO - PROCESS | 20755 | |4;audio-oscillator;83;83;166;84;85;84;144;83;84;150 05:34:36 INFO - PROCESS | 20755 | |5;imaging-gaussian-blur;118;117;118;117;118;117;118;117;120;117 05:34:36 INFO - PROCESS | 20755 | |6;imaging-darkroom;148;148;147;147;148;147;147;146;147;147 05:34:36 INFO - PROCESS | 20755 | |7;imaging-desaturate;96;96;97;97;95;97;95;96;96;96 05:34:36 INFO - PROCESS | 20755 | |8;json-parse-financial;54;53;54;53;54;54;52;51;52;62 05:34:36 INFO - PROCESS | 20755 | |9;json-stringify-tinderbox;62;61;60;61;60;60;60;60;60;62 05:34:36 INFO - PROCESS | 20755 | |10;stanford-crypto-aes;78;76;84;80;76;78;75;78;80;76 05:34:36 INFO - PROCESS | 20755 | |11;stanford-crypto-ccm;122;140;137;126;137;129;138;135;128;129 05:34:36 INFO - PROCESS | 20755 | |12;stanford-crypto-pbkdf2;163;160;169;166;169;161;167;164;161;161 05:34:36 INFO - PROCESS | 20755 | |13;stanford-crypto-sha256-iterative;64;65;65;63;67;64;69;66;65;68 05:34:36 INFO - PROCESS | 20755 | __end_tp_report 05:34:36 INFO - PROCESS | 20755 | __start_cc_report 05:34:36 INFO - PROCESS | 20755 | _x_x_mozilla_cycle_collect,838 05:34:36 INFO - PROCESS | 20755 | __end_cc_report 05:34:36 INFO - PROCESS | 20755 | __startTimestamp1474374876151__endTimestamp 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | ------- Summary: start ------- 05:34:36 INFO - PROCESS | 20755 | Number of tests: 14 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:4.11 (3.6%) stddev-sans-first:2.65 05:34:36 INFO - PROCESS | 20755 | Values: 102.0 115.0 106.0 113.0 112.0 114.0 113.0 114.0 113.0 111.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:149.50 stddev:22.13 (14.8%) stddev-sans-first:23.14 05:34:36 INFO - PROCESS | 20755 | Values: 153.0 119.0 144.0 171.0 119.0 146.0 155.0 118.0 177.0 122.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.35 (1.4%) stddev-sans-first:2.45 05:34:36 INFO - PROCESS | 20755 | Values: 163.0 163.0 164.0 163.0 163.0 168.0 169.0 162.0 164.0 163.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.77 (52.3%) stddev-sans-first:41.60 05:34:36 INFO - PROCESS | 20755 | Values: 76.0 77.0 75.0 175.0 76.0 74.0 76.0 76.0 165.0 77.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:83.50 stddev:34.06 (40.8%) stddev-sans-first:35.22 05:34:36 INFO - PROCESS | 20755 | Values: 83.0 83.0 166.0 84.0 85.0 84.0 144.0 83.0 84.0 150.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 05:34:36 INFO - PROCESS | 20755 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 120.0 117.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 05:34:36 INFO - PROCESS | 20755 | Values: 148.0 148.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 05:34:36 INFO - PROCESS | 20755 | Values: 96.0 96.0 97.0 97.0 95.0 97.0 95.0 96.0 96.0 96.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:3.03 (5.6%) stddev-sans-first:3.22 05:34:36 INFO - PROCESS | 20755 | Values: 54.0 53.0 54.0 53.0 54.0 54.0 52.0 51.0 52.0 62.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 05:34:36 INFO - PROCESS | 20755 | Values: 62.0 61.0 60.0 61.0 60.0 60.0 60.0 60.0 60.0 62.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:2.69 (3.4%) stddev-sans-first:2.85 05:34:36 INFO - PROCESS | 20755 | Values: 78.0 76.0 84.0 80.0 76.0 78.0 75.0 78.0 80.0 76.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:136.00 stddev:6.05 (4.4%) stddev-sans-first:5.19 05:34:36 INFO - PROCESS | 20755 | Values: 122.0 140.0 137.0 126.0 137.0 129.0 138.0 135.0 128.0 129.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:165.00 stddev:3.45 (2.1%) stddev-sans-first:3.63 05:34:36 INFO - PROCESS | 20755 | Values: 163.0 160.0 169.0 166.0 169.0 161.0 167.0 164.0 161.0 161.0 05:34:36 INFO - PROCESS | 20755 | 05:34:36 INFO - PROCESS | 20755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.90 (2.9%) stddev-sans-first:1.92 05:34:36 INFO - PROCESS | 20755 | Values: 64.0 65.0 65.0 63.0 67.0 64.0 69.0 66.0 65.0 68.0 05:34:36 INFO - PROCESS | 20755 | -------- Summary: end -------- 05:34:36 INFO - PROCESS | 20755 | 05:34:37 INFO - TEST-INFO | 20755: exit 0 05:34:37 INFO - TEST-OK | kraken | took 61459ms 05:34:37 INFO - SUITE-END | took 1174s 05:34:37 INFO - Completed test suite (00:19:34) 05:34:37 INFO - javascript benchmark 05:34:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7151.750306672272, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.262656962329, 3095.4582947984095, 3098.411301852649, 3116.5792617996563, 3125.8593363298637, 5380.408155102936, 5407.459254074591, 5447.509724124833, 5491.643043202194, 5536.252605898202, 5373.677579345242, 5393.352797664276, 5455.427180146087, 5471.097268950618, 5504.4770746779095, 4909.48450412706, 4986.800527978877, 5023.673461225027, 5034.949650503485, 5099.872503187431, 5042.949570504303, 5050.368703912011, 5140.306058682087, 5158.5873130149685, 5162.174052151657, 5032.622553308516, 5047.798088076473, 5065.898682026357, 5095.6942583444925, 5138.434772175076, 4781.235002399634, 4878.195097808857, 4928.383952005999, 4983.252512123175, 5054.545090941833, 4856.8300109495995, 4920.4833492483485, 4921.064997650471, 4970.229614409773, 4992.950070499285, 5416.91874621881, 5509.311336082989, 5516.255305533782, 5517.668939863621, 5518.586106042023, 5787.536997040227, 5801.448862358069, 5855.092460668603, 5859.2382990211, 5886.499647529965, 5853.180554722299, 5876.4123587641325, 5914.260717410324, 5914.733836977303, 5919.733611987471, 5258.763355649005, 5470.398256191816, 5473.397926228112, 5485.917711234335, 5505.917411238835, 5949.583529153005, 5990.191324171181, 6024.909626355608, 6042.818715438544, 6057.0, 5769.538436925036, 5777.508911742465, 5786.218860453785, 5791.478766910998, 5795.739191736382, 5669.234653321749, 5826.359100498942, 5850.824475265749, 5859.2090067841145, 5890.3815099414805, 5547.0, 5641.351244606841, 5756.539476841843, 5811.912821307684, 5831.679257640871, 5700.9429905701245, 5730.169125476866, 5756.453136951983, 5758.625689330264, 5765.567582431335, 4313.870583882489, 4404.207242696345, 4409.1181763646755, 4413.360062790877, 4444.0, 3904.8047597620007, 3943.526776786804, 3963.8612648557164, 3966.861159859391, 3971.384435412516, 5493.176023596492, 5551.694656793915, 5562.499375056183, 5588.720563971785, 5591.776328946797, 5865.35481097079, 5894.911576326359, 5901.645901245939, 5910.497607703307, 5916.822495325147, 5352.705601191972, 5362.624616276901, 5388.622796404214, 5517.641353312022, 5549.833504994856, 4989.7006179628615, 4993.575546078551, 5002.749862506933, 5030.698158110525, 5033.094043072282, 5927.110933359944, 5973.611715238496, 5976.103584462366, 5976.581639285295, 5981.641101533922, 5696.373398926032, 5787.479126878601, 5790.218320526844, 5792.420757924174, 5800.854978625568, 6014.188084608521, 6017.3681763414215, 6018.247719035121, 6041.6677082759115, 6063.696815159313, 5691.402402747652, 5748.080307150836, 5751.798687045934, 5754.424557544212, 5755.510781583613, 5605.439456054362, 5797.420257974169, 5827.912581311199, 5846.619969701956, 5849.064149736022, 5776.133579963039, 5781.508571771446, 5783.566232532493, 5812.82561523155, 5833.4749872511675, 5718.828435146952, 5748.367679555162, 5761.2222349983895, 5763.7982670606325, 5772.6247793894945, 5492.0663487206475, 5636.943630563642, 5709.628874123168, 5717.714114294352, 5741.110127930177, 5804.883902322014, 5805.390434004369, 5815.069588865761, 5822.272215973004, 5841.707914604168, 5632.295963004624, 5644.125160600113, 5655.4344565543115, 5664.348599910898, 5666.206731057573], "value": 5381.610734190052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.7987262540287, 568.7696482924416, 589.1545632018054, 598.0431309904154, 620.1101419463068, 41512.58487415129, 42624.0, 42680.35979460303, 42699.78650106753, 42786.57213427873, 41957.0, 42378.7881060595, 42423.3636495452, 42479.57520424795, 42590.0, 8677.3491988101, 8721.0, 8757.168069033432, 8770.386072974863, 8813.38306318558, 8699.217070463657, 8762.780930476725, 8786.736397908042, 8787.25308348791, 8836.381453298272, 8828.514431706253, 8863.069377715343, 8898.243649289818, 8899.510526921016, 8922.420042697237, 8788.560571971408, 8793.999999999967, 8819.51492667903, 8847.690330838454, 8865.246454051414, 8388.245057944814, 8697.304215662733, 8713.041565427799, 8765.386422950396, 8779.912200877974, 40117.59882401197, 40290.0, 40418.0, 40441.79779101115, 40712.185756285005, 3580.3555360035184, 3607.3146102240753, 3608.350496910555, 3705.2959937611768, 3761.097336639214, 31553.368932621448, 31927.201819954687, 32037.359252814815, 32071.358572828412, 32121.0, 4299.419578356944, 4347.1957687827535, 4393.7363758174615, 4406.140802543506, 4445.110977804452, 349029.25485372666, 349435.0, 349583.0, 349747.0, 350778.0, 31424.0, 32398.19004524906, 54952.450475495534, 55276.0, 55665.72167139138, 37041.0, 37283.62716372856, 37345.0, 37368.81315593405, 37408.625913740514, 15360.846391536164, 15474.303656335493, 15563.688726225639, 15613.297401616954, 15613.765793513106, 13015.544455943997, 13025.0, 13075.150115242479, 13091.214527128403, 13106.934465327613, 8449.32405407566, 8455.957720211483, 8521.872171917426, 8557.27263182624, 8592.957035214784, 3283.7208837248622, 3316.718078963267, 3331.93336133276, 3363.613184483767, 3466.2547552276383, 983.2871168402851, 985.7042887133831, 1030.160419258302, 1074.237291523012, 1135.9318440893574, 32057.51913721296, 32738.508922366185, 32747.83626081902, 33008.53410391922, 33160.336793264, 1059.6079450603327, 1128.1482480727, 1137.113051819582, 1144.0275765599174, 1173.7652469506133, 16898.239579218964, 17157.742633860504, 17159.485215443558, 17263.39578114785, 17407.21667524939, 554937.0, 557185.0, 558928.0, 561535.0, 562709.0, 57806.7109664449, 58037.70981145067, 58099.12851307234, 58354.416455835744, 58366.4163358361, 1329.2622594460167, 1350.750111229406, 1354.966125846842, 1382.585224432666, 1388.7361401333715, 30872.382552349278, 32201.35597287994, 32778.50832237566, 32919.83540082284, 33144.33711325808, 49463.0, 50831.237531436316, 50957.74521127371, 50963.2355514675, 51146.48853511566, 470676.0, 471998.0, 472513.0, 473806.0, 477851.0, 28724.978503010014, 28757.424851502434, 28874.711252887202, 28879.85560072186, 29196.7080329194, 47632.28551571799, 47643.0, 48000.7599961998, 48102.759486203744, 49910.0, 40199.79900100481, 41375.0, 41980.954643542944, 42297.577024229366, 42331.576684233994, 40675.59324406718, 40915.59084409237, 41174.38238426366, 41673.79163104165, 42334.57665423306, 41521.79239103785, 42101.36847947222, 43178.13643727171, 43393.13213735771, 43417.0, 31391.529127063568, 36324.818375907955, 36996.7801931885, 37116.69771879244, 37364.813175933945, 28506.57240141441, 28544.57183142296, 29204.415911682074, 30507.2373190672, 30566.694333056384], "value": 18942.00863633631, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.615250131122, 396.1344462349764, 401.1775859488049, 404.22590738735335, 420.4240190938413, 18274.725879111807, 19644.214231430742, 19757.407277781673, 20103.396898093044, 20249.785012899236, 19393.612127757435, 19506.512337191576, 19910.50223744407, 20080.598388032267, 20169.798302016974, 5701.6864072476, 5769.221155144044, 5889.352171261179, 5971.731272092767, 6009.639421634694, 5989.700514974255, 6010.12853136295, 6019.819405417845, 6020.8494787630225, 6031.0, 6571.080048793173, 6619.238787539446, 6636.2413960300555, 6641.435477984353, 6643.103181070542, 6047.425494578008, 6093.878122437571, 6174.475169610611, 6626.403623673868, 6629.867402651944, 5820.738066786962, 5845.415458454163, 5879.382664820175, 5882.6470411775, 5910.054391297372, 15714.0, 22095.558088838294, 22815.54368912629, 22981.770182298296, 23173.420664483354, 2440.865752383618, 2447.7027175596963, 2463.4210960424284, 2837.8581070946575, 2928.6485621725315, 9846.803063938753, 9867.851982220272, 10063.088013277455, 10132.138768204712, 10458.163346932302, 1854.3973208707089, 1918.8368988635982, 1953.5740054238356, 1971.7239586457908, 1991.2333751505776, 71871.0, 73672.63163684201, 74088.0, 84213.57893210556, 88800.0, 10927.945360273307, 10963.287386319864, 11031.558737650405, 11218.0, 11369.658910232707, 15304.234788260543, 15497.225138743017, 15521.301541430663, 15525.456609018856, 15568.0, 8192.795180120545, 8417.158284171534, 8429.789255268668, 8454.661813527513, 8520.616572254263, 7925.682972681144, 8001.5599142046585, 8252.05101413345, 8276.08963014068, 8307.252347288773, 4629.282461218517, 4679.134360143385, 4753.548412900769, 4779.737114458738, 4904.215325547966, 1984.454275074366, 2016.4353980885376, 2035.5725297687354, 2051.753789545264, 2062.9174833006814, 888.5557221389305, 932.5430539035824, 949.8622699708503, 1024.912882404989, 1029.9588016479406, 20072.89963550173, 20457.89771051165, 20492.282770102975, 20579.38261852117, 20616.896915515626, 952.6760901293455, 982.9017098290257, 1023.3450591621369, 1025.738436698637, 1037.9169666426667, 10685.572577096984, 11090.667279981613, 11197.832032519518, 11207.831882521768, 11270.492827822767, 477498.0, 487847.0, 509202.0, 514378.0, 516922.0, 83708.58145709355, 88030.55984720163, 89451.55274223717, 94188.0, 99015.0, 1000.7298029531986, 1008.7125169326706, 1028.7736697926593, 1044.4934206909643, 1044.6291566493785, 17755.46733597994, 18015.2793888243, 18587.256509739458, 18598.163082661584, 18734.0, 38619.22761544809, 41370.79314603408, 42761.0, 43091.7845410771, 43518.0, 55619.0, 56614.7169264151, 59040.52398690067, 59202.40797591969, 60509.0, 5679.0, 6295.433410993032, 8560.887084678952, 8821.955890220508, 9111.407758495676, 7687.346575541142, 10703.892961070289, 11120.608214494658, 12747.87252127504, 13079.0, 11046.33721976684, 11195.328280303207, 11221.55113795439, 11225.15811314171, 11232.382218978035, 11372.886271137182, 11570.537178513101, 11770.17608767378, 11770.234934729215, 11772.352520611448, 11061.502232399722, 11268.661940141808, 11299.039581635652, 11421.885781142082, 11425.143114266297, 8791.296696264155, 8909.643614255358, 8980.0, 12013.519459221534, 12190.817137743119, 10998.230123891251, 11000.669979900616, 11559.768804623693, 11717.589884354007, 11956.940215298868], "value": 9350.494629752817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.1989985357832, 1524.1464779723353, 1666.5833541614597, 1703.488953314007, 1755.648870225955, 7846.764597062083, 8534.530600816952, 8706.608202630881, 9232.399894006894, 9242.537873106343, 8798.648054077828, 9000.739896414507, 9003.729888103368, 9060.72817815465, 9063.0, 2241.350008497534, 2261.400728806859, 2261.9208327708534, 2268.0587556164173, 2271.2618399020303, 2293.9311820645407, 2302.3898666853297, 2371.7983971362455, 2377.1442280778906, 2388.4625959159225, 2297.4600968772324, 2312.6415405612156, 2321.802646775026, 2349.400902769791, 2354.458474550854, 2298.2186056740707, 2299.5860745065797, 2303.527776805759, 2305.3545007397956, 2309.4111001694628, 2278.453171238907, 2281.8174546036444, 2286.34839070864, 2324.9883750581307, 2327.592671282519, 8955.238804701608, 8998.100189981014, 9054.0, 9064.456132632064, 9111.134442227978, 5211.218317252405, 5319.414864364917, 5364.7317634118135, 5365.463453654643, 5370.758315875795, 3238.5466034755154, 3269.3134441767256, 3371.561696979377, 3422.5892892852767, 3464.7747896386654, 1178.387238635913, 1191.4638412714314, 1209.0508950473836, 1242.3539759325101, 1247.4698253242427, 12808.10343275971, 12846.871531284662, 12869.356532173448, 12890.935545322214, 12908.935455322664, 4446.1330040642415, 4531.728096314232, 4681.906361872811, 4713.316569097462, 4826.444958829779, 10786.975237352439, 10804.837927431096, 10885.074768644754, 10886.129109671207, 10892.509837057352, 5429.267048948421, 5450.127979523258, 5451.863703407446, 5462.371827239839, 5462.508374246337, 4342.6742994275555, 4746.311784791255, 4840.443349014909, 4984.501549844987, 4992.301077849104, 4106.753594784323, 4146.543880173179, 4161.271777438997, 4170.77060761655, 4222.678875325548, 1311.1477539599146, 1320.4124164746595, 1328.4287756264898, 1330.2484096485648, 1334.7997800329833, 883.2624758326741, 936.1200471556715, 950.7337945375306, 965.8551217317319, 972.9027097290356, 5925.785214031113, 5993.0, 6034.24571928509, 6131.908021379683, 6132.938670613326, 476.99284510732366, 488.68724016629386, 496.7044608457962, 497.70884032841195, 498.3023766726612, 3962.5641179470235, 4105.220008198433, 4110.897227569275, 4122.525909520384, 4223.366495025771, 10916.399598022026, 11158.776824463464, 11240.606578769704, 11253.381064041556, 11259.211855170059, 10734.19493537972, 11179.161562882817, 11214.383208923424, 11218.270812397168, 11249.381284029458, 8148.755537333889, 8611.181937715906, 8636.17956294151, 8651.437656552303, 8681.522516261666, 5701.372848986525, 5851.444112809277, 5861.501772349227, 5873.94126058751, 6028.5177185825905, 10321.174306055347, 10373.533191006574, 10510.106640935606, 10578.471076445992, 10617.787644246917, 10650.254482186172, 10771.138308935424, 10830.620928267474, 10857.945710271399, 10868.239223254297, 7220.963895180491, 7962.84074318522, 7983.2415920487465, 8107.1892810718455, 8194.34445244391, 8752.168543988311, 8906.465612063297, 8959.148880856308, 8986.32602554824, 9029.142231487998, 7685.077790665156, 7802.570858602831, 7936.127026027248, 7959.283664470226, 8019.318357939641, 7809.1409944907155, 7869.370450364072, 7874.72438464651, 7941.285284324438, 7957.323627491496, 6838.487113466411, 6965.825854353681, 6968.128983877015, 6971.268016858156, 6975.197852247056, 4841.322214889848, 4941.43173535048, 4947.455779864284, 4995.975020125022, 5206.687598744087, 5076.847694569169, 5131.384233891957, 5175.611829112907, 5227.111391063452, 5261.526772503705], "value": 4637.552763897487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.911285727139, 312.4064277872043, 320.7145640380062, 321.52253902954124, 326.8480156727123, 5351.304330437048, 5434.2935418395655, 5597.188407680884, 5610.382857885635, 5675.893200825841, 5431.017678547331, 5478.890422191554, 5544.667319960795, 5555.861103472405, 5559.77760889565, 4336.154449882274, 4356.8910777230585, 4357.041450880801, 4373.278409062501, 4374.3875857379835, 4017.7388469749517, 4233.978830105845, 4256.5527720575, 4365.279728844736, 4403.251447253974, 4204.759595919196, 4213.325867861143, 4216.7680777557225, 4218.303979843337, 4228.710243375769, 4203.516595591515, 4214.578542145791, 4246.766427846467, 4249.851255206084, 4292.12011537634, 3456.948145777815, 3716.8513259469587, 3723.94414083789, 3725.6646901778972, 3740.756850804689, 5325.573954083664, 5331.573474122061, 5357.491038351351, 5368.62419630626, 5384.246205531229, 4838.371011768483, 4871.12319782439, 4892.412910450733, 4899.167141585904, 4918.360613120307, 5501.862453438656, 5715.628484148517, 5746.0, 5766.769329226868, 5771.451712087345, 3999.9400008999596, 4003.619656132663, 4018.6584140347813, 4024.577419370953, 4048.5748996355546, 5940.405959404068, 6008.068749343859, 6012.879742405171, 6021.397860213988, 6028.668423236721, 4006.719529632898, 4068.8372465101656, 4121.4848143982, 4140.875773726793, 4151.958480415157, 4124.4019617155345, 4137.317342638491, 4145.398917156996, 4147.357159640261, 4176.373543968429, 4804.6876952997945, 4817.16947559925, 4835.0, 4835.540623640749, 4842.176829938849, 5665.291838520185, 5811.709414529257, 5818.389069147764, 5822.7088645567555, 5835.912461313083, 1423.9145651260958, 1439.9496017639333, 1440.488626537585, 1441.7116576684705, 1444.2634256529036, 849.1762989899787, 895.4314010603183, 907.8865141857268, 913.7532866126109, 916.8441364967971, 4867.004528143444, 4903.656744027955, 4918.45870972899, 4924.384451943507, 4927.87680307988, 5225.947740522623, 5308.75244317585, 5324.615599943965, 5326.280952071498, 5356.866078348073, 4569.817207311737, 4897.461279259279, 4961.950380496221, 4982.252662100714, 4982.526659967298, 2789.7489225969352, 2798.3004248937764, 2800.509910765608, 2800.6919238883706, 2818.027380833425, 5391.56867450603, 5396.812701205728, 5402.0, 5406.0, 5406.297181366397, 5108.7975428309355, 5130.48695130484, 5253.737313134328, 5347.598930080182, 5350.678959262456, 5315.176147697113, 5359.5712343012465, 5391.630231105559, 5399.325084364455, 5425.430329815392, 5157.7679004444135, 5175.37895452533, 5215.913634546212, 5258.316418865523, 5270.525652691276, 4930.408350997904, 5108.28484012246, 5123.1054454233235, 5137.87155321105, 5142.6914385137015, 5322.281491998686, 5397.812481254118, 5414.458554144554, 5428.565714742732, 5441.374241962225, 3845.3851381061145, 3954.5847685992558, 3994.2410941920944, 4077.347624380085, 4087.036898248865, 5836.04492495002, 5879.823605291848, 5913.698986223024, 5921.733521991435, 5923.555733319932, 5551.8889622206525, 5809.331926828469, 5814.918093410499, 5815.651060936358, 5832.737526811388, 5699.287589051369, 5709.54323654115, 5745.97127014379, 5760.913586296293, 5798.739056742373, 5756.136579513107, 5785.566082543742, 5801.448862358069, 5812.430643726255, 5829.183914251923, 5554.972225138848, 5731.8567035824435, 5765.164051212634, 5909.261342332208, 5913.438223368773, 5724.513416359656, 5766.596338256281, 5772.624779389326, 5785.479306862402, 5807.912881306699], "value": 4212.6508042423, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.4675110544855, 764.9426293028024, 769.5228958046013, 785.0696924144888, 795.4312666443492, 13444.865551344496, 14101.2244326562, 14602.12387256764, 14631.195284259362, 14662.973591848575, 13868.583942481742, 13956.302184890741, 14034.087784294039, 14083.29583520825, 14096.506622268224, 788.4756636836497, 806.9838603227946, 821.720614990903, 824.4435006370676, 826.450410477032, 805.1344804335363, 809.8299357135008, 809.8420807942454, 811.4036183405193, 811.411726498287, 863.6156910174975, 868.8827008353886, 870.3602851903846, 871.8082021955191, 871.8953725552942, 856.195176534056, 861.5347712235385, 863.7883718488947, 864.788126908905, 866.3805379153904, 626.4768917953469, 628.1080865171467, 629.6379581740472, 630.5176539946945, 632.2286810091726, 14212.644683882882, 14221.21783301918, 14260.429582816674, 14302.070365426214, 14354.282285885663, 12474.126811123226, 12771.361431928459, 13021.934890325489, 13050.216986980717, 13098.672533186651, 10063.748406289827, 10163.695089147264, 10357.9482102589, 10871.130309575294, 11082.61210857616, 4219.91560168798, 4234.830606775725, 4279.850205242833, 4314.978425107885, 4507.932381014288, 78519.60740196319, 84421.0, 86357.56821215917, 89820.99999999935, 90638.54680726553, 8881.467111973303, 8916.55417229136, 9006.234470070118, 9099.772505687411, 9214.401063930956, 21244.575108497742, 21276.78723212779, 21327.68008479874, 21467.78532214689, 21695.13219471235, 7620.847583048308, 7665.655045522964, 7680.385569154566, 7858.685652573948, 8040.557769322743, 3908.843646254175, 4003.939940900889, 4014.6587540059422, 4055.7972101395403, 4135.8966025849595, 3255.3977514159956, 3352.6144493383085, 3376.0, 3386.9661303387143, 3406.097384193191, 598.3896425645904, 608.2579253310954, 616.1497133955113, 617.305531277313, 635.5170070746266, 598.6168851934765, 635.3170341882495, 667.1460530520941, 716.4626530102423, 720.992790072103, 8654.134586541295, 8692.584772078002, 8784.912150878537, 8836.425632334007, 8952.68665596701, 590.7991282963812, 593.2613895699795, 688.7451642892062, 692.4702602509085, 702.2871785137987, 4051.9392209116886, 4188.832446702158, 4222.831086756495, 4374.496932852762, 4437.0, 111573.44213278881, 126889.0, 132667.0, 133082.32259344656, 139038.0, 107703.0, 108700.64967516242, 111363.0, 112134.0, 114606.0, 94181.0, 94578.0, 95546.52226738822, 96197.0, 96468.51765741127, 8147.75556733299, 8159.877601836096, 8202.38482113832, 8463.0, 8484.637565874416, 55277.0, 56113.82747897646, 56183.0, 56705.0, 58196.0, 79197.60401197957, 80282.5985870067, 83282.16717832744, 83863.0, 85409.57295213484, 10808.729781755519, 11017.173711971795, 11036.11711063097, 11185.32888026721, 11544.826827597424, 11703.414829258674, 11713.238639488405, 11958.820617690568, 12079.51681932748, 12095.75808483843, 10389.272750907667, 10434.269601127848, 10725.30285531438, 10829.837552436562, 11196.608118715805, 11375.772484550429, 11592.768144636892, 11881.0, 12019.21875078117, 12290.692732681755, 11140.665780026613, 11306.773864522827, 11455.026322762658, 11784.0, 11930.045596352444, 9518.714438566854, 9579.185769209695, 9844.655437059955, 9924.454155021254, 10481.475926203811, 8692.261157801659, 9165.54172291396, 9964.551595178089, 10021.599136034478, 10107.39355638664], "value": 7184.787762991275, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 106.0, 113.0, 112.0, 114.0, 113.0, 114.0, 113.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 144.0, 171.0, 119.0, 146.0, 155.0, 118.0, 177.0, 122.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 163.0, 168.0, 169.0, 162.0, 164.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 175.0, 76.0, 74.0, 76.0, 76.0, 165.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 166.0, 84.0, 85.0, 84.0, 144.0, 83.0, 84.0, 150.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 120.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 95.0, 97.0, 95.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 54.0, 54.0, 52.0, 51.0, 52.0, 62.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 62.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 84.0, 80.0, 76.0, 78.0, 75.0, 78.0, 80.0, 76.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 140.0, 137.0, 126.0, 137.0, 129.0, 138.0, 135.0, 128.0, 129.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 169.0, 166.0, 169.0, 161.0, 167.0, 164.0, 161.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 63.0, 67.0, 64.0, 69.0, 66.0, 65.0, 68.0], "value": 65.6, "unit": "score"}]}]} 05:34:37 INFO - Return code: 0 05:34:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:34:37 ERROR - # TBPL SUCCESS # 05:34:37 INFO - Running post-action listener: _resource_record_post_action 05:34:37 INFO - [mozharness: 2016-09-20 12:34:37.442531Z] Finished run-tests step (success) 05:34:37 INFO - Running post-run listener: _resource_record_post_run 05:34:37 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557789184; Read time: 8; Write time: 471180 05:34:37 INFO - TinderboxPrint: CPU usage
13.4% 05:34:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:34:37 INFO - TinderboxPrint: I/O write bytes / time
557,789,184 / 471,180 05:34:37 INFO - TinderboxPrint: CPU idle
8,227.7 (86.6%) 05:34:37 INFO - TinderboxPrint: CPU user
1,220.4 (12.8%) 05:34:37 INFO - TinderboxPrint: Swap in / out
0 / 0 05:34:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263151616; Read time: 0; Write time: 285040 05:34:37 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294162432; Read time: 0; Write time: 186096 05:34:38 INFO - Running post-run listener: _upload_blobber_files 05:34:38 INFO - Blob upload gear active. 05:34:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:34:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:34:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:34:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:34:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:34:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:39 INFO - (blobuploader) - INFO - Done attempting. 05:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:42 INFO - (blobuploader) - INFO - Done attempting. 05:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:43 INFO - (blobuploader) - INFO - Done attempting. 05:34:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:34:43 INFO - Return code: 0 05:34:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:34:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:34:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ab443004bed1f2f6d1ef1b5ba84236915faeb9ab303b443be6a7f2d4ac8c5565c7a869e2a329115334bcd7f0b3e900530b493019bfca4c261d6ecc531beb34a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67d452f11f3aa44e312cf8d3cf7d899ae6ccd6d844d2a947250ac4ea453fa19a8588844035cda6fd7ed34699dd7c9a5a3635edbe4be4ef341cb4334c7a2f826d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd9434647385749133eba9694d43c58ab65bee39c8b043ccbaa5a839619ff3878a8b9f39ce4b009b043157c6c0888ed2b835366cfc1a9554bfb9daf312ea8dc1"} 05:34:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:34:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:34:43 INFO - Contents: 05:34:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ab443004bed1f2f6d1ef1b5ba84236915faeb9ab303b443be6a7f2d4ac8c5565c7a869e2a329115334bcd7f0b3e900530b493019bfca4c261d6ecc531beb34a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67d452f11f3aa44e312cf8d3cf7d899ae6ccd6d844d2a947250ac4ea453fa19a8588844035cda6fd7ed34699dd7c9a5a3635edbe4be4ef341cb4334c7a2f826d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd9434647385749133eba9694d43c58ab65bee39c8b043ccbaa5a839619ff3878a8b9f39ce4b009b043157c6c0888ed2b835366cfc1a9554bfb9daf312ea8dc1"} 05:34:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:34:43 INFO - Copying logs to upload dir... 05:34:43 INFO - mkdir: /builds/slave/test/build/upload/logs 05:34:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.450205 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-09-20 05:34:43.236735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 05:34:43.240103) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ab443004bed1f2f6d1ef1b5ba84236915faeb9ab303b443be6a7f2d4ac8c5565c7a869e2a329115334bcd7f0b3e900530b493019bfca4c261d6ecc531beb34a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67d452f11f3aa44e312cf8d3cf7d899ae6ccd6d844d2a947250ac4ea453fa19a8588844035cda6fd7ed34699dd7c9a5a3635edbe4be4ef341cb4334c7a2f826d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd9434647385749133eba9694d43c58ab65bee39c8b043ccbaa5a839619ff3878a8b9f39ce4b009b043157c6c0888ed2b835366cfc1a9554bfb9daf312ea8dc1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1474362870/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ab443004bed1f2f6d1ef1b5ba84236915faeb9ab303b443be6a7f2d4ac8c5565c7a869e2a329115334bcd7f0b3e900530b493019bfca4c261d6ecc531beb34a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/67d452f11f3aa44e312cf8d3cf7d899ae6ccd6d844d2a947250ac4ea453fa19a8588844035cda6fd7ed34699dd7c9a5a3635edbe4be4ef341cb4334c7a2f826d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cd9434647385749133eba9694d43c58ab65bee39c8b043ccbaa5a839619ff3878a8b9f39ce4b009b043157c6c0888ed2b835366cfc1a9554bfb9daf312ea8dc1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 05:34:43.265595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 05:34:43.266024) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1474373654.745735-1776182790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004349 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 05:34:43.350710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 05:34:43.351163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 05:34:43.351505) ========= ========= Total master_lag: 0.17 =========