builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1467033880.23 results: success (0) buildid: 20160627025709 builduid: 149c76c2819e40dabdae4b1b3c7151ea revision: 9f311d92805addcd093ba46dabfcf385a0f7fed3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.229048) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.229640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.229968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.259144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.259457) ========= 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=33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 06:24:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-06-27 06:24:40 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.246221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.524307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.524723) ========= 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=33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.099860 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.634197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:40.634666) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f311d92805addcd093ba46dabfcf385a0f7fed3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f311d92805addcd093ba46dabfcf385a0f7fed3 --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=33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 06:24:40,693 truncating revision to first 12 chars 2016-06-27 06:24:40,693 Setting DEBUG logging. 2016-06-27 06:24:40,693 attempt 1/10 2016-06-27 06:24:40,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9f311d92805a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 06:24:41,012 unpacking tar archive at: mozilla-aurora-9f311d92805a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.672231 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:41.324835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:41.325266) ========= script_repo_revision: 9f311d92805addcd093ba46dabfcf385a0f7fed3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:41.325732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:41.326092) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:24:41.336922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-06-27 06:24:41.337444) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:24:41 INFO - MultiFileLogger online at 20160627 06:24:41 in /builds/slave/test 06:24:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:24:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:41 INFO - {'append_to_log': False, 06:24:41 INFO - 'base_work_dir': '/builds/slave/test', 06:24:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:24:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:41 INFO - 'branch': 'Mozilla-Aurora', 06:24:41 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:41 INFO - 'config_files': ('talos/linux_config.py',), 06:24:41 INFO - 'default_actions': ('clobber', 06:24:41 INFO - 'read-buildbot-config', 06:24:41 INFO - 'download-and-extract', 06:24:41 INFO - 'populate-webroot', 06:24:41 INFO - 'create-virtualenv', 06:24:41 INFO - 'install', 06:24:41 INFO - 'run-tests'), 06:24:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:41 INFO - 'download_minidump_stackwalk': True, 06:24:41 INFO - 'download_symbols': 'ondemand', 06:24:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:41 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:41 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:41 INFO - 'installer_path': 'installer.exe', 06:24:41 INFO - 'log_level': 'info', 06:24:41 INFO - 'log_name': 'talos', 06:24:41 INFO - 'log_to_console': True, 06:24:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:24:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:24:41 INFO - 'opt_config_files': (), 06:24:41 INFO - 'pip_index': False, 06:24:41 INFO - 'sps_profile': False, 06:24:41 INFO - 'sps_profile_interval': 0, 06:24:41 INFO - 'suite': 'dromaeojs-e10s', 06:24:41 INFO - 'system_bits': '32', 06:24:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:41 INFO - 'title': 'talos-linux64-ix-063', 06:24:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:41 INFO - 'use_talos_json': True, 06:24:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:41 INFO - 'work_dir': 'build'} 06:24:41 INFO - ##### 06:24:41 INFO - ##### Running clobber step. 06:24:41 INFO - ##### 06:24:41 INFO - Running pre-action listener: _resource_record_pre_action 06:24:41 INFO - Running main action method: clobber 06:24:41 INFO - rmtree: /builds/slave/test/build 06:24:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:44 INFO - Running post-action listener: _resource_record_post_action 06:24:44 INFO - ##### 06:24:44 INFO - ##### Finished clobber step (success) 06:24:44 INFO - ##### 06:24:44 INFO - ##### 06:24:44 INFO - ##### Running read-buildbot-config step. 06:24:44 INFO - ##### 06:24:44 INFO - Running pre-action listener: _resource_record_pre_action 06:24:44 INFO - Running main action method: read_buildbot_config 06:24:44 INFO - Using buildbot properties: 06:24:44 INFO - { 06:24:44 INFO - "project": "", 06:24:44 INFO - "product": "firefox", 06:24:44 INFO - "script_repo_revision": "production", 06:24:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:24:44 INFO - "repository": "", 06:24:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:24:44 INFO - "buildid": "20160627025709", 06:24:44 INFO - "pgo_build": "True", 06:24:44 INFO - "basedir": "/builds/slave/test", 06:24:44 INFO - "buildnumber": 371, 06:24:44 INFO - "slavename": "talos-linux64-ix-063", 06:24:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:24:44 INFO - "platform": "ubuntu64_hw", 06:24:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:24:44 INFO - "branch": "mozilla-aurora", 06:24:44 INFO - "repo_path": "releases/mozilla-aurora", 06:24:44 INFO - "revision": "9f311d92805addcd093ba46dabfcf385a0f7fed3", 06:24:44 INFO - "stage_platform": "linux64-pgo", 06:24:44 INFO - "builduid": "149c76c2819e40dabdae4b1b3c7151ea", 06:24:44 INFO - "slavebuilddir": "test" 06:24:44 INFO - } 06:24:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:24:44 INFO - Running post-action listener: _resource_record_post_action 06:24:44 INFO - ##### 06:24:44 INFO - ##### Finished read-buildbot-config step (success) 06:24:44 INFO - ##### 06:24:44 INFO - ##### 06:24:44 INFO - ##### Running download-and-extract step. 06:24:44 INFO - ##### 06:24:44 INFO - Running pre-action listener: _resource_record_pre_action 06:24:44 INFO - Running main action method: download_and_extract 06:24:44 INFO - mkdir: /builds/slave/test/build/tests 06:24:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:44 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:24:45 INFO - Downloaded 1361 bytes. 06:24:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:24:45 INFO - Using the following test package requirements: 06:24:45 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:24:45 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:24:45 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:24:45 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'jsshell-linux-x86_64.zip'], 06:24:45 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:24:45 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:24:45 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:24:45 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:24:45 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:24:45 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:24:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:24:45 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:45 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:47 INFO - Downloaded 24517304 bytes. 06:24:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:24:48 INFO - Return code: 0 06:24:48 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:24:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:48 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:49 INFO - Downloaded 24517304 bytes. 06:24:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:24:51 INFO - Return code: 0 06:24:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:51 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:24:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:24:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:24:52 INFO - Downloaded 10833369 bytes. 06:24:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:24:52 INFO - Return code: 0 06:24:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:52 INFO - https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:24:53 INFO - Downloaded 63617093 bytes. 06:24:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:24:53 INFO - mkdir: /builds/slave/test/properties 06:24:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:24:53 INFO - Writing to file /builds/slave/test/properties/build_url 06:24:53 INFO - Contents: 06:24:53 INFO - build_url:https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:24:54 INFO - Running post-action listener: _resource_record_post_action 06:24:54 INFO - Running post-action listener: set_extra_try_arguments 06:24:54 INFO - ##### 06:24:54 INFO - ##### Finished download-and-extract step (success) 06:24:54 INFO - ##### 06:24:54 INFO - ##### 06:24:54 INFO - ##### Running populate-webroot step. 06:24:54 INFO - ##### 06:24:54 INFO - Running pre-action listener: _resource_record_pre_action 06:24:54 INFO - Running main action method: populate_webroot 06:24:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:24:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:24:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:24:54 INFO - '--tppagecycles', 06:24:54 INFO - '7'], 06:24:54 INFO - 'tests': ['tsvgm']}}, 06:24:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:24:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:24:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:24:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:24:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:54 INFO - 'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:54 INFO - 'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['damp', 'tps']}, 06:24:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:54 INFO - 'tests': ['damp', 'tps']}, 06:24:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['dromaeo_dom']}, 06:24:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:24:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['a11yr', 06:24:54 INFO - 'ts_paint', 06:24:54 INFO - 'tpaint', 06:24:54 INFO - 'sessionrestore', 06:24:54 INFO - 'sessionrestore_no_auto_restore', 06:24:54 INFO - 'tabpaint']}, 06:24:54 INFO - 'other-e10s': {'tests': ['a11yr', 06:24:54 INFO - 'ts_paint', 06:24:54 INFO - 'tpaint', 06:24:54 INFO - 'sessionrestore', 06:24:54 INFO - 'sessionrestore_no_auto_restore', 06:24:54 INFO - 'tabpaint']}, 06:24:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:24:54 INFO - 'ts_paint', 06:24:54 INFO - 'tpaint', 06:24:54 INFO - 'sessionrestore', 06:24:54 INFO - 'sessionrestore_no_auto_restore', 06:24:54 INFO - 'tabpaint']}, 06:24:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:24:54 INFO - 'ts_paint', 06:24:54 INFO - 'tpaint', 06:24:54 INFO - 'sessionrestore', 06:24:54 INFO - 'sessionrestore_no_auto_restore', 06:24:54 INFO - 'tabpaint']}, 06:24:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['a11yr', 06:24:54 INFO - 'ts_paint', 06:24:54 INFO - 'tpaint', 06:24:54 INFO - 'sessionrestore', 06:24:54 INFO - 'sessionrestore_no_auto_restore', 06:24:54 INFO - 'tabpaint']}, 06:24:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['a11yr', 06:24:54 INFO - 'ts_paint', 06:24:54 INFO - 'tpaint', 06:24:54 INFO - 'sessionrestore', 06:24:54 INFO - 'sessionrestore_no_auto_restore', 06:24:54 INFO - 'tabpaint']}, 06:24:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['tsvgx', 06:24:54 INFO - 'tsvgr_opacity', 06:24:54 INFO - 'tart', 06:24:54 INFO - 'tscrollx', 06:24:54 INFO - 'cart']}, 06:24:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:24:54 INFO - 'tsvgr_opacity', 06:24:54 INFO - 'tart', 06:24:54 INFO - 'tscrollx', 06:24:54 INFO - 'cart']}, 06:24:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:54 INFO - 'talos_options': ['--disable-e10s'], 06:24:54 INFO - 'tests': ['tp5o']}, 06:24:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:54 INFO - 'tests': ['tp5o']}, 06:24:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:54 INFO - 'talos_options': ['--disable-e10s', 06:24:54 INFO - '--xperf_path', 06:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:54 INFO - 'tests': ['tp5n']}, 06:24:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:54 INFO - 'talos_options': ['--xperf_path', 06:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:54 INFO - 'tests': ['tp5n']}}, 06:24:54 INFO - 'talos.zip': {'path': '', 06:24:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:24:54 INFO - Running post-action listener: _resource_record_post_action 06:24:54 INFO - ##### 06:24:54 INFO - ##### Finished populate-webroot step (success) 06:24:54 INFO - ##### 06:24:54 INFO - ##### 06:24:54 INFO - ##### Running create-virtualenv step. 06:24:54 INFO - ##### 06:24:54 INFO - Running pre-action listener: _resource_record_pre_action 06:24:54 INFO - Running main action method: create_virtualenv 06:24:54 INFO - Creating virtualenv /builds/slave/test/build/venv 06:24:54 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 06:24:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:24:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:56 INFO - Using real prefix '/usr' 06:24:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:25:20 INFO - Installing distribute.............................................................................................................................................................................................done. 06:25:22 INFO - Installing pip.................done. 06:25:22 INFO - Return code: 0 06:25:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:22 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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:22 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 06:25:22 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 06:25:22 INFO - Using env: {'DISPLAY': ':0', 06:25:22 INFO - 'HOME': '/home/cltbld', 06:25:22 INFO - 'LANG': 'en_US.UTF-8', 06:25:22 INFO - 'LANGUAGE': 'en_US:en', 06:25:22 INFO - 'LOGNAME': 'cltbld', 06:25:22 INFO - 'MAIL': '/var/mail/cltbld', 06:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:22 INFO - 'MOZ_NO_REMOTE': '1', 06:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:22 INFO - 'NO_EM_RESTART': '1', 06:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:22 INFO - 'PWD': '/builds/slave/test', 06:25:22 INFO - 'SHELL': '/bin/bash', 06:25:22 INFO - 'SHLVL': '1', 06:25:22 INFO - 'TERM': 'linux', 06:25:22 INFO - 'TMOUT': '86400', 06:25:22 INFO - 'USER': 'cltbld', 06:25:22 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:22 INFO - '_': '/tools/buildbot/bin/python'} 06:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:22 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 06:25:22 INFO - Cleaning up... 06:25:22 INFO - Return code: 0 06:25:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:22 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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:22 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 06:25:22 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 06:25:22 INFO - Using env: {'DISPLAY': ':0', 06:25:22 INFO - 'HOME': '/home/cltbld', 06:25:22 INFO - 'LANG': 'en_US.UTF-8', 06:25:22 INFO - 'LANGUAGE': 'en_US:en', 06:25:22 INFO - 'LOGNAME': 'cltbld', 06:25:22 INFO - 'MAIL': '/var/mail/cltbld', 06:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:22 INFO - 'MOZ_NO_REMOTE': '1', 06:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:22 INFO - 'NO_EM_RESTART': '1', 06:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:22 INFO - 'PWD': '/builds/slave/test', 06:25:22 INFO - 'SHELL': '/bin/bash', 06:25:22 INFO - 'SHLVL': '1', 06:25:22 INFO - 'TERM': 'linux', 06:25:22 INFO - 'TMOUT': '86400', 06:25:22 INFO - 'USER': 'cltbld', 06:25:22 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:22 INFO - '_': '/tools/buildbot/bin/python'} 06:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:23 INFO - Downloading/unpacking psutil>=3.1.1 06:25:23 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 06:25:23 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 06:25:23 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 06:25:23 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 06:25:23 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 06:25:23 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 06:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:25:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:25 INFO - Installing collected packages: psutil 06:25:25 INFO - Running setup.py install for psutil 06:25:25 INFO - building 'psutil._psutil_linux' extension 06:25:25 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 06:25:26 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 06:25:27 INFO - building 'psutil._psutil_posix' extension 06:25:27 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 06:25:27 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 06:25:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:25:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:25:27 INFO - Successfully installed psutil 06:25:27 INFO - Cleaning up... 06:25:27 INFO - Return code: 0 06:25:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:25:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:27 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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:27 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 06:25:27 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 06:25:27 INFO - Using env: {'DISPLAY': ':0', 06:25:27 INFO - 'HOME': '/home/cltbld', 06:25:27 INFO - 'LANG': 'en_US.UTF-8', 06:25:27 INFO - 'LANGUAGE': 'en_US:en', 06:25:27 INFO - 'LOGNAME': 'cltbld', 06:25:27 INFO - 'MAIL': '/var/mail/cltbld', 06:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:27 INFO - 'MOZ_NO_REMOTE': '1', 06:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:27 INFO - 'NO_EM_RESTART': '1', 06:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:27 INFO - 'PWD': '/builds/slave/test', 06:25:27 INFO - 'SHELL': '/bin/bash', 06:25:27 INFO - 'SHLVL': '1', 06:25:27 INFO - 'TERM': 'linux', 06:25:27 INFO - 'TMOUT': '86400', 06:25:27 INFO - 'USER': 'cltbld', 06:25:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:27 INFO - '_': '/tools/buildbot/bin/python'} 06:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:25:27 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 06:25:27 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 06:25:27 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 06:25:27 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 06:25:27 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 06:25:27 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 06:25:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:25:29 INFO - Installing collected packages: mozsystemmonitor 06:25:29 INFO - Running setup.py install for mozsystemmonitor 06:25:29 INFO - Successfully installed mozsystemmonitor 06:25:29 INFO - Cleaning up... 06:25:29 INFO - Return code: 0 06:25:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25: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', '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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:25: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 jsonschema==2.5.1 06:25:29 INFO - Using env: {'DISPLAY': ':0', 06:25:29 INFO - 'HOME': '/home/cltbld', 06:25:29 INFO - 'LANG': 'en_US.UTF-8', 06:25:29 INFO - 'LANGUAGE': 'en_US:en', 06:25:29 INFO - 'LOGNAME': 'cltbld', 06:25:29 INFO - 'MAIL': '/var/mail/cltbld', 06:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:29 INFO - 'MOZ_NO_REMOTE': '1', 06:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:29 INFO - 'NO_EM_RESTART': '1', 06:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:29 INFO - 'PWD': '/builds/slave/test', 06:25:29 INFO - 'SHELL': '/bin/bash', 06:25:29 INFO - 'SHLVL': '1', 06:25:29 INFO - 'TERM': 'linux', 06:25:29 INFO - 'TMOUT': '86400', 06:25:29 INFO - 'USER': 'cltbld', 06:25:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:29 INFO - '_': '/tools/buildbot/bin/python'} 06:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:29 INFO - Downloading/unpacking jsonschema==2.5.1 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:32 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:32 INFO - warning: no files found matching '*.txt' 06:25:32 INFO - no previously-included directories found matching 'build' 06:25:32 INFO - no previously-included directories found matching 'dist' 06:25:32 INFO - no previously-included directories found matching '.git*' 06:25:32 INFO - Installing collected packages: jsonschema, functools32 06:25:32 INFO - Running setup.py install for functools32 06:25:32 INFO - warning: no files found matching '*.txt' 06:25:32 INFO - no previously-included directories found matching 'build' 06:25:32 INFO - no previously-included directories found matching 'dist' 06:25:32 INFO - no previously-included directories found matching '.git*' 06:25:32 INFO - Successfully installed jsonschema functools32 06:25:32 INFO - Cleaning up... 06:25:32 INFO - Return code: 0 06:25:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:25:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:32 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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:32 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 06:25:32 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 06:25:32 INFO - Using env: {'DISPLAY': ':0', 06:25:32 INFO - 'HOME': '/home/cltbld', 06:25:32 INFO - 'LANG': 'en_US.UTF-8', 06:25:32 INFO - 'LANGUAGE': 'en_US:en', 06:25:32 INFO - 'LOGNAME': 'cltbld', 06:25:32 INFO - 'MAIL': '/var/mail/cltbld', 06:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:32 INFO - 'MOZ_NO_REMOTE': '1', 06:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:32 INFO - 'NO_EM_RESTART': '1', 06:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:32 INFO - 'PWD': '/builds/slave/test', 06:25:32 INFO - 'SHELL': '/bin/bash', 06:25:32 INFO - 'SHLVL': '1', 06:25:32 INFO - 'TERM': 'linux', 06:25:32 INFO - 'TMOUT': '86400', 06:25:32 INFO - 'USER': 'cltbld', 06:25:32 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:32 INFO - '_': '/tools/buildbot/bin/python'} 06:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:25:32 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 06:25:32 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 06:25:32 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 06:25:32 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 06:25:32 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 06:25:32 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 06:25:34 INFO - Downloading blobuploader-1.2.4.tar.gz 06:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:25:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:25:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:35 INFO - Downloading docopt-0.6.1.tar.gz 06:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:25:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:25:35 INFO - Running setup.py install for blobuploader 06:25:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:25:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:25:35 INFO - Running setup.py install for requests 06:25:35 INFO - Running setup.py install for docopt 06:25:35 INFO - Successfully installed blobuploader requests docopt 06:25:35 INFO - Cleaning up... 06:25:35 INFO - Return code: 0 06:25:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:35 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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:35 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 06:25:35 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 06:25:35 INFO - Using env: {'DISPLAY': ':0', 06:25:35 INFO - 'HOME': '/home/cltbld', 06:25:35 INFO - 'LANG': 'en_US.UTF-8', 06:25:35 INFO - 'LANGUAGE': 'en_US:en', 06:25:35 INFO - 'LOGNAME': 'cltbld', 06:25:35 INFO - 'MAIL': '/var/mail/cltbld', 06:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:35 INFO - 'MOZ_NO_REMOTE': '1', 06:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:35 INFO - 'NO_EM_RESTART': '1', 06:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:35 INFO - 'PWD': '/builds/slave/test', 06:25:35 INFO - 'SHELL': '/bin/bash', 06:25:35 INFO - 'SHLVL': '1', 06:25:35 INFO - 'TERM': 'linux', 06:25:35 INFO - 'TMOUT': '86400', 06:25:35 INFO - 'USER': 'cltbld', 06:25:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:35 INFO - '_': '/tools/buildbot/bin/python'} 06:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:35 INFO - Running setup.py (path:/tmp/pip-TbSH3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:36 INFO - Running setup.py (path:/tmp/pip-L0LPJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:36 INFO - Running setup.py (path:/tmp/pip-AtStyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:36 INFO - Running setup.py (path:/tmp/pip-EXVyOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:36 INFO - Running setup.py (path:/tmp/pip-fbFd1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:36 INFO - Running setup.py (path:/tmp/pip-QjaJax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:36 INFO - Running setup.py (path:/tmp/pip-_cGHth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:36 INFO - Running setup.py (path:/tmp/pip-frT8Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:36 INFO - Running setup.py (path:/tmp/pip-POFQZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:36 INFO - Running setup.py (path:/tmp/pip-4lu2K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:36 INFO - Running setup.py (path:/tmp/pip-yQUbt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:36 INFO - Running setup.py (path:/tmp/pip-S3_IGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:36 INFO - Running setup.py (path:/tmp/pip-dB5fbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:36 INFO - Running setup.py (path:/tmp/pip-rKtBYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:36 INFO - Running setup.py (path:/tmp/pip-OIcObv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:37 INFO - Running setup.py (path:/tmp/pip-adXfmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:37 INFO - Running setup.py (path:/tmp/pip-Kc4dON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:25:37 INFO - Running setup.py install for manifestparser 06:25:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Running setup.py install for mozcrash 06:25:37 INFO - Running setup.py install for mozdebug 06:25:37 INFO - Running setup.py install for mozdevice 06:25:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Running setup.py install for mozfile 06:25:37 INFO - Running setup.py install for mozhttpd 06:25:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Running setup.py install for mozinfo 06:25:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Running setup.py install for mozInstall 06:25:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:25:37 INFO - Running setup.py install for mozleak 06:25:38 INFO - Running setup.py install for mozlog 06:25:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:25:38 INFO - Running setup.py install for moznetwork 06:25:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:25:38 INFO - Running setup.py install for mozprocess 06:25:38 INFO - Running setup.py install for mozprofile 06:25:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:25:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:25:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:25:38 INFO - Running setup.py install for mozrunner 06:25:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:25:38 INFO - Running setup.py install for mozscreenshot 06:25:38 INFO - Running setup.py install for moztest 06:25:38 INFO - Running setup.py install for mozversion 06:25:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:25:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:25:38 INFO - Cleaning up... 06:25:38 INFO - Return code: 0 06:25:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:38 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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:38 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 06:25:38 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 06:25:38 INFO - Using env: {'DISPLAY': ':0', 06:25:38 INFO - 'HOME': '/home/cltbld', 06:25:38 INFO - 'LANG': 'en_US.UTF-8', 06:25:38 INFO - 'LANGUAGE': 'en_US:en', 06:25:38 INFO - 'LOGNAME': 'cltbld', 06:25:38 INFO - 'MAIL': '/var/mail/cltbld', 06:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:38 INFO - 'MOZ_NO_REMOTE': '1', 06:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:38 INFO - 'NO_EM_RESTART': '1', 06:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:38 INFO - 'PWD': '/builds/slave/test', 06:25:38 INFO - 'SHELL': '/bin/bash', 06:25:38 INFO - 'SHLVL': '1', 06:25:38 INFO - 'TERM': 'linux', 06:25:38 INFO - 'TMOUT': '86400', 06:25:38 INFO - 'USER': 'cltbld', 06:25:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:38 INFO - '_': '/tools/buildbot/bin/python'} 06:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:25:39 INFO - Running setup.py (path:/tmp/pip-JiR8IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:25:39 INFO - Running setup.py (path:/tmp/pip-RKA8sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:25:39 INFO - Running setup.py (path:/tmp/pip-9njNPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:25:39 INFO - Running setup.py (path:/tmp/pip-7fQ9xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:25:39 INFO - Running setup.py (path:/tmp/pip-IAMSIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:25:39 INFO - Running setup.py (path:/tmp/pip-MCh1tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:25:39 INFO - Running setup.py (path:/tmp/pip-ipm0o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:25:39 INFO - Running setup.py (path:/tmp/pip-_KfdGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:25:39 INFO - Running setup.py (path:/tmp/pip-CUVc4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:25:39 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:25:39 INFO - Running setup.py (path:/tmp/pip-PtHqkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 06:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:25:39 INFO - Running setup.py (path:/tmp/pip-g9OYNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:25:40 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)) 06:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:25:40 INFO - Running setup.py (path:/tmp/pip-kwm34E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 06:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:25:40 INFO - Running setup.py (path:/tmp/pip-CND15y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:25:40 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)) 06:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:25:40 INFO - Running setup.py (path:/tmp/pip-eYrOsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 06:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:40 INFO - Running setup.py (path:/tmp/pip-PK2g2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:25:40 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)) 06:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:25:40 INFO - Running setup.py (path:/tmp/pip-cPdstM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:25:40 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)) 06:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:25:40 INFO - Running setup.py (path:/tmp/pip-giRIGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 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)) 06:25:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:25:40 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 06:25:40 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 06:25:40 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 06:25:40 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 06:25:40 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 06:25:40 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 06:25:42 INFO - Downloading blessings-1.6.tar.gz 06:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:25:42 INFO - Installing collected packages: blessings 06:25:42 INFO - Running setup.py install for blessings 06:25:42 INFO - Successfully installed blessings 06:25:42 INFO - Cleaning up... 06:25:42 INFO - Return code: 0 06:25:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:25:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:43 INFO - Reading from file tmpfile_stdout 06:25:43 INFO - Current package versions: 06:25:43 INFO - argparse == 1.2.1 06:25:43 INFO - blessings == 1.6 06:25:43 INFO - blobuploader == 1.2.4 06:25:43 INFO - docopt == 0.6.1 06:25:43 INFO - functools32 == 3.2.3-2 06:25:43 INFO - jsonschema == 2.5.1 06:25:43 INFO - manifestparser == 1.1 06:25:43 INFO - mozInstall == 1.12 06:25:43 INFO - mozcrash == 0.17 06:25:43 INFO - mozdebug == 0.1 06:25:43 INFO - mozdevice == 0.48 06:25:43 INFO - mozfile == 1.2 06:25:43 INFO - mozhttpd == 0.7 06:25:43 INFO - mozinfo == 0.9 06:25:43 INFO - mozleak == 0.1 06:25:43 INFO - mozlog == 3.2 06:25:43 INFO - moznetwork == 0.27 06:25:43 INFO - mozprocess == 0.22 06:25:43 INFO - mozprofile == 0.28 06:25:43 INFO - mozrunner == 6.11 06:25:43 INFO - mozscreenshot == 0.1 06:25:43 INFO - mozsystemmonitor == 0.3 06:25:43 INFO - moztest == 0.7 06:25:43 INFO - mozversion == 1.4 06:25:43 INFO - psutil == 3.1.1 06:25:43 INFO - requests == 1.2.3 06:25:43 INFO - wsgiref == 0.1.2 06:25:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:43 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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:43 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 06:25:43 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 06:25:43 INFO - Using env: {'DISPLAY': ':0', 06:25:43 INFO - 'HOME': '/home/cltbld', 06:25:43 INFO - 'LANG': 'en_US.UTF-8', 06:25:43 INFO - 'LANGUAGE': 'en_US:en', 06:25:43 INFO - 'LOGNAME': 'cltbld', 06:25:43 INFO - 'MAIL': '/var/mail/cltbld', 06:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:43 INFO - 'MOZ_NO_REMOTE': '1', 06:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:43 INFO - 'NO_EM_RESTART': '1', 06:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:43 INFO - 'PWD': '/builds/slave/test', 06:25:43 INFO - 'SHELL': '/bin/bash', 06:25:43 INFO - 'SHLVL': '1', 06:25:43 INFO - 'TERM': 'linux', 06:25:43 INFO - 'TMOUT': '86400', 06:25:43 INFO - 'USER': 'cltbld', 06:25:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:43 INFO - '_': '/tools/buildbot/bin/python'} 06:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 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)) 06:25:43 INFO - Cleaning up... 06:25:43 INFO - Return code: 0 06:25:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:25:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:43 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 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:43 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 06:25:43 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 06:25:43 INFO - Using env: {'DISPLAY': ':0', 06:25:43 INFO - 'HOME': '/home/cltbld', 06:25:43 INFO - 'LANG': 'en_US.UTF-8', 06:25:43 INFO - 'LANGUAGE': 'en_US:en', 06:25:43 INFO - 'LOGNAME': 'cltbld', 06:25:43 INFO - 'MAIL': '/var/mail/cltbld', 06:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:43 INFO - 'MOZ_NO_REMOTE': '1', 06:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:43 INFO - 'NO_EM_RESTART': '1', 06:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:43 INFO - 'PWD': '/builds/slave/test', 06:25:43 INFO - 'SHELL': '/bin/bash', 06:25:43 INFO - 'SHLVL': '1', 06:25:43 INFO - 'TERM': 'linux', 06:25:43 INFO - 'TMOUT': '86400', 06:25:43 INFO - 'USER': 'cltbld', 06:25:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:43 INFO - '_': '/tools/buildbot/bin/python'} 06:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:25:43 INFO - Cleaning up... 06:25:43 INFO - Return code: 0 06:25:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:25:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:43 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc88a50ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, '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': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', '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 06:25:43 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', 'flake8'] in /builds/slave/test/build 06:25:43 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 flake8 06:25:43 INFO - Using env: {'DISPLAY': ':0', 06:25:43 INFO - 'HOME': '/home/cltbld', 06:25:43 INFO - 'LANG': 'en_US.UTF-8', 06:25:43 INFO - 'LANGUAGE': 'en_US:en', 06:25:43 INFO - 'LOGNAME': 'cltbld', 06:25:43 INFO - 'MAIL': '/var/mail/cltbld', 06:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:43 INFO - 'MOZ_NO_REMOTE': '1', 06:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:43 INFO - 'NO_EM_RESTART': '1', 06:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:43 INFO - 'PWD': '/builds/slave/test', 06:25:43 INFO - 'SHELL': '/bin/bash', 06:25:43 INFO - 'SHLVL': '1', 06:25:43 INFO - 'TERM': 'linux', 06:25:43 INFO - 'TMOUT': '86400', 06:25:43 INFO - 'USER': 'cltbld', 06:25:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:43 INFO - '_': '/tools/buildbot/bin/python'} 06:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:43 INFO - Downloading/unpacking flake8 06:25:43 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 06:25:43 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 06:25:43 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 06:25:43 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 06:25:43 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 06:25:43 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 06:25:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:25:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:25:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:45 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 06:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:25:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:46 INFO - no previously-included directories found matching 'docs/_build' 06:25:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:25:46 INFO - Running setup.py install for pep8 06:25:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:46 INFO - no previously-included directories found matching 'docs/_build' 06:25:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:25:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:25:46 INFO - Cleaning up... 06:25:46 INFO - Return code: 0 06:25:46 INFO - Running post-action listener: _resource_record_post_action 06:25:46 INFO - Running post-action listener: _start_resource_monitoring 06:25:46 INFO - Starting resource monitoring. 06:25:46 INFO - ##### 06:25:46 INFO - ##### Finished create-virtualenv step (success) 06:25:46 INFO - ##### 06:25:46 INFO - ##### 06:25:46 INFO - ##### Running install step. 06:25:46 INFO - ##### 06:25:46 INFO - Running pre-action listener: _resource_record_pre_action 06:25:46 INFO - Running main action method: install 06:25:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:46 INFO - Reading from file tmpfile_stdout 06:25:46 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:46 INFO - Reading from file tmpfile_stdout 06:25:46 INFO - Output received: 06:25:46 INFO - Usage: mozinstall [options] installer 06:25:46 INFO - Options: 06:25:46 INFO - -h, --help show this help message and exit 06:25:46 INFO - -d DEST, --destination=DEST 06:25:46 INFO - Directory to install application into. [default: 06:25:46 INFO - "/builds/slave/test"] 06:25:46 INFO - --app=APP Application being installed. [default: firefox] 06:25:46 INFO - mkdir: /builds/slave/test/build/application 06:25:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:26:02 INFO - Reading from file tmpfile_stdout 06:26:02 INFO - Output received: 06:26:02 INFO - /builds/slave/test/build/application/firefox/firefox 06:26:02 INFO - Running post-action listener: _resource_record_post_action 06:26:02 INFO - ##### 06:26:02 INFO - ##### Finished install step (success) 06:26:02 INFO - ##### 06:26:02 INFO - ##### 06:26:02 INFO - ##### Running run-tests step. 06:26:02 INFO - ##### 06:26:02 INFO - Running pre-action listener: _resource_record_pre_action 06:26:02 INFO - Running main action method: run_tests 06:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:26:02 INFO - Python 2.7.3 06:26:02 INFO - Return code: 0 06:26:02 INFO - grabbing minidump binary from tooltool 06:26: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26: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 0x22581c0>, '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 0x22590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2259550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:26: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 06:26: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 06:26: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 06:26:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:26:02 INFO - Return code: 0 06:26:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:26:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:26:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:26:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:26:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:26:03 INFO - Return code: 0 06:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 06:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 06:26:03 INFO - Using env: {'DISPLAY': ':0', 06:26:03 INFO - 'HOME': '/home/cltbld', 06:26:03 INFO - 'LANG': 'en_US.UTF-8', 06:26:03 INFO - 'LANGUAGE': 'en_US:en', 06:26:03 INFO - 'LOGNAME': 'cltbld', 06:26:03 INFO - 'MAIL': '/var/mail/cltbld', 06:26:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:26:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:03 INFO - 'MOZ_NO_REMOTE': '1', 06:26:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:03 INFO - 'NO_EM_RESTART': '1', 06:26:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:03 INFO - 'PWD': '/builds/slave/test', 06:26:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:26:03 INFO - 'SHELL': '/bin/bash', 06:26:03 INFO - 'SHLVL': '1', 06:26:03 INFO - 'TERM': 'linux', 06:26:03 INFO - 'TMOUT': '86400', 06:26:03 INFO - 'USER': 'cltbld', 06:26:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979', 06:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:03 INFO - '_': '/tools/buildbot/bin/python'} 06:26:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 06:26:04 INFO - mozversion application_buildid: 20160627025709 06:26:04 INFO - mozversion application_changeset: 9f311d92805addcd093ba46dabfcf385a0f7fed3 06:26:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:26:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:26:04 INFO - mozversion application_name: Firefox 06:26:04 INFO - mozversion application_remotingname: firefox-dev 06:26:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:26:04 INFO - mozversion application_vendor: Mozilla 06:26:04 INFO - mozversion application_version: 49.0a2 06:26:04 INFO - mozversion platform_buildid: 20160627025709 06:26:04 INFO - mozversion platform_changeset: 9f311d92805addcd093ba46dabfcf385a0f7fed3 06:26:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:26:04 INFO - mozversion platform_version: 49.0a2 06:26:04 INFO - using testdate: 1467033964 06:26:04 INFO - actual date: 1467033964 06:26:04 INFO - starting webserver on 'localhost:56066' 06:26:04 INFO - SUITE-START | Running 2 tests 06:26:04 INFO - TEST-START | dromaeo_css 06:26:04 INFO - operating with platform_type : linux_ 06:26:04 INFO - Initialising browser for dromaeo_css test... 06:26:04 INFO - TEST-INFO | started process 3331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKM9UrA/profile http://localhost:56066/getInfo.html) 06:26:21 INFO - PROCESS | 3331 | __metrics Screen width/height:1600/1200 06:26:21 INFO - PROCESS | 3331 | colorDepth:24 06:26:21 INFO - PROCESS | 3331 | Browser inner width/height: 1024/697 06:26:21 INFO - PROCESS | 3331 | __metrics 06:26:23 ERROR - PROCESS | 3331 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:26:24 INFO - TEST-INFO | 3331: exit 0 06:26:24 INFO - Browser initialized. 06:26:24 INFO - Running cycle 1/1 for dromaeo_css test... 06:26:24 INFO - TEST-INFO | started process 3466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKM9UrA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:26:36 INFO - PROCESS | 3466 | RSS: Main: 156459008 06:26:36 INFO - PROCESS | 3466 | 06:27:25 INFO - PROCESS | 3466 | 1467034045707 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] 06:29:33 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:56066/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56066/tests/dromaeo/cssquery-ext.html) 06:29:34 INFO - PROCESS | 3466 | RSS: Main: 159969280 06:29:34 INFO - PROCESS | 3466 | 06:32:36 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:56066/tests/dromaeo/cssquery-ext.html (next: http://localhost:56066/tests/dromaeo/cssquery-jquery.html) 06:32:37 INFO - PROCESS | 3466 | RSS: Main: 157990912 06:32:37 INFO - PROCESS | 3466 | 06:35:39 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:56066/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56066/tests/dromaeo/cssquery-mootools.html) 06:35:39 INFO - PROCESS | 3466 | RSS: Main: 157097984 06:35:39 INFO - PROCESS | 3466 | 06:38:41 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:56066/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56066/tests/dromaeo/cssquery-prototype.html) 06:38:42 INFO - PROCESS | 3466 | RSS: Main: 156966912 06:38:42 INFO - PROCESS | 3466 | 06:41:44 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:56066/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56066/tests/dromaeo/cssquery-yui.html) 06:41:45 INFO - PROCESS | 3466 | RSS: Main: 158527488 06:41:45 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | Cycle 1(1): loaded http://localhost:56066/tests/dromaeo/cssquery-yui.html (next: http://localhost:56066/tests/dromaeo/cssquery-dojo.html) 06:44:47 INFO - PROCESS | 3466 | RSS: Main: 159354880 06:44:47 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | __start_tp_report 06:44:47 INFO - PROCESS | 3466 | _x_x_mozilla_page_load 06:44:47 INFO - PROCESS | 3466 | _x_x_mozilla_page_load_details 06:44:47 INFO - PROCESS | 3466 | |i|pagename|runs| 06:44:47 INFO - PROCESS | 3466 | |0;dojo.html;3374.780639258448;3427.0746898337447;3439.896803095908;3453.205762674585;3462.3248466549016;5628.859278518039;5663.9999999999945;5707.058335374663;5734.455226753462;5762.3373312069125;5702.885942281152;5734.053881109612;5737.885242295151;5748.137779333102;5796.942030579693;5098.056859480989;5157.458466860963;5197.584193264549;5202.739863006854;5234.79060837568;5099.15863882459;5168.948310516903;5206.375234971809;5266.052110620087;5320.14877619581;5184.196449550326;5196.662216955886;5201.115810312256;5221.582273418117;5265.552428043621;5219.86950326243;5267.5259226669405;5271.103912334912;5276.12943864262;5299.682019078868;5090.49095090488;5133.922991155136;5182.948170518284;5240.056789777838;5263.710495922723;5499.3675727291475;5515.034868897927;5528.44715528448;5548.223248745179;5649.661020338752;6106.755729770848;6130.417610327012;6145.477634401082;6153.107799369066;6156.322804491547;6183.2889217740085;6189.102580125857;6197.318294987548;6200.534959878028;6200.627962322275;5646.20953066571;5655.010373184677;5690.40250773667;5696.943030569724;5736.569757268263;6197.070439434121;6221.097940798559;6273.560850740496;6283.560150789401;6292.370762923671;5859.326177489558;5975.760969561169;5987.580869339192;6028.698565071729;6039.456448919531;6048.516118710492;6059.424354686298;6115.816525504242;6140.699918429095;6170.10533472644;6048.12302216185;6091.744580856434;6108.35862234459;6120.816375508742;6132.6627035513475;5922.1412895130825;6021.307549631849;6144.354842741537;6145.84635384119;6160.753569857246;4518.706284091523;4612.95387046132;4637.6289896808175;4639.30410438437;4655.4180727409075;4149.232392007489;4159.272127377697;4165.562615925345;4176.853810116631;4195.49654041517;5773.6824474654295;5851.063829787214;5857.355690874;5859.970700146472;5875.735591898375;6017.518598512109;6028.608140470856;6124.571280010446;6142.293636231801;6233.937660623426;5940.405959404112;5966.373530779292;5973.074173503114;5982.461578457873;5991.340952495222;5174.870628234249;5190.403103643054;5226.163813789852;5294.49702278283;5333.733313334318;6421.743130274736;6432.614043157426;6434.8391290218115;6445.838854028687;6446.677666116675;6236.064590311489;6251.374862513712;6255.374462553708;6262.436380725574;6268;6152.692365381802;6159.507239420746;6183.536234782499;6252.030935205051;6439.935600643934;6001.189839371629;6027.21646185993;6032.638041717511;6033.78881739137;6036.154938308729;6105.755769769159;6133.601315914451;6135.386461353829;6142.04798256271;6143.385661433999;5823.505002074871;5909.793157239476;5925.4370834770625;5933.495652869555;6008.669523176267;5919.4080591940465;5983.401659833982;5985.132155837467;5988.520918326611;6006;5748.338941021836;5853.678047707247;5907.704614769158;5907.970460147843;5933.970330148321;5955.315138758925;5958.433948774859;6000.51995840323;6029.246344206974;6057.636541807329;5920.703964801829;5932.64404135736;5964.582479226586;5965.6718880461995;5980.3421623622235 06:44:47 INFO - PROCESS | 3466 | |1;ext.html;647.0908373734902;652.634524666187;666.7766298290074;667.8731041102187;674.2583158525625;37097.44353834691;38343.424848627255;42622.360664590014;42855.571444285546;42908;44298.55701442985;44927.775361123146;45119.09761804762;45233.09533809322;45432;8748.737537873858;8955.776105597379;8995.910040899606;9005.099490050976;9041.773955651128;8780.780480488007;8835.028146903835;8877.778055548632;8878.955605221965;8882.86675699865;8930.062343453941;8951.328650351217;8954.686585969492;8974.50640214788;9006.189442950134;8831.02858685544;8845.867311990292;8895.555222238861;8898.688545900895;8949.060348663426;8822.955885220597;8856.247218986395;8863.955680221557;8904.287656987426;8956.731298061068;41683;41788.373174402106;41872;41973.79013104915;42060.57939420628;3657.6708096271464;3688.704903607705;3761.9435708464393;3881.8059097045316;4302.902759796232;32397;33284;33288.16779580506;33501.83249083763;33519.49720754191;4717.410323709536;4737.313089601988;4745.098431298043;4778.331033655291;4805.231163013936;293200;294284;294926;295363;295625;37176.44235336472;59665;59988.40011599915;60029.69985150046;60265;36342.818285908405;38625.80687096546;38755.80622096928;38777.2244555113;38854.805725971186;15830.841691583168;16052.197390130446;16066.27701753424;16114.75827862583;16147.273372698257;13121.409536570878;13149.408276627575;13209.40557674907;13232.139910905953;13286.20282783036;8593.527355995355;8662.133786621287;8701.738947831574;8740.601503759368;8877.378583499092;3511.6839484446523;3528.188516641187;3552.307300076512;3622.42041273395;3638.2541578976247;1047.4972013433442;1124.8875112488686;1166.4634268236537;1225.1668865171769;1242.7203879127123;31555.684443155733;31786.523202151988;32523.674763252064;32532.08868144719;32720.181995450304;1125.1031178873454;1139.7378602921374;1178.3224645828682;1246.6073186946082;1280.3342262023696;17223.36378044109;17260.827391726172;17364;17404.65190696179;17614.647707045788;419069;641792;645400;649336;909684;64284.35715642877;65143.674281628286;65387.67306163534;65425;65486.67256663686;1488.0773920169563;1497.7903093566908;1501.5870635575304;1502.053706165109;1514.9166795826116;33522.32955340928;33953.15117122092;34077.82961085278;34216.657833422345;34435.4834677475;61431.69284153551;63664;63673.68163159154;69439.30560694328;69546.30453695398;494956;504437;505189;505485;505547;48407.27389089237;48790.5120948786;48910.75544622254;48947.755261223465;49264.50735492599;53453.19820202778;54265.72867135639;54366.456335437724;55307.170392444954;55492.44507554873;44479.22083116769;45023;45233.54766452425;46798.76600616975;46851.76574117244;44060.33909491296;44198.337024944005;44773.776131119135;44834.55165448304;44844.55155448534;44452;44712.552874470835;45020;45064.774676126406;45578.54421455743;38785.418218726176;39226;39295.803520983354;39833.2033359337;40115.99710007157;29374.853125734233;29766.25584360408;30105.698943011164;30120.397592047597;30295.848520758136 06:44:47 INFO - PROCESS | 3466 | |2;jquery.html;428.642083859977;439.11518290644375;439.43971436418565;441.7702794546836;454.03517525258826;18803.247870085197;19794.901025494888;20167.991600419995;21049.894750526266;21244.787552124475;17791.37730179444;18013.099345032762;18019;18119.72820407695;18876.811231887677;5842.795502157425;5997.280326360843;6042.365551617083;6053.152558641794;6059.212302400704;4265.471012156603;5939.910901336461;6018.187544681456;6491.285958544557;6886.24251332353;6828.5902845829405;6863.725450981955;6867.175938887341;6871.793846184622;6891.689873955684;6609;6785.898211526831;6791.660416979132;6793.966030169867;6814.931850681504;5787.102999035156;5848.619839710405;5848.64908105515;6023.518118550549;6026.668533230671;23702.407439814142;23715.88142059296;24148.87925560361;24282.757172428228;24641.260762177164;2330.102910379499;2359.55168517981;2439.207257641274;2463.4949835283724;2848.3733578612673;15024.624384390369;15376.769348459782;15573.37706491739;15694.76457853133;15731.37074517018;1937.0314842578712;2029.1173339597322;2055.4758536573077;2103.232320203115;2111.155537784883;80335.59832200801;82187;82477.17522824755;83344.58327708322;83777;11045.779084418267;11087.944560277308;11652.708682283012;11790.410479475991;11891.702707432383;16427.52152306298;16447;16502.092384918946;16618.418355357506;16656.75014874778;8561;8680.088590698013;8754.912450875538;8881.467111973303;8887.377883548219;8304.377171712145;8393.874091888627;8489.872651910226;8543.743687689379;8562.272206862486;7065.328793764585;7163.820904477429;7194.38847697941;7290.817729556804;7372.373348265351;1733.488620856825;1816.1827177770056;1825.087456271864;1845.5386153461634;2115.165677991499;980.7940332530106;1039.9688009359731;1041.510490069666;1053.7997780421695;1069.4064794039382;17350.65298694019;18760.437186884414;19605.90197049034;19759.60480790405;19903;1015.5531566110888;1021.3259248895694;1058.756486008207;1063.9308444951052;1072.9248952573246;10964.671059868217;11106.500207490682;11219.66341009771;11243.66269011931;11243.718907027389;423925;429398;437165;440651;463938;89285;92320.0767992325;92373.53813230891;94625;95282.65574934185;1043.5043354406596;1054.7415883108688;1071.3357718214756;1078.4823284823328;1082.3397727386289;17349.56626084358;17538.82461175423;17644.382446614305;17965.820341796414;17991.370302039366;39162.608373917035;41675.37486937638;42166.789166053975;42822.57177428186;43395;53058.73470632622;57779;58276.70861645665;58309.4169058321;59713.402865970784;8321.542315172723;8428.0729119798;8441.493510389397;8499.74500764978;8509.446885952393;11918.642440726791;13303.933480332924;13676.384562694902;13834.515791947233;13918.234497102352;12335.938320308342;12445.37773111359;12477.376131193223;12734.74530509366;12839.679008024874;12045.156839021185;12328.81506777417;12337.444814983526;12380.752384952431;12898;11872.82190767122;12535.623931282076;12665.620031399072;12935.870641293466;12988.35058247065;9268.582913768762;9379.437233765995;9444.52777361143;9514.381565198517;9638.710838674851;6041.6375017499095;8919.643214271357;9806.313558050868;12742.61772146837;12903.548375806802 06:44:47 INFO - PROCESS | 3466 | |3;mootools.html;1575.9133247671373;1606.5822886049627;1829.2957211473579;1920.0303846557485;1927.3061697788785;9084.182423581884;9230.538473076336;9595.424274543533;9705.4176749395;9793.314467987244;9851.802963940718;9911.950440247807;9956.6515171969;10023.649172278972;10034.397936123838;2520.596704527276;2544.8854801533885;2567.717551069381;2568.8458692478416;2569.884355204011;2532.632768248603;2576.7423257674177;2579.045753071366;2581.032112957641;2583.3799888026833;2516.069054449856;2547.8853451594723;2568.1011645923963;2577.510273048115;2578.329634295078;2483.739207383217;2494.588392915167;2495.987520062406;2498.925032249035;2504.8497090174556;2455.7789798918184;2474.2824580871525;2477.55404027275;2494.775470207672;2509.648649189115;9396.060393960617;9465.52672366379;9496.145346918742;9615.423074615475;9636.277279204018;5556.16657501374;5724.742386592613;5732.254806875121;5767.019606666835;5780.046292361755;3637.1270894985278;3693.372126738461;3756.3614185588244;3771.264603402338;3811.8475260989526;1244.3467179730715;1272.9116605302427;1299.6815780133834;1305.0538359689244;1306.0857399820163;13379.397927093305;13445.193288402726;13462.124961877447;13554.051216414855;13585.388657510337;4762.547557982056;4812.278158276216;4820.373351464357;4839.879003024953;4909.729964851896;10345.844812327821;10440.947795261127;10457.058864702061;10458.843117353246;10491.055804977588;5619.072852979212;5621.775128994795;5630.690312032878;5634.661920284796;5638.182463542763;4692.601128904082;4971.975140124348;5068.341115654941;5106.234064890222;5184.714840683723;4030.415589739471;4083.9387409188885;4169.749815011109;4178.874633760992;4195.916081678411;1229.8032314829584;1258.2639156093787;1262.103906226571;1262.3435813376993;1265.3040827544814;987.9604815807431;1065.5737704918095;1082.7996820588216;1088.553692985872;1094.2121672395863;6378.947473666793;6608.2730899601;6663.233728121231;6694.631795251308;6712.93287067123;489.24656029713844;496.07729622901377;499.96750211236156;505.1967371878657;508.95673867720916;4644.489106198315;4694.765261736899;4715.905681886412;4717.575418212377;4758.1673207188605;11695.707607309716;12008.219465734699;12092.576759813364;12099.939500302618;12120.393980300949;11306.94346528262;11810.291382517076;11837.112216583619;12174.452149653287;12216.877831221751;8714.30285577165;8982.236509896602;9031.78070960425;9045.366824322235;9056.36605437613;6609.537332386687;6813.2846051163915;6822.590644561144;6889.586624802528;6948.166220053626;10877.891221087688;11055.668329950115;11093.5562577496;11130.944345278545;11275.718107047061;11023.393713345842;11313.943430282796;11343.149263805413;11352.091832653534;11376.146788990693;7565.6973721050545;8424.705135320479;8485.575721214038;8563.743087707378;8735.388522803343;9263.67577134824;9424.434533927986;9480.525973701426;9488.288378371788;9489.857652135086;7944.126146123806;8142.145074767301;8202.671893124209;8384.245417912418;8427.410081294496;7829.96085019594;7851.772876508941;8129.552874591955;8164.7958801030445;8238.711645092393;7434.665440055102;7671.731489397845;7683.231676832495;7906.960465197637;7976.760697179094;5427.891442171213;5429.728513574384;5464.043792336404;5483.945160548344;5632.493075623213;5745.827625171251;5781.306243250837;5784.392638772868;5830.912536312044;5838.795642152674 06:44:47 INFO - PROCESS | 3466 | |4;prototype.html;356.4599631558188;357.7799653213274;360.6988164882323;369.4919485707153;370.0342107100466;5646.717664116798;5703.543716502681;5932.28812542495;5940.851478713034;5987.4910632596175;5659.462351076651;5691.239748721867;5729.0833466645345;5729.226554415152;5741.282339707536;4443.422355093841;4453.421055262827;4470.307102399117;4487.12501062293;4508.165989291975;4442.778610694652;4498.50516443191;4501.414816073922;4515.841945531907;4544.091181763644;4403.977980110095;4422.7788610569505;4439.689221754463;4446.266366049598;4452.154090722753;4479.372887795711;4481.148581769454;4482.260427029552;4501.15452664406;4509.278515437514;3897.395903634941;3961.385985172274;3970.146418520032;4011.7191796574252;4015.859444919443;5522.144067669517;5535.335759708861;5547.944520554784;5549.472800083986;5583.720813959286;5118.129917913963;5148.073346797575;5176.715280659562;5187.559057480081;5221.642372983052;5959.612625179349;5996.4902983246475;6045.486133678643;6084.787032453887;6086.786962456293;4331.917020744814;4361.454818147731;4375.343698445226;4381.3208952612395;4426.933595996063;6192.637619723653;6328.778492752777;6337.524685648548;6343.9682801585695;6354.904676429857;4178.895527611834;4412.382266482695;4418.856854425601;4420.248557745191;4438.400815889813;4436.112777444524;4461.7730124216105;4463.352813841975;4479.238529450001;4486.487566962512;5097.668651537712;5121.641485096082;5122.231665250242;5128.205128205134;5129.7178655173575;5907.645541267451;5957.910631340534;6036.939630603725;6069.787557435557;6078.969605151946;1515.515035188729;1529.9770503442458;1548.612846788303;1554.6579752454443;1570.16781106014;966.9951650241704;977.1108291454742;979.2264111351952;1002.2583288366702;1010.8129995950773;5231.169090818259;5257.185136303879;5262.368515778055;5313.388960269541;5321.760520776575;5500.532454741312;5505.953868764922;5544.867150060203;5603.075492543766;5606.55147588192;4942.57988071018;5211.270422140903;5232.633715639869;5306.230596563477;5342.687533729113;2972.573164880869;2980.882169186555;2998.670146283907;3005.368872536748;3018.818870867755;5639.210510528529;5740.761103169767;5764.394738552475;5765.509931655773;5799.333076696234;5952.553558483131;6405.327440618761;6436.774712885027;6457.709403076873;6469.191351081115;6560.589473263271;6572.539922205496;6619.735210591619;6630.569013014138;6659.500537459709;6070.2108725865355;6335.239771227482;6343.682815859096;6348.333424990495;6406.1031455597185;6209.379062093935;6216.658083805434;6237.413487244761;6245.625262484084;6304.211973503312;6381.968564931621;6490.689748228343;6507.251666058464;6539.313372095861;6550.8362290943105;4379.715318504287;4397.274449715761;4420.381146639409;4424.81854647368;4430.269005614037;6063.454289114001;6072.939270607238;6304.590201636879;6319.715612797527;6369.649669268049;6037.366076561898;6066.514678825595;6127.20346354971;6144.201253836973;6154.507639388928;5970.000049983304;6132.025967405893;6157.84605384869;6164.719053950067;6195.473384762166;6019.608725432833;6027.728752206249;6037.154798328325;6041.456268935817;6041.577089603861;6096.817095487142;6119.724612392364;6144.877102457836;6151.446369826737;6176.289726681489;5833.270841144857;5997.5306050018025;6038.788642397495;6041.734349618893;6050.757969681164 06:44:47 INFO - PROCESS | 3466 | |5;yui.html;775.4959276470297;805.8791181322805;816.7917181118812;836.5942517878832;888.3115585421299;15828.208589570504;16030.43893463729;16476.011439313635;16655.66688666226;17285.0493222873;15968.840311596881;16089.19554022297;16207.594810129753;16209.027458352508;16237.350505979746;875.3434923807145;878.056089703568;894.7584152278913;902.1249388093539;910.8406028944942;903.1871315815786;905.7192270396165;908.3686837647838;910.2990697163181;910.8497097978826;947.7204224753714;951.0394501553411;953.9332246742731;956.6747305915987;957.1290125985355;940;940.6895724410996;940.8823897012874;948;948.0614191949988;694.5554844899268;696.0742212856889;696.6760456387804;697.7243988624516;699.7655785311927;16467.505974820775;16507.752383714254;16509.17454127301;16537.83462165387;16542.917285413496;14841.406343746345;14957.102573845605;15358.462453814063;16076.839231607652;16548.338066477325;12813.487460501568;13075.542356017493;13336.333183340794;13471.12437691547;13541.119827211298;3983.780892050936;4030.8387664493384;4062.1875624874847;4125.66994640428;4138.337865941465;79301;81000.59499702464;81474.59262703708;82798;83008;12902.290374029331;13155.802662960063;13289.13620614657;13348.93325533366;13969.930150349182;22754.772452275265;25722;26209.213723588324;26250.737492625212;26297.21108366752;9866.260030497599;9927.900720992842;9929.156021738234;9981.700548983543;10053.949730251448;5083.186690129635;5199.636025478256;5251.133562962068;5271.367435907716;5372.785088596413;4098.52866920302;4186.581341865789;4247.49030116388;4388.626966707801;4588.105319462673;771.4175797273135;779.4154384211841;780.55898417394;801.8316153607691;807.1524898856178;599.7001499250375;715.2561336210387;759.1649185895582;759.6619504320635;789.6880732110784;10004.649837255662;10083.294169408218;10175.185985121321;10309.484525773682;10458.215633827493;580.6806256558875;660.5541259649717;740.0305599664457;764.3961270596278;771.9266669666373;4627.398438203079;4852.805887764521;4856.441509226484;4897.804087836446;5020.2720605511995;100527.49736251272;127228;130931.34534327267;133074.33462832624;133619;82766;83550;85855.57072214599;100715;107632;86764;88013.55993220121;88045;88757;89022;9875.555599997873;9901.752456188653;10054.19566434698;10198.490075496047;10256.589736410759;44878.3268250983;45773.08453830971;47814.760926195144;47997;55476.72261638666;69429.30570694228;72872.63563682148;73262.26737732554;74341.25658743344;75312;13717.382717777524;13827.654308641962;13955.162690238618;14039.859601403856;14143.292835358397;14363.784543232068;14576.781348279996;14962.177080260255;15607.375704971673;15785.447509337118;14312.713745725236;14797.556073317388;14980.1011939284;14993.775093373826;15732.29204685769;14477.817525987664;14483.131012139305;14617.122972621677;14651.267436628339;14657.267136642911;14534.200618966059;14546.92726536403;14651.194184319966;14750.55748327552;14883.851161488246;11653.6503904883;11715.707107322385;11884.702882427662;12077.27536347822;12342;11960.880391195977;12347.75304493887;12484.812727808909;12524.937375313066;12590.937045314715 06:44:47 INFO - PROCESS | 3466 | __end_tp_report 06:44:47 INFO - PROCESS | 3466 | __start_cc_report 06:44:47 INFO - PROCESS | 3466 | _x_x_mozilla_cycle_collect,358 06:44:47 INFO - PROCESS | 3466 | __end_cc_report 06:44:47 INFO - PROCESS | 3466 | __startTimestamp1467035087626__endTimestamp 06:44:47 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | ------- Summary: start ------- 06:44:47 INFO - PROCESS | 3466 | Number of tests: 6 06:44:47 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | [#0] dojo.html Cycles:165 Average:5689.94 Median:5933.50 stddev:640.86 (10.8%) stddev-sans-first:616.56 06:44:47 INFO - PROCESS | 3466 | Values: 3374.8 3427.1 3439.9 3453.2 3462.3 5628.9 5664.0 5707.1 5734.5 5762.3 5702.9 5734.1 5737.9 5748.1 5796.9 5098.1 5157.5 5197.6 5202.7 5234.8 5099.2 5168.9 5206.4 5266.1 5320.1 5184.2 5196.7 5201.1 5221.6 5265.6 5219.9 5267.5 5271.1 5276.1 5299.7 5090.5 5133.9 5182.9 5240.1 5263.7 5499.4 5515.0 5528.4 5548.2 5649.7 6106.8 6130.4 6145.5 6153.1 6156.3 6183.3 6189.1 6197.3 6200.5 6200.6 5646.2 5655.0 5690.4 5696.9 5736.6 6197.1 6221.1 6273.6 6283.6 6292.4 5859.3 5975.8 5987.6 6028.7 6039.5 6048.5 6059.4 6115.8 6140.7 6170.1 6048.1 6091.7 6108.4 6120.8 6132.7 5922.1 6021.3 6144.4 6145.8 6160.8 4518.7 4613.0 4637.6 4639.3 4655.4 4149.2 4159.3 4165.6 4176.9 4195.5 5773.7 5851.1 5857.4 5860.0 5875.7 6017.5 6028.6 6124.6 6142.3 6233.9 5940.4 5966.4 5973.1 5982.5 5991.3 5174.9 5190.4 5226.2 5294.5 5333.7 6421.7 6432.6 6434.8 6445.8 6446.7 6236.1 6251.4 6255.4 6262.4 6268.0 6152.7 6159.5 6183.5 6252.0 6439.9 6001.2 6027.2 6032.6 6033.8 6036.2 6105.8 6133.6 6135.4 6142.0 6143.4 5823.5 5909.8 5925.4 5933.5 6008.7 5919.4 5983.4 5985.1 5988.5 6006.0 5748.3 5853.7 5907.7 5908.0 5934.0 5955.3 5958.4 6000.5 6029.2 6057.6 5920.7 5932.6 5964.6 5965.7 5980.3 06:44:47 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | [#1] ext.html Cycles:180 Average:64636.96 Median:44465.61 stddev:137548.28 (309.3%) stddev-sans-first:137850.23 06:44:47 INFO - PROCESS | 3466 | Values: 647.1 652.6 666.8 667.9 674.3 37097.4 38343.4 42622.4 42855.6 42908.0 44298.6 44927.8 45119.1 45233.1 45432.0 8748.7 8955.8 8995.9 9005.1 9041.8 8780.8 8835.0 8877.8 8879.0 8882.9 8930.1 8951.3 8954.7 8974.5 9006.2 8831.0 8845.9 8895.6 8898.7 8949.1 8823.0 8856.2 8864.0 8904.3 8956.7 41683.0 41788.4 41872.0 41973.8 42060.6 3657.7 3688.7 3761.9 3881.8 4302.9 32397.0 33284.0 33288.2 33501.8 33519.5 4717.4 4737.3 4745.1 4778.3 4805.2 293200.0 294284.0 294926.0 295363.0 295625.0 37176.4 59665.0 59988.4 60029.7 60265.0 36342.8 38625.8 38755.8 38777.2 38854.8 15830.8 16052.2 16066.3 16114.8 16147.3 13121.4 13149.4 13209.4 13232.1 13286.2 8593.5 8662.1 8701.7 8740.6 8877.4 3511.7 3528.2 3552.3 3622.4 3638.3 1047.5 1124.9 1166.5 1225.2 1242.7 31555.7 31786.5 32523.7 32532.1 32720.2 1125.1 1139.7 1178.3 1246.6 1280.3 17223.4 17260.8 17364.0 17404.7 17614.6 419069.0 641792.0 645400.0 649336.0 909684.0 64284.4 65143.7 65387.7 65425.0 65486.7 1488.1 1497.8 1501.6 1502.1 1514.9 33522.3 33953.2 34077.8 34216.7 34435.5 61431.7 63664.0 63673.7 69439.3 69546.3 494956.0 504437.0 505189.0 505485.0 505547.0 48407.3 48790.5 48910.8 48947.8 49264.5 53453.2 54265.7 54366.5 55307.2 55492.4 44479.2 45023.0 45233.5 46798.8 46851.8 44060.3 44198.3 44773.8 44834.6 44844.6 44452.0 44712.6 45020.0 45064.8 45578.5 38785.4 39226.0 39295.8 39833.2 40116.0 29374.9 29766.3 30105.7 30120.4 30295.8 06:44:47 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | [#2] jquery.html Cycles:180 Average:28114.87 Median:24215.82 stddev:72665.59 (300.1%) stddev-sans-first:72839.70 06:44:47 INFO - PROCESS | 3466 | Values: 428.6 439.1 439.4 441.8 454.0 18803.2 19794.9 20168.0 21049.9 21244.8 17791.4 18013.1 18019.0 18119.7 18876.8 5842.8 5997.3 6042.4 6053.2 6059.2 4265.5 5939.9 6018.2 6491.3 6886.2 6828.6 6863.7 6867.2 6871.8 6891.7 6609.0 6785.9 6791.7 6794.0 6814.9 5787.1 5848.6 5848.6 6023.5 6026.7 23702.4 23715.9 24148.9 24282.8 24641.3 2330.1 2359.6 2439.2 2463.5 2848.4 15024.6 15376.8 15573.4 15694.8 15731.4 1937.0 2029.1 2055.5 2103.2 2111.2 80335.6 82187.0 82477.2 83344.6 83777.0 11045.8 11087.9 11652.7 11790.4 11891.7 16427.5 16447.0 16502.1 16618.4 16656.8 8561.0 8680.1 8754.9 8881.5 8887.4 8304.4 8393.9 8489.9 8543.7 8562.3 7065.3 7163.8 7194.4 7290.8 7372.4 1733.5 1816.2 1825.1 1845.5 2115.2 980.8 1040.0 1041.5 1053.8 1069.4 17350.7 18760.4 19605.9 19759.6 19903.0 1015.6 1021.3 1058.8 1063.9 1072.9 10964.7 11106.5 11219.7 11243.7 11243.7 423925.0 429398.0 437165.0 440651.0 463938.0 89285.0 92320.1 92373.5 94625.0 95282.7 1043.5 1054.7 1071.3 1078.5 1082.3 17349.6 17538.8 17644.4 17965.8 17991.4 39162.6 41675.4 42166.8 42822.6 43395.0 53058.7 57779.0 58276.7 58309.4 59713.4 8321.5 8428.1 8441.5 8499.7 8509.4 11918.6 13303.9 13676.4 13834.5 13918.2 12335.9 12445.4 12477.4 12734.7 12839.7 12045.2 12328.8 12337.4 12380.8 12898.0 11872.8 12535.6 12665.6 12935.9 12988.4 9268.6 9379.4 9444.5 9514.4 9638.7 6041.6 8919.6 9806.3 12742.6 12903.5 06:44:47 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | [#3] mootools.html Cycles:180 Average:6301.90 Median:4737.87 stddev:3613.10 (76.3%) stddev-sans-first:3605.78 06:44:47 INFO - PROCESS | 3466 | Values: 1575.9 1606.6 1829.3 1920.0 1927.3 9084.2 9230.5 9595.4 9705.4 9793.3 9851.8 9912.0 9956.7 10023.6 10034.4 2520.6 2544.9 2567.7 2568.8 2569.9 2532.6 2576.7 2579.0 2581.0 2583.4 2516.1 2547.9 2568.1 2577.5 2578.3 2483.7 2494.6 2496.0 2498.9 2504.8 2455.8 2474.3 2477.6 2494.8 2509.6 9396.1 9465.5 9496.1 9615.4 9636.3 5556.2 5724.7 5732.3 5767.0 5780.0 3637.1 3693.4 3756.4 3771.3 3811.8 1244.3 1272.9 1299.7 1305.1 1306.1 13379.4 13445.2 13462.1 13554.1 13585.4 4762.5 4812.3 4820.4 4839.9 4909.7 10345.8 10440.9 10457.1 10458.8 10491.1 5619.1 5621.8 5630.7 5634.7 5638.2 4692.6 4972.0 5068.3 5106.2 5184.7 4030.4 4083.9 4169.7 4178.9 4195.9 1229.8 1258.3 1262.1 1262.3 1265.3 988.0 1065.6 1082.8 1088.6 1094.2 6378.9 6608.3 6663.2 6694.6 6712.9 489.2 496.1 500.0 505.2 509.0 4644.5 4694.8 4715.9 4717.6 4758.2 11695.7 12008.2 12092.6 12099.9 12120.4 11306.9 11810.3 11837.1 12174.5 12216.9 8714.3 8982.2 9031.8 9045.4 9056.4 6609.5 6813.3 6822.6 6889.6 6948.2 10877.9 11055.7 11093.6 11130.9 11275.7 11023.4 11313.9 11343.1 11352.1 11376.1 7565.7 8424.7 8485.6 8563.7 8735.4 9263.7 9424.4 9480.5 9488.3 9489.9 7944.1 8142.1 8202.7 8384.2 8427.4 7830.0 7851.8 8129.6 8164.8 8238.7 7434.7 7671.7 7683.2 7907.0 7976.8 5427.9 5429.7 5464.0 5483.9 5632.5 5745.8 5781.3 5784.4 5830.9 5838.8 06:44:47 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | [#4] prototype.html Cycles:180 Average:5042.15 Median:5604.81 stddev:1502.30 (26.8%) stddev-sans-first:1464.77 06:44:47 INFO - PROCESS | 3466 | Values: 356.5 357.8 360.7 369.5 370.0 5646.7 5703.5 5932.3 5940.9 5987.5 5659.5 5691.2 5729.1 5729.2 5741.3 4443.4 4453.4 4470.3 4487.1 4508.2 4442.8 4498.5 4501.4 4515.8 4544.1 4404.0 4422.8 4439.7 4446.3 4452.2 4479.4 4481.1 4482.3 4501.2 4509.3 3897.4 3961.4 3970.1 4011.7 4015.9 5522.1 5535.3 5547.9 5549.5 5583.7 5118.1 5148.1 5176.7 5187.6 5221.6 5959.6 5996.5 6045.5 6084.8 6086.8 4331.9 4361.5 4375.3 4381.3 4426.9 6192.6 6328.8 6337.5 6344.0 6354.9 4178.9 4412.4 4418.9 4420.2 4438.4 4436.1 4461.8 4463.4 4479.2 4486.5 5097.7 5121.6 5122.2 5128.2 5129.7 5907.6 5957.9 6036.9 6069.8 6079.0 1515.5 1530.0 1548.6 1554.7 1570.2 967.0 977.1 979.2 1002.3 1010.8 5231.2 5257.2 5262.4 5313.4 5321.8 5500.5 5506.0 5544.9 5603.1 5606.6 4942.6 5211.3 5232.6 5306.2 5342.7 2972.6 2980.9 2998.7 3005.4 3018.8 5639.2 5740.8 5764.4 5765.5 5799.3 5952.6 6405.3 6436.8 6457.7 6469.2 6560.6 6572.5 6619.7 6630.6 6659.5 6070.2 6335.2 6343.7 6348.3 6406.1 6209.4 6216.7 6237.4 6245.6 6304.2 6382.0 6490.7 6507.3 6539.3 6550.8 4379.7 4397.3 4420.4 4424.8 4430.3 6063.5 6072.9 6304.6 6319.7 6369.6 6037.4 6066.5 6127.2 6144.2 6154.5 5970.0 6132.0 6157.8 6164.7 6195.5 6019.6 6027.7 6037.2 6041.5 6041.6 6096.8 6119.7 6144.9 6151.4 6176.3 5833.3 5997.5 6038.8 6041.7 6050.8 06:44:47 INFO - PROCESS | 3466 | 06:44:47 INFO - PROCESS | 3466 | [#5] yui.html Cycles:180 Average:21627.09 Median:4132.00 stddev:30576.46 (740.0%) stddev-sans-first:30622.15 06:44:47 INFO - PROCESS | 3466 | Values: 775.5 805.9 816.8 836.6 888.3 15828.2 16030.4 16476.0 16655.7 17285.0 15968.8 16089.2 16207.6 16209.0 16237.4 875.3 878.1 894.8 902.1 910.8 903.2 905.7 908.4 910.3 910.8 947.7 951.0 953.9 956.7 957.1 940.0 940.7 940.9 948.0 948.1 694.6 696.1 696.7 697.7 699.8 16467.5 16507.8 16509.2 16537.8 16542.9 14841.4 14957.1 15358.5 16076.8 16548.3 12813.5 13075.5 13336.3 13471.1 13541.1 3983.8 4030.8 4062.2 4125.7 4138.3 79301.0 81000.6 81474.6 82798.0 83008.0 12902.3 13155.8 13289.1 13348.9 13969.9 22754.8 25722.0 26209.2 26250.7 26297.2 9866.3 9927.9 9929.2 9981.7 10053.9 5083.2 5199.6 5251.1 5271.4 5372.8 4098.5 4186.6 4247.5 4388.6 4588.1 771.4 779.4 780.6 801.8 807.2 599.7 715.3 759.2 759.7 789.7 10004.6 10083.3 10175.2 10309.5 10458.2 580.7 660.6 740.0 764.4 771.9 4627.4 4852.8 4856.4 4897.8 5020.3 100527.5 127228.0 130931.3 133074.3 133619.0 82766.0 83550.0 85855.6 100715.0 107632.0 86764.0 88013.6 88045.0 88757.0 89022.0 9875.6 9901.8 10054.2 10198.5 10256.6 44878.3 45773.1 47814.8 47997.0 55476.7 69429.3 72872.6 73262.3 74341.3 75312.0 13717.4 13827.7 13955.2 14039.9 14143.3 14363.8 14576.8 14962.2 15607.4 15785.4 14312.7 14797.6 14980.1 14993.8 15732.3 14477.8 14483.1 14617.1 14651.3 14657.3 14534.2 14546.9 14651.2 14750.6 14883.9 11653.7 11715.7 11884.7 12077.3 12342.0 11960.9 12347.8 12484.8 12524.9 12590.9 06:44:47 INFO - PROCESS | 3466 | -------- Summary: end -------- 06:44:47 INFO - PROCESS | 3466 | 06:44:48 INFO - TEST-INFO | 3466: exit 0 06:44:48 INFO - TEST-OK | dromaeo_css | took 1124211ms 06:44:48 INFO - TEST-START | kraken 06:44:48 INFO - operating with platform_type : linux_ 06:44:48 INFO - Initialising browser for kraken test... 06:44:48 INFO - TEST-INFO | started process 3748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbiys7/profile http://localhost:56066/getInfo.html) 06:44:55 INFO - PROCESS | 3748 | __metrics Screen width/height:1600/1200 06:44:55 INFO - PROCESS | 3748 | colorDepth:24 06:44:55 INFO - PROCESS | 3748 | Browser inner width/height: 1024/697 06:44:55 INFO - PROCESS | 3748 | __metrics 06:44:56 ERROR - PROCESS | 3748 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:44:57 INFO - TEST-INFO | 3748: exit 0 06:44:57 INFO - Browser initialized. 06:44:57 INFO - Running cycle 1/1 for kraken test... 06:44:57 INFO - TEST-INFO | started process 3882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUbiys7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:09 INFO - PROCESS | 3882 | RSS: Main: 156110848 06:45:09 INFO - PROCESS | 3882 | 06:45:11 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56066/tests/kraken/driver.html?testName=audio-beat-detection) 06:45:12 INFO - PROCESS | 3882 | RSS: Main: 161538048 06:45:12 INFO - PROCESS | 3882 | 06:45:15 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56066/tests/kraken/driver.html?testName=audio-dft) 06:45:16 INFO - PROCESS | 3882 | RSS: Main: 160518144 06:45:16 INFO - PROCESS | 3882 | 06:45:18 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56066/tests/kraken/driver.html?testName=audio-fft) 06:45:19 INFO - PROCESS | 3882 | RSS: Main: 161112064 06:45:19 INFO - PROCESS | 3882 | 06:45:21 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56066/tests/kraken/driver.html?testName=audio-oscillator) 06:45:22 INFO - PROCESS | 3882 | RSS: Main: 161202176 06:45:22 INFO - PROCESS | 3882 | 06:45:24 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56066/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:45:24 INFO - PROCESS | 3882 | RSS: Main: 161083392 06:45:24 INFO - PROCESS | 3882 | 06:45:27 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56066/tests/kraken/driver.html?testName=imaging-darkroom) 06:45:28 INFO - PROCESS | 3882 | RSS: Main: 160759808 06:45:28 INFO - PROCESS | 3882 | 06:45:31 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56066/tests/kraken/driver.html?testName=imaging-desaturate) 06:45:32 INFO - PROCESS | 3882 | RSS: Main: 161058816 06:45:32 INFO - PROCESS | 3882 | 06:45:35 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56066/tests/kraken/driver.html?testName=json-parse-financial) 06:45:36 INFO - PROCESS | 3882 | RSS: Main: 160825344 06:45:36 INFO - PROCESS | 3882 | 06:45:38 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56066/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:45:39 INFO - PROCESS | 3882 | RSS: Main: 160923648 06:45:39 INFO - PROCESS | 3882 | 06:45:39 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56066/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:45:40 INFO - PROCESS | 3882 | RSS: Main: 161148928 06:45:40 INFO - PROCESS | 3882 | 06:45:42 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56066/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:45:43 INFO - PROCESS | 3882 | RSS: Main: 161763328 06:45:43 INFO - PROCESS | 3882 | 06:45:54 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:54 INFO - PROCESS | 3882 | RSS: Main: 159641600 06:45:54 INFO - PROCESS | 3882 | 06:45:57 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:45:58 INFO - PROCESS | 3882 | RSS: Main: 165306368 06:45:58 INFO - PROCESS | 3882 | 06:45:58 INFO - PROCESS | 3882 | 1467035158954 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] 06:45:59 INFO - PROCESS | 3882 | Cycle 1(1): loaded http://localhost:56066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56066/tests/kraken/driver.html?testName=ai-astar) 06:46:00 INFO - PROCESS | 3882 | RSS: Main: 167571456 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | __start_tp_report 06:46:00 INFO - PROCESS | 3882 | _x_x_mozilla_page_load 06:46:00 INFO - PROCESS | 3882 | _x_x_mozilla_page_load_details 06:46:00 INFO - PROCESS | 3882 | |i|pagename|runs| 06:46:00 INFO - PROCESS | 3882 | |0;ai-astar;114;106;110;111;110;112;111;111;112;111 06:46:00 INFO - PROCESS | 3882 | |1;audio-beat-detection;162;122;159;172;128;151;160;133;187;124 06:46:00 INFO - PROCESS | 3882 | |2;audio-dft;164;163;162;162;163;162;166;162;162;166 06:46:00 INFO - PROCESS | 3882 | |3;audio-fft;87;75;75;168;75;75;75;76;162;78 06:46:00 INFO - PROCESS | 3882 | |4;audio-oscillator;85;83;148;85;84;86;144;85;84;140 06:46:00 INFO - PROCESS | 3882 | |5;imaging-gaussian-blur;119;117;117;117;120;118;118;117;118;118 06:46:00 INFO - PROCESS | 3882 | |6;imaging-darkroom;147;149;147;147;148;149;147;147;147;148 06:46:00 INFO - PROCESS | 3882 | |7;imaging-desaturate;99;96;95;96;96;95;96;96;96;95 06:46:00 INFO - PROCESS | 3882 | |8;json-parse-financial;52;56;53;52;51;53;51;51;52;51 06:46:00 INFO - PROCESS | 3882 | |9;json-stringify-tinderbox;60;61;60;60;60;60;61;63;60;60 06:46:00 INFO - PROCESS | 3882 | |10;stanford-crypto-aes;77;76;77;79;77;79;80;80;103;78 06:46:00 INFO - PROCESS | 3882 | |11;stanford-crypto-ccm;136;129;123;120;125;118;126;125;128;121 06:46:00 INFO - PROCESS | 3882 | |12;stanford-crypto-pbkdf2;168;162;158;161;158;157;168;160;160;162 06:46:00 INFO - PROCESS | 3882 | |13;stanford-crypto-sha256-iterative;65;63;63;63;64;66;63;63;70;66 06:46:00 INFO - PROCESS | 3882 | __end_tp_report 06:46:00 INFO - PROCESS | 3882 | __start_cc_report 06:46:00 INFO - PROCESS | 3882 | _x_x_mozilla_cycle_collect,852 06:46:00 INFO - PROCESS | 3882 | __end_cc_report 06:46:00 INFO - PROCESS | 3882 | __startTimestamp1467035160218__endTimestamp 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | ------- Summary: start ------- 06:46:00 INFO - PROCESS | 3882 | Number of tests: 14 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.04 (1.8%) stddev-sans-first:1.81 06:46:00 INFO - PROCESS | 3882 | Values: 114.0 106.0 110.0 111.0 110.0 112.0 111.0 111.0 112.0 111.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:159.50 stddev:22.14 (13.9%) stddev-sans-first:23.04 06:46:00 INFO - PROCESS | 3882 | Values: 162.0 122.0 159.0 172.0 128.0 151.0 160.0 133.0 187.0 124.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.62 (1.0%) stddev-sans-first:1.69 06:46:00 INFO - PROCESS | 3882 | Values: 164.0 163.0 162.0 162.0 163.0 162.0 166.0 162.0 162.0 166.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:37.31 (49.8%) stddev-sans-first:39.48 06:46:00 INFO - PROCESS | 3882 | Values: 87.0 75.0 75.0 168.0 75.0 75.0 75.0 76.0 162.0 78.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.50 stddev:28.78 (34.1%) stddev-sans-first:29.83 06:46:00 INFO - PROCESS | 3882 | Values: 85.0 83.0 148.0 85.0 84.0 86.0 144.0 85.0 84.0 140.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:0.97 06:46:00 INFO - PROCESS | 3882 | Values: 119.0 117.0 117.0 117.0 120.0 118.0 118.0 117.0 118.0 118.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 06:46:00 INFO - PROCESS | 3882 | Values: 147.0 149.0 147.0 147.0 148.0 149.0 147.0 147.0 147.0 148.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.15 (1.2%) stddev-sans-first:0.50 06:46:00 INFO - PROCESS | 3882 | Values: 99.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:1.55 (3.0%) stddev-sans-first:1.64 06:46:00 INFO - PROCESS | 3882 | Values: 52.0 56.0 53.0 52.0 51.0 53.0 51.0 51.0 52.0 51.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 06:46:00 INFO - PROCESS | 3882 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 61.0 63.0 60.0 60.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:78.50 stddev:7.99 (10.2%) stddev-sans-first:8.37 06:46:00 INFO - PROCESS | 3882 | Values: 77.0 76.0 77.0 79.0 77.0 79.0 80.0 80.0 103.0 78.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:125.50 stddev:5.17 (4.1%) stddev-sans-first:3.69 06:46:00 INFO - PROCESS | 3882 | Values: 136.0 129.0 123.0 120.0 125.0 118.0 126.0 125.0 128.0 121.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.50 stddev:3.86 (2.4%) stddev-sans-first:3.28 06:46:00 INFO - PROCESS | 3882 | Values: 168.0 162.0 158.0 161.0 158.0 157.0 168.0 160.0 160.0 162.0 06:46:00 INFO - PROCESS | 3882 | 06:46:00 INFO - PROCESS | 3882 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:2.27 (3.5%) stddev-sans-first:2.40 06:46:00 INFO - PROCESS | 3882 | Values: 65.0 63.0 63.0 63.0 64.0 66.0 63.0 63.0 70.0 66.0 06:46:00 INFO - PROCESS | 3882 | -------- Summary: end -------- 06:46:00 INFO - PROCESS | 3882 | 06:46:01 INFO - TEST-INFO | 3882: exit 0 06:46:01 INFO - TEST-OK | kraken | took 72668ms 06:46:01 INFO - SUITE-END | took 1196s 06:46:01 INFO - Completed test suite (00:19:57) 06:46:01 INFO - javascript benchmark 06:46:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7688.71490631499, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.780639258448, 3427.0746898337447, 3439.896803095908, 3453.205762674585, 3462.3248466549016, 5628.859278518039, 5663.9999999999945, 5707.058335374663, 5734.455226753462, 5762.3373312069125, 5702.885942281152, 5734.053881109612, 5737.885242295151, 5748.137779333102, 5796.942030579693, 5098.056859480989, 5157.458466860963, 5197.584193264549, 5202.739863006854, 5234.79060837568, 5099.15863882459, 5168.948310516903, 5206.375234971809, 5266.052110620087, 5320.14877619581, 5184.196449550326, 5196.662216955886, 5201.115810312256, 5221.582273418117, 5265.552428043621, 5219.86950326243, 5267.5259226669405, 5271.103912334912, 5276.12943864262, 5299.682019078868, 5090.49095090488, 5133.922991155136, 5182.948170518284, 5240.056789777838, 5263.710495922723, 5499.3675727291475, 5515.034868897927, 5528.44715528448, 5548.223248745179, 5649.661020338752, 6106.755729770848, 6130.417610327012, 6145.477634401082, 6153.107799369066, 6156.322804491547, 6183.2889217740085, 6189.102580125857, 6197.318294987548, 6200.534959878028, 6200.627962322275, 5646.20953066571, 5655.010373184677, 5690.40250773667, 5696.943030569724, 5736.569757268263, 6197.070439434121, 6221.097940798559, 6273.560850740496, 6283.560150789401, 6292.370762923671, 5859.326177489558, 5975.760969561169, 5987.580869339192, 6028.698565071729, 6039.456448919531, 6048.516118710492, 6059.424354686298, 6115.816525504242, 6140.699918429095, 6170.10533472644, 6048.12302216185, 6091.744580856434, 6108.35862234459, 6120.816375508742, 6132.6627035513475, 5922.1412895130825, 6021.307549631849, 6144.354842741537, 6145.84635384119, 6160.753569857246, 4518.706284091523, 4612.95387046132, 4637.6289896808175, 4639.30410438437, 4655.4180727409075, 4149.232392007489, 4159.272127377697, 4165.562615925345, 4176.853810116631, 4195.49654041517, 5773.6824474654295, 5851.063829787214, 5857.355690874, 5859.970700146472, 5875.735591898375, 6017.518598512109, 6028.608140470856, 6124.571280010446, 6142.293636231801, 6233.937660623426, 5940.405959404112, 5966.373530779292, 5973.074173503114, 5982.461578457873, 5991.340952495222, 5174.870628234249, 5190.403103643054, 5226.163813789852, 5294.49702278283, 5333.733313334318, 6421.743130274736, 6432.614043157426, 6434.8391290218115, 6445.838854028687, 6446.677666116675, 6236.064590311489, 6251.374862513712, 6255.374462553708, 6262.436380725574, 6268.0, 6152.692365381802, 6159.507239420746, 6183.536234782499, 6252.030935205051, 6439.935600643934, 6001.189839371629, 6027.21646185993, 6032.638041717511, 6033.78881739137, 6036.154938308729, 6105.755769769159, 6133.601315914451, 6135.386461353829, 6142.04798256271, 6143.385661433999, 5823.505002074871, 5909.793157239476, 5925.4370834770625, 5933.495652869555, 6008.669523176267, 5919.4080591940465, 5983.401659833982, 5985.132155837467, 5988.520918326611, 6006.0, 5748.338941021836, 5853.678047707247, 5907.704614769158, 5907.970460147843, 5933.970330148321, 5955.315138758925, 5958.433948774859, 6000.51995840323, 6029.246344206974, 6057.636541807329, 5920.703964801829, 5932.64404135736, 5964.582479226586, 5965.6718880461995, 5980.3421623622235], "value": 5647.70932207132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.0908373734902, 652.634524666187, 666.7766298290074, 667.8731041102187, 674.2583158525625, 37097.44353834691, 38343.424848627255, 42622.360664590014, 42855.571444285546, 42908.0, 44298.55701442985, 44927.775361123146, 45119.09761804762, 45233.09533809322, 45432.0, 8748.737537873858, 8955.776105597379, 8995.910040899606, 9005.099490050976, 9041.773955651128, 8780.780480488007, 8835.028146903835, 8877.778055548632, 8878.955605221965, 8882.86675699865, 8930.062343453941, 8951.328650351217, 8954.686585969492, 8974.50640214788, 9006.189442950134, 8831.02858685544, 8845.867311990292, 8895.555222238861, 8898.688545900895, 8949.060348663426, 8822.955885220597, 8856.247218986395, 8863.955680221557, 8904.287656987426, 8956.731298061068, 41683.0, 41788.373174402106, 41872.0, 41973.79013104915, 42060.57939420628, 3657.6708096271464, 3688.704903607705, 3761.9435708464393, 3881.8059097045316, 4302.902759796232, 32397.0, 33284.0, 33288.16779580506, 33501.83249083763, 33519.49720754191, 4717.410323709536, 4737.313089601988, 4745.098431298043, 4778.331033655291, 4805.231163013936, 293200.0, 294284.0, 294926.0, 295363.0, 295625.0, 37176.44235336472, 59665.0, 59988.40011599915, 60029.69985150046, 60265.0, 36342.818285908405, 38625.80687096546, 38755.80622096928, 38777.2244555113, 38854.805725971186, 15830.841691583168, 16052.197390130446, 16066.27701753424, 16114.75827862583, 16147.273372698257, 13121.409536570878, 13149.408276627575, 13209.40557674907, 13232.139910905953, 13286.20282783036, 8593.527355995355, 8662.133786621287, 8701.738947831574, 8740.601503759368, 8877.378583499092, 3511.6839484446523, 3528.188516641187, 3552.307300076512, 3622.42041273395, 3638.2541578976247, 1047.4972013433442, 1124.8875112488686, 1166.4634268236537, 1225.1668865171769, 1242.7203879127123, 31555.684443155733, 31786.523202151988, 32523.674763252064, 32532.08868144719, 32720.181995450304, 1125.1031178873454, 1139.7378602921374, 1178.3224645828682, 1246.6073186946082, 1280.3342262023696, 17223.36378044109, 17260.827391726172, 17364.0, 17404.65190696179, 17614.647707045788, 419069.0, 641792.0, 645400.0, 649336.0, 909684.0, 64284.35715642877, 65143.674281628286, 65387.67306163534, 65425.0, 65486.67256663686, 1488.0773920169563, 1497.7903093566908, 1501.5870635575304, 1502.053706165109, 1514.9166795826116, 33522.32955340928, 33953.15117122092, 34077.82961085278, 34216.657833422345, 34435.4834677475, 61431.69284153551, 63664.0, 63673.68163159154, 69439.30560694328, 69546.30453695398, 494956.0, 504437.0, 505189.0, 505485.0, 505547.0, 48407.27389089237, 48790.5120948786, 48910.75544622254, 48947.755261223465, 49264.50735492599, 53453.19820202778, 54265.72867135639, 54366.456335437724, 55307.170392444954, 55492.44507554873, 44479.22083116769, 45023.0, 45233.54766452425, 46798.76600616975, 46851.76574117244, 44060.33909491296, 44198.337024944005, 44773.776131119135, 44834.55165448304, 44844.55155448534, 44452.0, 44712.552874470835, 45020.0, 45064.774676126406, 45578.54421455743, 38785.418218726176, 39226.0, 39295.803520983354, 39833.2033359337, 40115.99710007157, 29374.853125734233, 29766.25584360408, 30105.698943011164, 30120.397592047597, 30295.848520758136], "value": 20288.414729710552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.642083859977, 439.11518290644375, 439.43971436418565, 441.7702794546836, 454.03517525258826, 18803.247870085197, 19794.901025494888, 20167.991600419995, 21049.894750526266, 21244.787552124475, 17791.37730179444, 18013.099345032762, 18019.0, 18119.72820407695, 18876.811231887677, 5842.795502157425, 5997.280326360843, 6042.365551617083, 6053.152558641794, 6059.212302400704, 4265.471012156603, 5939.910901336461, 6018.187544681456, 6491.285958544557, 6886.24251332353, 6828.5902845829405, 6863.725450981955, 6867.175938887341, 6871.793846184622, 6891.689873955684, 6609.0, 6785.898211526831, 6791.660416979132, 6793.966030169867, 6814.931850681504, 5787.102999035156, 5848.619839710405, 5848.64908105515, 6023.518118550549, 6026.668533230671, 23702.407439814142, 23715.88142059296, 24148.87925560361, 24282.757172428228, 24641.260762177164, 2330.102910379499, 2359.55168517981, 2439.207257641274, 2463.4949835283724, 2848.3733578612673, 15024.624384390369, 15376.769348459782, 15573.37706491739, 15694.76457853133, 15731.37074517018, 1937.0314842578712, 2029.1173339597322, 2055.4758536573077, 2103.232320203115, 2111.155537784883, 80335.59832200801, 82187.0, 82477.17522824755, 83344.58327708322, 83777.0, 11045.779084418267, 11087.944560277308, 11652.708682283012, 11790.410479475991, 11891.702707432383, 16427.52152306298, 16447.0, 16502.092384918946, 16618.418355357506, 16656.75014874778, 8561.0, 8680.088590698013, 8754.912450875538, 8881.467111973303, 8887.377883548219, 8304.377171712145, 8393.874091888627, 8489.872651910226, 8543.743687689379, 8562.272206862486, 7065.328793764585, 7163.820904477429, 7194.38847697941, 7290.817729556804, 7372.373348265351, 1733.488620856825, 1816.1827177770056, 1825.087456271864, 1845.5386153461634, 2115.165677991499, 980.7940332530106, 1039.9688009359731, 1041.510490069666, 1053.7997780421695, 1069.4064794039382, 17350.65298694019, 18760.437186884414, 19605.90197049034, 19759.60480790405, 19903.0, 1015.5531566110888, 1021.3259248895694, 1058.756486008207, 1063.9308444951052, 1072.9248952573246, 10964.671059868217, 11106.500207490682, 11219.66341009771, 11243.66269011931, 11243.718907027389, 423925.0, 429398.0, 437165.0, 440651.0, 463938.0, 89285.0, 92320.0767992325, 92373.53813230891, 94625.0, 95282.65574934185, 1043.5043354406596, 1054.7415883108688, 1071.3357718214756, 1078.4823284823328, 1082.3397727386289, 17349.56626084358, 17538.82461175423, 17644.382446614305, 17965.820341796414, 17991.370302039366, 39162.608373917035, 41675.37486937638, 42166.789166053975, 42822.57177428186, 43395.0, 53058.73470632622, 57779.0, 58276.70861645665, 58309.4169058321, 59713.402865970784, 8321.542315172723, 8428.0729119798, 8441.493510389397, 8499.74500764978, 8509.446885952393, 11918.642440726791, 13303.933480332924, 13676.384562694902, 13834.515791947233, 13918.234497102352, 12335.938320308342, 12445.37773111359, 12477.376131193223, 12734.74530509366, 12839.679008024874, 12045.156839021185, 12328.81506777417, 12337.444814983526, 12380.752384952431, 12898.0, 11872.82190767122, 12535.623931282076, 12665.620031399072, 12935.870641293466, 12988.35058247065, 9268.582913768762, 9379.437233765995, 9444.52777361143, 9514.381565198517, 9638.710838674851, 6041.6375017499095, 8919.643214271357, 9806.313558050868, 12742.61772146837, 12903.548375806802], "value": 9763.04368402409, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.9133247671373, 1606.5822886049627, 1829.2957211473579, 1920.0303846557485, 1927.3061697788785, 9084.182423581884, 9230.538473076336, 9595.424274543533, 9705.4176749395, 9793.314467987244, 9851.802963940718, 9911.950440247807, 9956.6515171969, 10023.649172278972, 10034.397936123838, 2520.596704527276, 2544.8854801533885, 2567.717551069381, 2568.8458692478416, 2569.884355204011, 2532.632768248603, 2576.7423257674177, 2579.045753071366, 2581.032112957641, 2583.3799888026833, 2516.069054449856, 2547.8853451594723, 2568.1011645923963, 2577.510273048115, 2578.329634295078, 2483.739207383217, 2494.588392915167, 2495.987520062406, 2498.925032249035, 2504.8497090174556, 2455.7789798918184, 2474.2824580871525, 2477.55404027275, 2494.775470207672, 2509.648649189115, 9396.060393960617, 9465.52672366379, 9496.145346918742, 9615.423074615475, 9636.277279204018, 5556.16657501374, 5724.742386592613, 5732.254806875121, 5767.019606666835, 5780.046292361755, 3637.1270894985278, 3693.372126738461, 3756.3614185588244, 3771.264603402338, 3811.8475260989526, 1244.3467179730715, 1272.9116605302427, 1299.6815780133834, 1305.0538359689244, 1306.0857399820163, 13379.397927093305, 13445.193288402726, 13462.124961877447, 13554.051216414855, 13585.388657510337, 4762.547557982056, 4812.278158276216, 4820.373351464357, 4839.879003024953, 4909.729964851896, 10345.844812327821, 10440.947795261127, 10457.058864702061, 10458.843117353246, 10491.055804977588, 5619.072852979212, 5621.775128994795, 5630.690312032878, 5634.661920284796, 5638.182463542763, 4692.601128904082, 4971.975140124348, 5068.341115654941, 5106.234064890222, 5184.714840683723, 4030.415589739471, 4083.9387409188885, 4169.749815011109, 4178.874633760992, 4195.916081678411, 1229.8032314829584, 1258.2639156093787, 1262.103906226571, 1262.3435813376993, 1265.3040827544814, 987.9604815807431, 1065.5737704918095, 1082.7996820588216, 1088.553692985872, 1094.2121672395863, 6378.947473666793, 6608.2730899601, 6663.233728121231, 6694.631795251308, 6712.93287067123, 489.24656029713844, 496.07729622901377, 499.96750211236156, 505.1967371878657, 508.95673867720916, 4644.489106198315, 4694.765261736899, 4715.905681886412, 4717.575418212377, 4758.1673207188605, 11695.707607309716, 12008.219465734699, 12092.576759813364, 12099.939500302618, 12120.393980300949, 11306.94346528262, 11810.291382517076, 11837.112216583619, 12174.452149653287, 12216.877831221751, 8714.30285577165, 8982.236509896602, 9031.78070960425, 9045.366824322235, 9056.36605437613, 6609.537332386687, 6813.2846051163915, 6822.590644561144, 6889.586624802528, 6948.166220053626, 10877.891221087688, 11055.668329950115, 11093.5562577496, 11130.944345278545, 11275.718107047061, 11023.393713345842, 11313.943430282796, 11343.149263805413, 11352.091832653534, 11376.146788990693, 7565.6973721050545, 8424.705135320479, 8485.575721214038, 8563.743087707378, 8735.388522803343, 9263.67577134824, 9424.434533927986, 9480.525973701426, 9488.288378371788, 9489.857652135086, 7944.126146123806, 8142.145074767301, 8202.671893124209, 8384.245417912418, 8427.410081294496, 7829.96085019594, 7851.772876508941, 8129.552874591955, 8164.7958801030445, 8238.711645092393, 7434.665440055102, 7671.731489397845, 7683.231676832495, 7906.960465197637, 7976.760697179094, 5427.891442171213, 5429.728513574384, 5464.043792336404, 5483.945160548344, 5632.493075623213, 5745.827625171251, 5781.306243250837, 5784.392638772868, 5830.912536312044, 5838.795642152674], "value": 4954.345937035208, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.4599631558188, 357.7799653213274, 360.6988164882323, 369.4919485707153, 370.0342107100466, 5646.717664116798, 5703.543716502681, 5932.28812542495, 5940.851478713034, 5987.4910632596175, 5659.462351076651, 5691.239748721867, 5729.0833466645345, 5729.226554415152, 5741.282339707536, 4443.422355093841, 4453.421055262827, 4470.307102399117, 4487.12501062293, 4508.165989291975, 4442.778610694652, 4498.50516443191, 4501.414816073922, 4515.841945531907, 4544.091181763644, 4403.977980110095, 4422.7788610569505, 4439.689221754463, 4446.266366049598, 4452.154090722753, 4479.372887795711, 4481.148581769454, 4482.260427029552, 4501.15452664406, 4509.278515437514, 3897.395903634941, 3961.385985172274, 3970.146418520032, 4011.7191796574252, 4015.859444919443, 5522.144067669517, 5535.335759708861, 5547.944520554784, 5549.472800083986, 5583.720813959286, 5118.129917913963, 5148.073346797575, 5176.715280659562, 5187.559057480081, 5221.642372983052, 5959.612625179349, 5996.4902983246475, 6045.486133678643, 6084.787032453887, 6086.786962456293, 4331.917020744814, 4361.454818147731, 4375.343698445226, 4381.3208952612395, 4426.933595996063, 6192.637619723653, 6328.778492752777, 6337.524685648548, 6343.9682801585695, 6354.904676429857, 4178.895527611834, 4412.382266482695, 4418.856854425601, 4420.248557745191, 4438.400815889813, 4436.112777444524, 4461.7730124216105, 4463.352813841975, 4479.238529450001, 4486.487566962512, 5097.668651537712, 5121.641485096082, 5122.231665250242, 5128.205128205134, 5129.7178655173575, 5907.645541267451, 5957.910631340534, 6036.939630603725, 6069.787557435557, 6078.969605151946, 1515.515035188729, 1529.9770503442458, 1548.612846788303, 1554.6579752454443, 1570.16781106014, 966.9951650241704, 977.1108291454742, 979.2264111351952, 1002.2583288366702, 1010.8129995950773, 5231.169090818259, 5257.185136303879, 5262.368515778055, 5313.388960269541, 5321.760520776575, 5500.532454741312, 5505.953868764922, 5544.867150060203, 5603.075492543766, 5606.55147588192, 4942.57988071018, 5211.270422140903, 5232.633715639869, 5306.230596563477, 5342.687533729113, 2972.573164880869, 2980.882169186555, 2998.670146283907, 3005.368872536748, 3018.818870867755, 5639.210510528529, 5740.761103169767, 5764.394738552475, 5765.509931655773, 5799.333076696234, 5952.553558483131, 6405.327440618761, 6436.774712885027, 6457.709403076873, 6469.191351081115, 6560.589473263271, 6572.539922205496, 6619.735210591619, 6630.569013014138, 6659.500537459709, 6070.2108725865355, 6335.239771227482, 6343.682815859096, 6348.333424990495, 6406.1031455597185, 6209.379062093935, 6216.658083805434, 6237.413487244761, 6245.625262484084, 6304.211973503312, 6381.968564931621, 6490.689748228343, 6507.251666058464, 6539.313372095861, 6550.8362290943105, 4379.715318504287, 4397.274449715761, 4420.381146639409, 4424.81854647368, 4430.269005614037, 6063.454289114001, 6072.939270607238, 6304.590201636879, 6319.715612797527, 6369.649669268049, 6037.366076561898, 6066.514678825595, 6127.20346354971, 6144.201253836973, 6154.507639388928, 5970.000049983304, 6132.025967405893, 6157.84605384869, 6164.719053950067, 6195.473384762166, 6019.608725432833, 6027.728752206249, 6037.154798328325, 6041.456268935817, 6041.577089603861, 6096.817095487142, 6119.724612392364, 6144.877102457836, 6151.446369826737, 6176.289726681489, 5833.270841144857, 5997.5306050018025, 6038.788642397495, 6041.734349618893, 6050.757969681164], "value": 4563.198658582229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.4959276470297, 805.8791181322805, 816.7917181118812, 836.5942517878832, 888.3115585421299, 15828.208589570504, 16030.43893463729, 16476.011439313635, 16655.66688666226, 17285.0493222873, 15968.840311596881, 16089.19554022297, 16207.594810129753, 16209.027458352508, 16237.350505979746, 875.3434923807145, 878.056089703568, 894.7584152278913, 902.1249388093539, 910.8406028944942, 903.1871315815786, 905.7192270396165, 908.3686837647838, 910.2990697163181, 910.8497097978826, 947.7204224753714, 951.0394501553411, 953.9332246742731, 956.6747305915987, 957.1290125985355, 940.0, 940.6895724410996, 940.8823897012874, 948.0, 948.0614191949988, 694.5554844899268, 696.0742212856889, 696.6760456387804, 697.7243988624516, 699.7655785311927, 16467.505974820775, 16507.752383714254, 16509.17454127301, 16537.83462165387, 16542.917285413496, 14841.406343746345, 14957.102573845605, 15358.462453814063, 16076.839231607652, 16548.338066477325, 12813.487460501568, 13075.542356017493, 13336.333183340794, 13471.12437691547, 13541.119827211298, 3983.780892050936, 4030.8387664493384, 4062.1875624874847, 4125.66994640428, 4138.337865941465, 79301.0, 81000.59499702464, 81474.59262703708, 82798.0, 83008.0, 12902.290374029331, 13155.802662960063, 13289.13620614657, 13348.93325533366, 13969.930150349182, 22754.772452275265, 25722.0, 26209.213723588324, 26250.737492625212, 26297.21108366752, 9866.260030497599, 9927.900720992842, 9929.156021738234, 9981.700548983543, 10053.949730251448, 5083.186690129635, 5199.636025478256, 5251.133562962068, 5271.367435907716, 5372.785088596413, 4098.52866920302, 4186.581341865789, 4247.49030116388, 4388.626966707801, 4588.105319462673, 771.4175797273135, 779.4154384211841, 780.55898417394, 801.8316153607691, 807.1524898856178, 599.7001499250375, 715.2561336210387, 759.1649185895582, 759.6619504320635, 789.6880732110784, 10004.649837255662, 10083.294169408218, 10175.185985121321, 10309.484525773682, 10458.215633827493, 580.6806256558875, 660.5541259649717, 740.0305599664457, 764.3961270596278, 771.9266669666373, 4627.398438203079, 4852.805887764521, 4856.441509226484, 4897.804087836446, 5020.2720605511995, 100527.49736251272, 127228.0, 130931.34534327267, 133074.33462832624, 133619.0, 82766.0, 83550.0, 85855.57072214599, 100715.0, 107632.0, 86764.0, 88013.55993220121, 88045.0, 88757.0, 89022.0, 9875.555599997873, 9901.752456188653, 10054.19566434698, 10198.490075496047, 10256.589736410759, 44878.3268250983, 45773.08453830971, 47814.760926195144, 47997.0, 55476.72261638666, 69429.30570694228, 72872.63563682148, 73262.26737732554, 74341.25658743344, 75312.0, 13717.382717777524, 13827.654308641962, 13955.162690238618, 14039.859601403856, 14143.292835358397, 14363.784543232068, 14576.781348279996, 14962.177080260255, 15607.375704971673, 15785.447509337118, 14312.713745725236, 14797.556073317388, 14980.1011939284, 14993.775093373826, 15732.29204685769, 14477.817525987664, 14483.131012139305, 14617.122972621677, 14651.267436628339, 14657.267136642911, 14534.200618966059, 14546.92726536403, 14651.194184319966, 14750.55748327552, 14883.851161488246, 11653.6503904883, 11715.707107322385, 11884.702882427662, 12077.27536347822, 12342.0, 11960.880391195977, 12347.75304493887, 12484.812727808909, 12524.937375313066, 12590.937045314715], "value": 8168.104565579913, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 110.0, 111.0, 110.0, 112.0, 111.0, 111.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 122.0, 159.0, 172.0, 128.0, 151.0, 160.0, 133.0, 187.0, 124.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 163.0, 162.0, 166.0, 162.0, 162.0, 166.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 75.0, 75.0, 168.0, 75.0, 75.0, 75.0, 76.0, 162.0, 78.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 148.0, 85.0, 84.0, 86.0, 144.0, 85.0, 84.0, 140.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 120.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 56.0, 53.0, 52.0, 51.0, 53.0, 51.0, 51.0, 52.0, 51.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 63.0, 60.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 79.0, 77.0, 79.0, 80.0, 80.0, 103.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 123.0, 120.0, 125.0, 118.0, 126.0, 125.0, 128.0, 121.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 162.0, 158.0, 161.0, 158.0, 157.0, 168.0, 160.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 64.0, 66.0, 63.0, 63.0, 70.0, 66.0], "value": 64.6, "unit": "score"}]}]} 06:46:01 INFO - Return code: 0 06:46:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:46:01 ERROR - # TBPL SUCCESS # 06:46:01 INFO - Running post-action listener: _resource_record_post_action 06:46:01 INFO - ##### 06:46:01 INFO - ##### Finished run-tests step (success) 06:46:01 INFO - ##### 06:46:01 INFO - Running post-run listener: _resource_record_post_run 06:46:01 INFO - Total resource usage - Wall time: 1214s; CPU: 14.0%; Read bytes: 10215424; Write bytes: 386244608; Read time: 3776; Write time: 2202252 06:46:01 INFO - TinderboxPrint: CPU usage
13.6% 06:46:01 INFO - TinderboxPrint: I/O read bytes / time
10,215,424 / 3,776 06:46:01 INFO - TinderboxPrint: I/O write bytes / time
386,244,608 / 2,202,252 06:46:01 INFO - TinderboxPrint: CPU idle
8,372.0 (86.4%) 06:46:01 INFO - TinderboxPrint: CPU user
1,214.7 (12.5%) 06:46:01 INFO - TinderboxPrint: Swap in / out
0 / 0 06:46:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8155136; Read time: 0; Write time: 2236 06:46:01 INFO - run-tests - Wall time: 1199s; CPU: 14.0%; Read bytes: 8454144; Write bytes: 378089472; Read time: 3640; Write time: 2200016 06:46:02 INFO - Running post-run listener: _upload_blobber_files 06:46:02 INFO - Blob upload gear active. 06:46:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:46:02 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 06:46:02 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:46:02 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:46:02 INFO - (blobuploader) - INFO - Open directory for files ... 06:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:06 INFO - (blobuploader) - INFO - Done attempting. 06:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:06 INFO - (blobuploader) - INFO - Done attempting. 06:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:07 INFO - (blobuploader) - INFO - Done attempting. 06:46:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:46:07 INFO - Return code: 0 06:46:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:46:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:46:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27aff19948c8bc6031da76c7f3279ad2d3fea35fc522d2693b0f86edb3ef50b388ac97a03f7bfb48326d48e5a0d3c492b27768d2459fa03181f3f40d6e8c453d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa1ca970a74f15da116bbbed34256484dcb0839f8245c3d85ae3024db78b35529de8826bff13d09ead4156e89403eb0e97060db126401ef7f459c7bd6ca1f19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/523edea3e52893ffb2eed98237ff436256ba1c0c3009765d25fdd6d76312fefdc9f2a2b75764b2b5a577cd8f8022558968b67e7339f29b0de57acc8c97724cd2"} 06:46:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:46:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:46:07 INFO - Contents: 06:46:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27aff19948c8bc6031da76c7f3279ad2d3fea35fc522d2693b0f86edb3ef50b388ac97a03f7bfb48326d48e5a0d3c492b27768d2459fa03181f3f40d6e8c453d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa1ca970a74f15da116bbbed34256484dcb0839f8245c3d85ae3024db78b35529de8826bff13d09ead4156e89403eb0e97060db126401ef7f459c7bd6ca1f19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/523edea3e52893ffb2eed98237ff436256ba1c0c3009765d25fdd6d76312fefdc9f2a2b75764b2b5a577cd8f8022558968b67e7339f29b0de57acc8c97724cd2"} 06:46:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:46:07 INFO - Copying logs to upload dir... 06:46:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:46:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.136989 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-06-27 06:46:07.477828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:46:07.481100) ========= 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=33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979 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-Aurora/sha512/27aff19948c8bc6031da76c7f3279ad2d3fea35fc522d2693b0f86edb3ef50b388ac97a03f7bfb48326d48e5a0d3c492b27768d2459fa03181f3f40d6e8c453d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa1ca970a74f15da116bbbed34256484dcb0839f8245c3d85ae3024db78b35529de8826bff13d09ead4156e89403eb0e97060db126401ef7f459c7bd6ca1f19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/523edea3e52893ffb2eed98237ff436256ba1c0c3009765d25fdd6d76312fefdc9f2a2b75764b2b5a577cd8f8022558968b67e7339f29b0de57acc8c97724cd2"} build_url:https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/DBiGjFYkRpWvoIGPxASbvA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27aff19948c8bc6031da76c7f3279ad2d3fea35fc522d2693b0f86edb3ef50b388ac97a03f7bfb48326d48e5a0d3c492b27768d2459fa03181f3f40d6e8c453d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa1ca970a74f15da116bbbed34256484dcb0839f8245c3d85ae3024db78b35529de8826bff13d09ead4156e89403eb0e97060db126401ef7f459c7bd6ca1f19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/523edea3e52893ffb2eed98237ff436256ba1c0c3009765d25fdd6d76312fefdc9f2a2b75764b2b5a577cd8f8022558968b67e7339f29b0de57acc8c97724cd2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 06:46:07.506793) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:46:07.507137) ========= 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=33d5923976266a1c518c4bf7000001ab-1467033878.919150-1190650979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:46:07.589893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:46:07.590210) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 06:46:07.590523) ========= ========= Total master_lag: 0.14 =========