builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1467195555.72 results: success (0) buildid: 20160629004019 builduid: eea8cfaad4194f0eb10a207cd6893c86 revision: c83de296c78d277a35e67cdc950162ee8e75bf39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:15.724301) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:15.724762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:15.725044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:15.742706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:15.743291) ========= 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=6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 03:19:15-- 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.3M=0s 2016-06-29 03:19:15 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102501 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.058000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.058370) ========= 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=6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018541 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.116329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.116788) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c83de296c78d277a35e67cdc950162ee8e75bf39 --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 c83de296c78d277a35e67cdc950162ee8e75bf39 --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=6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 03:19:16,278 truncating revision to first 12 chars 2016-06-29 03:19:16,278 Setting DEBUG logging. 2016-06-29 03:19:16,278 attempt 1/10 2016-06-29 03:19:16,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c83de296c78d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 03:19:16,627 unpacking tar archive at: mozilla-aurora-c83de296c78d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.833415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.833756) ========= script_repo_revision: c83de296c78d277a35e67cdc950162ee8e75bf39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.834159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.834447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 03:19:16.845011) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-29 03:19:16.845654) ========= /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=6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:19:17 INFO - MultiFileLogger online at 20160629 03:19:17 in /builds/slave/test 03:19:17 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 03:19:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:19:17 INFO - {'append_to_log': False, 03:19:17 INFO - 'base_work_dir': '/builds/slave/test', 03:19:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:19:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:19:17 INFO - 'branch': 'Mozilla-Aurora', 03:19:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:19:17 INFO - 'config_files': ('talos/linux_config.py',), 03:19:17 INFO - 'default_actions': ('clobber', 03:19:17 INFO - 'read-buildbot-config', 03:19:17 INFO - 'download-and-extract', 03:19:17 INFO - 'populate-webroot', 03:19:17 INFO - 'create-virtualenv', 03:19:17 INFO - 'install', 03:19:17 INFO - 'run-tests'), 03:19:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:19:17 INFO - 'download_minidump_stackwalk': True, 03:19:17 INFO - 'download_symbols': 'ondemand', 03:19:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:19:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:19:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:19:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:19:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:19:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:19:17 INFO - 'installer_path': 'installer.exe', 03:19:17 INFO - 'log_level': 'info', 03:19:17 INFO - 'log_name': 'talos', 03:19:17 INFO - 'log_to_console': True, 03:19:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:19:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:19:17 INFO - 'opt_config_files': (), 03:19:17 INFO - 'pip_index': False, 03:19:17 INFO - 'sps_profile': False, 03:19:17 INFO - 'sps_profile_interval': 0, 03:19:17 INFO - 'suite': 'dromaeojs-e10s', 03:19:17 INFO - 'system_bits': '32', 03:19:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:19:17 INFO - 'title': 'talos-linux64-ix-050', 03:19:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:19:17 INFO - 'use_talos_json': True, 03:19:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:19:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:19:17 INFO - 'work_dir': 'build'} 03:19:17 INFO - ##### 03:19:17 INFO - ##### Running clobber step. 03:19:17 INFO - ##### 03:19:17 INFO - Running pre-action listener: _resource_record_pre_action 03:19:17 INFO - Running main action method: clobber 03:19:17 INFO - rmtree: /builds/slave/test/build 03:19:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:19:18 INFO - Running post-action listener: _resource_record_post_action 03:19:18 INFO - ##### 03:19:18 INFO - ##### Finished clobber step (success) 03:19:18 INFO - ##### 03:19:18 INFO - ##### 03:19:18 INFO - ##### Running read-buildbot-config step. 03:19:18 INFO - ##### 03:19:18 INFO - Running pre-action listener: _resource_record_pre_action 03:19:18 INFO - Running main action method: read_buildbot_config 03:19:18 INFO - Using buildbot properties: 03:19:18 INFO - { 03:19:18 INFO - "project": "", 03:19:18 INFO - "product": "firefox", 03:19:18 INFO - "script_repo_revision": "production", 03:19:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:19:18 INFO - "repository": "", 03:19:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:19:18 INFO - "buildid": "20160629004019", 03:19:18 INFO - "stage_platform": "linux64-pgo", 03:19:18 INFO - "basedir": "/builds/slave/test", 03:19:18 INFO - "nightly_build": "True", 03:19:18 INFO - "buildnumber": 373, 03:19:18 INFO - "slavename": "talos-linux64-ix-050", 03:19:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:19:18 INFO - "platform": "ubuntu64_hw", 03:19:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:19:18 INFO - "branch": "mozilla-aurora", 03:19:18 INFO - "repo_path": "releases/mozilla-aurora", 03:19:18 INFO - "revision": "c83de296c78d277a35e67cdc950162ee8e75bf39", 03:19:18 INFO - "pgo_build": "True", 03:19:18 INFO - "builduid": "eea8cfaad4194f0eb10a207cd6893c86", 03:19:18 INFO - "slavebuilddir": "test" 03:19:18 INFO - } 03:19:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:19:18 INFO - Running post-action listener: _resource_record_post_action 03:19:18 INFO - ##### 03:19:18 INFO - ##### Finished read-buildbot-config step (success) 03:19:18 INFO - ##### 03:19:18 INFO - ##### 03:19:18 INFO - ##### Running download-and-extract step. 03:19:18 INFO - ##### 03:19:18 INFO - Running pre-action listener: _resource_record_pre_action 03:19:18 INFO - Running main action method: download_and_extract 03:19:18 INFO - mkdir: /builds/slave/test/build/tests 03:19:18 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')]} 03:19:18 INFO - https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:19 INFO - Downloaded 1361 bytes. 03:19:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:19:19 INFO - Using the following test package requirements: 03:19:19 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:19:19 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:19:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:19:19 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:19:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:19:19 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:19:19 INFO - u'jsshell-linux-x86_64.zip'], 03:19:19 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:19:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:19:19 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:19:19 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:19:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:19:19 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:19:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:19:19 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:19:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:19:19 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:19:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:19:19 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:19:19 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')]} 03:19:19 INFO - https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:19:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:19:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:19:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:23 INFO - Downloaded 24524276 bytes. 03:19:23 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'] 03:19:23 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 03:19:24 INFO - Return code: 0 03:19:24 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 03:19:24 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')]} 03:19:24 INFO - https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:19:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:19:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:19:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:26 INFO - Downloaded 24524276 bytes. 03:19:26 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'] 03:19:26 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 03:19:28 INFO - Return code: 0 03:19:28 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')]} 03:19:28 INFO - https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:19:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:19:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:19:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:28 INFO - Downloaded 10833369 bytes. 03:19:28 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'] 03:19:28 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 03:19:29 INFO - Return code: 0 03:19: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')]} 03:19:29 INFO - https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:19:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:19:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:19:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CbT8zo6aTEaf4HFrerIMYw/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 03:19:34 INFO - Downloaded 63619428 bytes. 03:19:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:19:34 INFO - mkdir: /builds/slave/test/properties 03:19:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:19:34 INFO - Writing to file /builds/slave/test/properties/build_url 03:19:34 INFO - Contents: 03:19:34 INFO - build_url:https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:19:35 INFO - Running post-action listener: _resource_record_post_action 03:19:35 INFO - Running post-action listener: set_extra_try_arguments 03:19:35 INFO - ##### 03:19:35 INFO - ##### Finished download-and-extract step (success) 03:19:35 INFO - ##### 03:19:35 INFO - ##### 03:19:35 INFO - ##### Running populate-webroot step. 03:19:35 INFO - ##### 03:19:35 INFO - Running pre-action listener: _resource_record_pre_action 03:19:35 INFO - Running main action method: populate_webroot 03:19:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:19:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:19:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:19:35 INFO - '--tppagecycles', 03:19:35 INFO - '7'], 03:19:35 INFO - 'tests': ['tsvgm']}}, 03:19:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:19:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:19:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:19:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:19:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:35 INFO - 'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:35 INFO - 'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['damp', 'tps']}, 03:19:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:35 INFO - 'tests': ['damp', 'tps']}, 03:19:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['dromaeo_dom']}, 03:19:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:19:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['a11yr', 03:19:35 INFO - 'ts_paint', 03:19:35 INFO - 'tpaint', 03:19:35 INFO - 'sessionrestore', 03:19:35 INFO - 'sessionrestore_no_auto_restore', 03:19:35 INFO - 'tabpaint']}, 03:19:35 INFO - 'other-e10s': {'tests': ['a11yr', 03:19:35 INFO - 'ts_paint', 03:19:35 INFO - 'tpaint', 03:19:35 INFO - 'sessionrestore', 03:19:35 INFO - 'sessionrestore_no_auto_restore', 03:19:35 INFO - 'tabpaint']}, 03:19:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:19:35 INFO - 'ts_paint', 03:19:35 INFO - 'tpaint', 03:19:35 INFO - 'sessionrestore', 03:19:35 INFO - 'sessionrestore_no_auto_restore', 03:19:35 INFO - 'tabpaint']}, 03:19:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:19:35 INFO - 'ts_paint', 03:19:35 INFO - 'tpaint', 03:19:35 INFO - 'sessionrestore', 03:19:35 INFO - 'sessionrestore_no_auto_restore', 03:19:35 INFO - 'tabpaint']}, 03:19:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['a11yr', 03:19:35 INFO - 'ts_paint', 03:19:35 INFO - 'tpaint', 03:19:35 INFO - 'sessionrestore', 03:19:35 INFO - 'sessionrestore_no_auto_restore', 03:19:35 INFO - 'tabpaint']}, 03:19:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['a11yr', 03:19:35 INFO - 'ts_paint', 03:19:35 INFO - 'tpaint', 03:19:35 INFO - 'sessionrestore', 03:19:35 INFO - 'sessionrestore_no_auto_restore', 03:19:35 INFO - 'tabpaint']}, 03:19:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['tsvgx', 03:19:35 INFO - 'tsvgr_opacity', 03:19:35 INFO - 'tart', 03:19:35 INFO - 'tscrollx', 03:19:35 INFO - 'cart']}, 03:19:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:19:35 INFO - 'tsvgr_opacity', 03:19:35 INFO - 'tart', 03:19:35 INFO - 'tscrollx', 03:19:35 INFO - 'cart']}, 03:19:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:35 INFO - 'talos_options': ['--disable-e10s'], 03:19:35 INFO - 'tests': ['tp5o']}, 03:19:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:35 INFO - 'tests': ['tp5o']}, 03:19:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:35 INFO - 'talos_options': ['--disable-e10s', 03:19:35 INFO - '--xperf_path', 03:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:35 INFO - 'tests': ['tp5n']}, 03:19:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:19:35 INFO - 'talos_options': ['--xperf_path', 03:19:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:35 INFO - 'tests': ['tp5n']}}, 03:19:35 INFO - 'talos.zip': {'path': '', 03:19:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:19:35 INFO - Running post-action listener: _resource_record_post_action 03:19:35 INFO - ##### 03:19:35 INFO - ##### Finished populate-webroot step (success) 03:19:35 INFO - ##### 03:19:35 INFO - ##### 03:19:35 INFO - ##### Running create-virtualenv step. 03:19:35 INFO - ##### 03:19:35 INFO - Running pre-action listener: _resource_record_pre_action 03:19:35 INFO - Running main action method: create_virtualenv 03:19:35 INFO - Creating virtualenv /builds/slave/test/build/venv 03:19:35 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 03:19:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:19:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:19:35 INFO - Using real prefix '/usr' 03:19:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:19:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:19:37 INFO - Installing pip.................done. 03:19:37 INFO - Return code: 0 03:19:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:37 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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:37 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 03:19:37 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 03:19:37 INFO - Using env: {'DISPLAY': ':0', 03:19:37 INFO - 'HOME': '/home/cltbld', 03:19:37 INFO - 'LANG': 'en_US.UTF-8', 03:19:37 INFO - 'LANGUAGE': 'en_US:en', 03:19:37 INFO - 'LOGNAME': 'cltbld', 03:19:37 INFO - 'MAIL': '/var/mail/cltbld', 03:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:37 INFO - 'MOZ_NO_REMOTE': '1', 03:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:37 INFO - 'NO_EM_RESTART': '1', 03:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:37 INFO - 'PWD': '/builds/slave/test', 03:19:37 INFO - 'SHELL': '/bin/bash', 03:19:37 INFO - 'SHLVL': '1', 03:19:37 INFO - 'TERM': 'linux', 03:19:37 INFO - 'TMOUT': '86400', 03:19:37 INFO - 'USER': 'cltbld', 03:19:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:37 INFO - '_': '/tools/buildbot/bin/python'} 03:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:38 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 03:19:38 INFO - Cleaning up... 03:19:38 INFO - Return code: 0 03:19:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:38 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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:38 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 03:19:38 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 03:19:38 INFO - Using env: {'DISPLAY': ':0', 03:19:38 INFO - 'HOME': '/home/cltbld', 03:19:38 INFO - 'LANG': 'en_US.UTF-8', 03:19:38 INFO - 'LANGUAGE': 'en_US:en', 03:19:38 INFO - 'LOGNAME': 'cltbld', 03:19:38 INFO - 'MAIL': '/var/mail/cltbld', 03:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:38 INFO - 'MOZ_NO_REMOTE': '1', 03:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:38 INFO - 'NO_EM_RESTART': '1', 03:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:38 INFO - 'PWD': '/builds/slave/test', 03:19:38 INFO - 'SHELL': '/bin/bash', 03:19:38 INFO - 'SHLVL': '1', 03:19:38 INFO - 'TERM': 'linux', 03:19:38 INFO - 'TMOUT': '86400', 03:19:38 INFO - 'USER': 'cltbld', 03:19:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:38 INFO - '_': '/tools/buildbot/bin/python'} 03:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:38 INFO - Downloading/unpacking psutil>=3.1.1 03:19:38 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 03:19:38 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 03:19:38 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 03:19:38 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 03:19:38 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 03:19:38 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 03:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:19:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:40 INFO - Installing collected packages: psutil 03:19:40 INFO - Running setup.py install for psutil 03:19:40 INFO - building 'psutil._psutil_linux' extension 03:19:40 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 03:19:40 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 03:19:40 INFO - building 'psutil._psutil_posix' extension 03:19:40 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 03:19:40 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 03:19:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:40 INFO - Successfully installed psutil 03:19:40 INFO - Cleaning up... 03:19:40 INFO - Return code: 0 03:19:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:19:40 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')]} 03:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:40 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')]} 03:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:40 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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:40 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 03:19:40 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 03:19:40 INFO - Using env: {'DISPLAY': ':0', 03:19:40 INFO - 'HOME': '/home/cltbld', 03:19:40 INFO - 'LANG': 'en_US.UTF-8', 03:19:40 INFO - 'LANGUAGE': 'en_US:en', 03:19:40 INFO - 'LOGNAME': 'cltbld', 03:19:40 INFO - 'MAIL': '/var/mail/cltbld', 03:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:40 INFO - 'MOZ_NO_REMOTE': '1', 03:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:40 INFO - 'NO_EM_RESTART': '1', 03:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:40 INFO - 'PWD': '/builds/slave/test', 03:19:40 INFO - 'SHELL': '/bin/bash', 03:19:40 INFO - 'SHLVL': '1', 03:19:40 INFO - 'TERM': 'linux', 03:19:40 INFO - 'TMOUT': '86400', 03:19:40 INFO - 'USER': 'cltbld', 03:19:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:40 INFO - '_': '/tools/buildbot/bin/python'} 03:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:41 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 03:19:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:19:43 INFO - Installing collected packages: mozsystemmonitor 03:19:43 INFO - Running setup.py install for mozsystemmonitor 03:19:43 INFO - Successfully installed mozsystemmonitor 03:19:43 INFO - Cleaning up... 03:19:43 INFO - Return code: 0 03:19:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19: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==2.5.1'] in /builds/slave/test/build 03:19: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==2.5.1 03:19:43 INFO - Using env: {'DISPLAY': ':0', 03:19:43 INFO - 'HOME': '/home/cltbld', 03:19:43 INFO - 'LANG': 'en_US.UTF-8', 03:19:43 INFO - 'LANGUAGE': 'en_US:en', 03:19:43 INFO - 'LOGNAME': 'cltbld', 03:19:43 INFO - 'MAIL': '/var/mail/cltbld', 03:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:43 INFO - 'MOZ_NO_REMOTE': '1', 03:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:43 INFO - 'NO_EM_RESTART': '1', 03:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:43 INFO - 'PWD': '/builds/slave/test', 03:19:43 INFO - 'SHELL': '/bin/bash', 03:19:43 INFO - 'SHLVL': '1', 03:19:43 INFO - 'TERM': 'linux', 03:19:43 INFO - 'TMOUT': '86400', 03:19:43 INFO - 'USER': 'cltbld', 03:19:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:43 INFO - '_': '/tools/buildbot/bin/python'} 03:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:43 INFO - Downloading/unpacking jsonschema==2.5.1 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:19:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19:45 INFO - Downloading functools32-3.2.3-2.tar.gz 03:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:19:45 INFO - warning: no files found matching '*.txt' 03:19:45 INFO - no previously-included directories found matching 'build' 03:19:45 INFO - no previously-included directories found matching 'dist' 03:19:45 INFO - no previously-included directories found matching '.git*' 03:19:45 INFO - Installing collected packages: jsonschema, functools32 03:19:45 INFO - Running setup.py install for functools32 03:19:45 INFO - warning: no files found matching '*.txt' 03:19:45 INFO - no previously-included directories found matching 'build' 03:19:45 INFO - no previously-included directories found matching 'dist' 03:19:45 INFO - no previously-included directories found matching '.git*' 03:19:45 INFO - Successfully installed jsonschema functools32 03:19:45 INFO - Cleaning up... 03:19:45 INFO - Return code: 0 03:19:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:19:45 INFO - Using env: {'DISPLAY': ':0', 03:19:45 INFO - 'HOME': '/home/cltbld', 03:19:45 INFO - 'LANG': 'en_US.UTF-8', 03:19:45 INFO - 'LANGUAGE': 'en_US:en', 03:19:45 INFO - 'LOGNAME': 'cltbld', 03:19:45 INFO - 'MAIL': '/var/mail/cltbld', 03:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:45 INFO - 'MOZ_NO_REMOTE': '1', 03:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:45 INFO - 'NO_EM_RESTART': '1', 03:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:45 INFO - 'PWD': '/builds/slave/test', 03:19:45 INFO - 'SHELL': '/bin/bash', 03:19:45 INFO - 'SHLVL': '1', 03:19:45 INFO - 'TERM': 'linux', 03:19:45 INFO - 'TMOUT': '86400', 03:19:45 INFO - 'USER': 'cltbld', 03:19:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:45 INFO - '_': '/tools/buildbot/bin/python'} 03:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19: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 03:19:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:19:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:19:47 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 03:19:47 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 03:19:47 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 03:19:47 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 03:19:47 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 03:19:47 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 03:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:19:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:19:48 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 03:19:48 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 03:19:48 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 03:19:48 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 03:19:48 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 03:19:48 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 03:19:48 INFO - Downloading docopt-0.6.1.tar.gz 03:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:48 INFO - Running setup.py install for blobuploader 03:19:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:19:48 INFO - Running setup.py install for requests 03:19:49 INFO - Running setup.py install for docopt 03:19:49 INFO - Successfully installed blobuploader requests docopt 03:19:49 INFO - Cleaning up... 03:19:49 INFO - Return code: 0 03:19:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:49 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')]} 03:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:49 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')]} 03:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:49 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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:49 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 03:19:49 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 03:19:49 INFO - Using env: {'DISPLAY': ':0', 03:19:49 INFO - 'HOME': '/home/cltbld', 03:19:49 INFO - 'LANG': 'en_US.UTF-8', 03:19:49 INFO - 'LANGUAGE': 'en_US:en', 03:19:49 INFO - 'LOGNAME': 'cltbld', 03:19:49 INFO - 'MAIL': '/var/mail/cltbld', 03:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:49 INFO - 'MOZ_NO_REMOTE': '1', 03:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:49 INFO - 'NO_EM_RESTART': '1', 03:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:49 INFO - 'PWD': '/builds/slave/test', 03:19:49 INFO - 'SHELL': '/bin/bash', 03:19:49 INFO - 'SHLVL': '1', 03:19:49 INFO - 'TERM': 'linux', 03:19:49 INFO - 'TMOUT': '86400', 03:19:49 INFO - 'USER': 'cltbld', 03:19:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:49 INFO - '_': '/tools/buildbot/bin/python'} 03:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:49 INFO - Running setup.py (path:/tmp/pip-3VWgyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:49 INFO - Running setup.py (path:/tmp/pip-SeGjfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:49 INFO - Running setup.py (path:/tmp/pip-zRNLng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:49 INFO - Running setup.py (path:/tmp/pip-SipzBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:49 INFO - Running setup.py (path:/tmp/pip-UuJJNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:49 INFO - Running setup.py (path:/tmp/pip-Qi_ANA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:49 INFO - Running setup.py (path:/tmp/pip-OU6Wlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:49 INFO - Running setup.py (path:/tmp/pip-Nm4QCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:49 INFO - Running setup.py (path:/tmp/pip-PxB3Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:50 INFO - Running setup.py (path:/tmp/pip-vKdGla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:50 INFO - Running setup.py (path:/tmp/pip-pyGCKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:50 INFO - Running setup.py (path:/tmp/pip-f034Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:50 INFO - Running setup.py (path:/tmp/pip-1EkkwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:50 INFO - Running setup.py (path:/tmp/pip-q3z35g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:50 INFO - Running setup.py (path:/tmp/pip-Ky1VgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:50 INFO - Running setup.py (path:/tmp/pip-eTFaPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:50 INFO - Running setup.py (path:/tmp/pip-Tjt2pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:50 INFO - Running setup.py install for manifestparser 03:19:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:19:50 INFO - Running setup.py install for mozcrash 03:19:50 INFO - Running setup.py install for mozdebug 03:19:50 INFO - Running setup.py install for mozdevice 03:19:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Running setup.py install for mozfile 03:19:51 INFO - Running setup.py install for mozhttpd 03:19:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Running setup.py install for mozinfo 03:19:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Running setup.py install for mozInstall 03:19:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Running setup.py install for mozleak 03:19:51 INFO - Running setup.py install for mozlog 03:19:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Running setup.py install for moznetwork 03:19:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:51 INFO - Running setup.py install for mozprocess 03:19:51 INFO - Running setup.py install for mozprofile 03:19:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:52 INFO - Running setup.py install for mozrunner 03:19:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:52 INFO - Running setup.py install for mozscreenshot 03:19:52 INFO - Running setup.py install for moztest 03:19:52 INFO - Running setup.py install for mozversion 03:19:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:52 INFO - Cleaning up... 03:19:52 INFO - Return code: 0 03:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:52 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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:52 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 03:19:52 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 03:19:52 INFO - Using env: {'DISPLAY': ':0', 03:19:52 INFO - 'HOME': '/home/cltbld', 03:19:52 INFO - 'LANG': 'en_US.UTF-8', 03:19:52 INFO - 'LANGUAGE': 'en_US:en', 03:19:52 INFO - 'LOGNAME': 'cltbld', 03:19:52 INFO - 'MAIL': '/var/mail/cltbld', 03:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:52 INFO - 'MOZ_NO_REMOTE': '1', 03:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:52 INFO - 'NO_EM_RESTART': '1', 03:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:52 INFO - 'PWD': '/builds/slave/test', 03:19:52 INFO - 'SHELL': '/bin/bash', 03:19:52 INFO - 'SHLVL': '1', 03:19:52 INFO - 'TERM': 'linux', 03:19:52 INFO - 'TMOUT': '86400', 03:19:52 INFO - 'USER': 'cltbld', 03:19:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:52 INFO - '_': '/tools/buildbot/bin/python'} 03:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:52 INFO - Running setup.py (path:/tmp/pip-8dkNMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:52 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)) 03:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:52 INFO - Running setup.py (path:/tmp/pip-6M8JBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:52 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)) 03:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:52 INFO - Running setup.py (path:/tmp/pip-3RNijN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:52 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)) 03:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:52 INFO - Running setup.py (path:/tmp/pip-h7agSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:52 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)) 03:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:52 INFO - Running setup.py (path:/tmp/pip-uCO0nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:53 INFO - Running setup.py (path:/tmp/pip-IS0KoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:53 INFO - Running setup.py (path:/tmp/pip-n5F5of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:53 INFO - Running setup.py (path:/tmp/pip-xYUWFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:53 INFO - Running setup.py (path:/tmp/pip-xE_L_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:53 INFO - Running setup.py (path:/tmp/pip-Mj1V0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:53 INFO - Running setup.py (path:/tmp/pip-GEH8OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:53 INFO - Running setup.py (path:/tmp/pip-cnB3W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:53 INFO - Running setup.py (path:/tmp/pip-wstPXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:53 INFO - Running setup.py (path:/tmp/pip-fhP4b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:53 INFO - Running setup.py (path:/tmp/pip-tWd9kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:53 INFO - Running setup.py (path:/tmp/pip-aR782P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:53 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)) 03:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:53 INFO - Running setup.py (path:/tmp/pip-tFdGQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:53 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)) 03:19:53 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)) 03:19:53 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)) 03:19:53 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)) 03:19:53 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)) 03:19:53 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)) 03:19:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:53 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 03:19:53 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 03:19:53 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 03:19:53 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 03:19:53 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 03:19:53 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 03:19:55 INFO - Downloading blessings-1.6.tar.gz 03:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:55 INFO - Installing collected packages: blessings 03:19:55 INFO - Running setup.py install for blessings 03:19:56 INFO - Successfully installed blessings 03:19:56 INFO - Cleaning up... 03:19:56 INFO - Return code: 0 03:19:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:56 INFO - Reading from file tmpfile_stdout 03:19:56 INFO - Current package versions: 03:19:56 INFO - argparse == 1.2.1 03:19:56 INFO - blessings == 1.6 03:19:56 INFO - blobuploader == 1.2.4 03:19:56 INFO - docopt == 0.6.1 03:19:56 INFO - functools32 == 3.2.3-2 03:19:56 INFO - jsonschema == 2.5.1 03:19:56 INFO - manifestparser == 1.1 03:19:56 INFO - mozInstall == 1.12 03:19:56 INFO - mozcrash == 0.17 03:19:56 INFO - mozdebug == 0.1 03:19:56 INFO - mozdevice == 0.48 03:19:56 INFO - mozfile == 1.2 03:19:56 INFO - mozhttpd == 0.7 03:19:56 INFO - mozinfo == 0.9 03:19:56 INFO - mozleak == 0.1 03:19:56 INFO - mozlog == 3.2 03:19:56 INFO - moznetwork == 0.27 03:19:56 INFO - mozprocess == 0.22 03:19:56 INFO - mozprofile == 0.28 03:19:56 INFO - mozrunner == 6.11 03:19:56 INFO - mozscreenshot == 0.1 03:19:56 INFO - mozsystemmonitor == 0.3 03:19:56 INFO - moztest == 0.7 03:19:56 INFO - mozversion == 1.4 03:19:56 INFO - psutil == 3.1.1 03:19:56 INFO - requests == 1.2.3 03:19:56 INFO - wsgiref == 0.1.2 03:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:56 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')]} 03:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:56 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')]} 03:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:56 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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:56 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 03:19:56 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 03:19:56 INFO - Using env: {'DISPLAY': ':0', 03:19:56 INFO - 'HOME': '/home/cltbld', 03:19:56 INFO - 'LANG': 'en_US.UTF-8', 03:19:56 INFO - 'LANGUAGE': 'en_US:en', 03:19:56 INFO - 'LOGNAME': 'cltbld', 03:19:56 INFO - 'MAIL': '/var/mail/cltbld', 03:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:56 INFO - 'MOZ_NO_REMOTE': '1', 03:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:56 INFO - 'NO_EM_RESTART': '1', 03:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:56 INFO - 'PWD': '/builds/slave/test', 03:19:56 INFO - 'SHELL': '/bin/bash', 03:19:56 INFO - 'SHLVL': '1', 03:19:56 INFO - 'TERM': 'linux', 03:19:56 INFO - 'TMOUT': '86400', 03:19:56 INFO - 'USER': 'cltbld', 03:19:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:56 INFO - '_': '/tools/buildbot/bin/python'} 03:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 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)) 03:19:56 INFO - Cleaning up... 03:19:56 INFO - Return code: 0 03:19:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:56 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')]} 03:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:56 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')]} 03:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:56 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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:56 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 03:19:56 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 03:19:56 INFO - Using env: {'DISPLAY': ':0', 03:19:56 INFO - 'HOME': '/home/cltbld', 03:19:56 INFO - 'LANG': 'en_US.UTF-8', 03:19:56 INFO - 'LANGUAGE': 'en_US:en', 03:19:56 INFO - 'LOGNAME': 'cltbld', 03:19:56 INFO - 'MAIL': '/var/mail/cltbld', 03:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:56 INFO - 'MOZ_NO_REMOTE': '1', 03:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:56 INFO - 'NO_EM_RESTART': '1', 03:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:56 INFO - 'PWD': '/builds/slave/test', 03:19:56 INFO - 'SHELL': '/bin/bash', 03:19:56 INFO - 'SHLVL': '1', 03:19:56 INFO - 'TERM': 'linux', 03:19:56 INFO - 'TMOUT': '86400', 03:19:56 INFO - 'USER': 'cltbld', 03:19:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:56 INFO - '_': '/tools/buildbot/bin/python'} 03:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:56 INFO - Cleaning up... 03:19:56 INFO - Return code: 0 03:19:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:19:56 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')]} 03:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:56 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')]} 03:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:56 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 0x7f9ab429af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', '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 03:19:56 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 03:19:56 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 03:19:56 INFO - Using env: {'DISPLAY': ':0', 03:19:56 INFO - 'HOME': '/home/cltbld', 03:19:56 INFO - 'LANG': 'en_US.UTF-8', 03:19:56 INFO - 'LANGUAGE': 'en_US:en', 03:19:56 INFO - 'LOGNAME': 'cltbld', 03:19:56 INFO - 'MAIL': '/var/mail/cltbld', 03:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:56 INFO - 'MOZ_NO_REMOTE': '1', 03:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:56 INFO - 'NO_EM_RESTART': '1', 03:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:56 INFO - 'PWD': '/builds/slave/test', 03:19:56 INFO - 'SHELL': '/bin/bash', 03:19:56 INFO - 'SHLVL': '1', 03:19:56 INFO - 'TERM': 'linux', 03:19:56 INFO - 'TMOUT': '86400', 03:19:56 INFO - 'USER': 'cltbld', 03:19:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:56 INFO - '_': '/tools/buildbot/bin/python'} 03:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:57 INFO - Downloading/unpacking flake8 03:19:57 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 03:19:57 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 03:19:57 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 03:19:57 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 03:19:57 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 03:19:57 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 03:19:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:19:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:19:58 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 03:19:58 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 03:19:58 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 03:19:58 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 03:19:58 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 03:19:58 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 03:19:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:19:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:19:59 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 03:19:59 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 03:19:59 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 03:19:59 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 03:19:59 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 03:19:59 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 03:19:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:19:59 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 03:19:59 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 03:19:59 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 03:19:59 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 03:19:59 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 03:19:59 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 03:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:19:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:59 INFO - no previously-included directories found matching 'docs/_build' 03:19:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:19:59 INFO - Running setup.py install for pep8 03:19:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:19:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:19:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:19:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:19:59 INFO - no previously-included directories found matching 'docs/_build' 03:19:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:19:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:19:59 INFO - Cleaning up... 03:19:59 INFO - Return code: 0 03:19:59 INFO - Running post-action listener: _resource_record_post_action 03:19:59 INFO - Running post-action listener: _start_resource_monitoring 03:19:59 INFO - Starting resource monitoring. 03:19:59 INFO - ##### 03:19:59 INFO - ##### Finished create-virtualenv step (success) 03:19:59 INFO - ##### 03:19:59 INFO - ##### 03:19:59 INFO - ##### Running install step. 03:19:59 INFO - ##### 03:19:59 INFO - Running pre-action listener: _resource_record_pre_action 03:19:59 INFO - Running main action method: install 03:19:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:00 INFO - Reading from file tmpfile_stdout 03:20:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:00 INFO - Reading from file tmpfile_stdout 03:20:00 INFO - Output received: 03:20:00 INFO - Usage: mozinstall [options] installer 03:20:00 INFO - Options: 03:20:00 INFO - -h, --help show this help message and exit 03:20:00 INFO - -d DEST, --destination=DEST 03:20:00 INFO - Directory to install application into. [default: 03:20:00 INFO - "/builds/slave/test"] 03:20:00 INFO - --app=APP Application being installed. [default: firefox] 03:20:00 INFO - mkdir: /builds/slave/test/build/application 03:20:00 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'] 03:20:00 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 03:20:16 INFO - Reading from file tmpfile_stdout 03:20:16 INFO - Output received: 03:20:16 INFO - /builds/slave/test/build/application/firefox/firefox 03:20:16 INFO - Running post-action listener: _resource_record_post_action 03:20:16 INFO - ##### 03:20:16 INFO - ##### Finished install step (success) 03:20:16 INFO - ##### 03:20:16 INFO - ##### 03:20:16 INFO - ##### Running run-tests step. 03:20:16 INFO - ##### 03:20:16 INFO - Running pre-action listener: _resource_record_pre_action 03:20:16 INFO - Running main action method: run_tests 03:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:20:16 INFO - Python 2.7.3 03:20:16 INFO - Return code: 0 03:20:16 INFO - grabbing minidump binary from tooltool 03:20:16 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')]} 03:20:16 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 0x124e2e0>, '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 0x11ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ba5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:20:16 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 03:20:16 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 03:20:16 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 03:20:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:20:16 INFO - Return code: 0 03:20:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:20:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:20:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:20:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:20:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:20:17 INFO - Return code: 0 03:20:17 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/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:20:17 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/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 03:20:17 INFO - Using env: {'DISPLAY': ':0', 03:20:17 INFO - 'HOME': '/home/cltbld', 03:20:17 INFO - 'LANG': 'en_US.UTF-8', 03:20:17 INFO - 'LANGUAGE': 'en_US:en', 03:20:17 INFO - 'LOGNAME': 'cltbld', 03:20:17 INFO - 'MAIL': '/var/mail/cltbld', 03:20:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:20:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:17 INFO - 'MOZ_NO_REMOTE': '1', 03:20:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:17 INFO - 'NO_EM_RESTART': '1', 03:20:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:17 INFO - 'PWD': '/builds/slave/test', 03:20:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:20:17 INFO - 'SHELL': '/bin/bash', 03:20:17 INFO - 'SHLVL': '1', 03:20:17 INFO - 'TERM': 'linux', 03:20:17 INFO - 'TMOUT': '86400', 03:20:17 INFO - 'USER': 'cltbld', 03:20:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683', 03:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:17 INFO - '_': '/tools/buildbot/bin/python'} 03:20:17 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/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:20:17 INFO - mozversion application_buildid: 20160629004019 03:20:17 INFO - mozversion application_changeset: c83de296c78d277a35e67cdc950162ee8e75bf39 03:20:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:20:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:20:17 INFO - mozversion application_name: Firefox 03:20:17 INFO - mozversion application_remotingname: firefox-dev 03:20:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:20:17 INFO - mozversion application_vendor: Mozilla 03:20:17 INFO - mozversion application_version: 49.0a2 03:20:17 INFO - mozversion platform_buildid: 20160629004019 03:20:17 INFO - mozversion platform_changeset: c83de296c78d277a35e67cdc950162ee8e75bf39 03:20:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:20:17 INFO - mozversion platform_version: 49.0a2 03:20:17 INFO - using testdate: 1467195617 03:20:17 INFO - actual date: 1467195617 03:20:17 INFO - starting webserver on 'localhost:51822' 03:20:17 INFO - SUITE-START | Running 2 tests 03:20:17 INFO - TEST-START | dromaeo_css 03:20:17 INFO - operating with platform_type : linux_ 03:20:17 INFO - Initialising browser for dromaeo_css test... 03:20:17 INFO - TEST-INFO | started process 25139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf74YvE/profile http://localhost:51822/getInfo.html) 03:20:21 INFO - PROCESS | 25139 | __metrics Screen width/height:1600/1200 03:20:21 INFO - PROCESS | 25139 | colorDepth:24 03:20:21 INFO - PROCESS | 25139 | Browser inner width/height: 1024/697 03:20:21 INFO - PROCESS | 25139 | __metrics 03:20:22 ERROR - PROCESS | 25139 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:20:23 INFO - TEST-INFO | 25139: exit 0 03:20:23 INFO - Browser initialized. 03:20:23 INFO - Running cycle 1/1 for dromaeo_css test... 03:20:23 INFO - TEST-INFO | started process 25267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf74YvE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:35 INFO - PROCESS | 25267 | RSS: Main: 156192768 03:20:35 INFO - PROCESS | 25267 | 03:21:24 INFO - PROCESS | 25267 | 1467195684638 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] 03:23:33 INFO - PROCESS | 25267 | Cycle 1(1): loaded http://localhost:51822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51822/tests/dromaeo/cssquery-ext.html) 03:23:34 INFO - PROCESS | 25267 | RSS: Main: 159354880 03:23:34 INFO - PROCESS | 25267 | 03:26:36 INFO - PROCESS | 25267 | Cycle 1(1): loaded http://localhost:51822/tests/dromaeo/cssquery-ext.html (next: http://localhost:51822/tests/dromaeo/cssquery-jquery.html) 03:26:36 INFO - PROCESS | 25267 | RSS: Main: 158064640 03:26:36 INFO - PROCESS | 25267 | 03:29:38 INFO - PROCESS | 25267 | Cycle 1(1): loaded http://localhost:51822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51822/tests/dromaeo/cssquery-mootools.html) 03:29:39 INFO - PROCESS | 25267 | RSS: Main: 157106176 03:29:39 INFO - PROCESS | 25267 | 03:32:40 INFO - PROCESS | 25267 | Cycle 1(1): loaded http://localhost:51822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51822/tests/dromaeo/cssquery-prototype.html) 03:32:41 INFO - PROCESS | 25267 | RSS: Main: 157130752 03:32:41 INFO - PROCESS | 25267 | 03:35:43 INFO - PROCESS | 25267 | Cycle 1(1): loaded http://localhost:51822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51822/tests/dromaeo/cssquery-yui.html) 03:35:44 INFO - PROCESS | 25267 | RSS: Main: 159223808 03:35:44 INFO - PROCESS | 25267 | 03:38:46 INFO - PROCESS | 25267 | Cycle 1(1): loaded http://localhost:51822/tests/dromaeo/cssquery-yui.html (next: http://localhost:51822/tests/dromaeo/cssquery-dojo.html) 03:38:47 INFO - PROCESS | 25267 | RSS: Main: 159342592 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - PROCESS | 25267 | __start_tp_report 03:38:47 INFO - PROCESS | 25267 | _x_x_mozilla_page_load 03:38:47 INFO - PROCESS | 25267 | _x_x_mozilla_page_load_details 03:38:47 INFO - PROCESS | 25267 | |i|pagename|runs| 03:38:47 INFO - PROCESS | 25267 | |0;dojo.html;3466.7226621870245;3468.965310346896;3476.0614634048798;3486.1284678830293;3496.1958749487617;5827.155062515938;5866.911996320058;5892.734826932793;5973.223480947481;6006.699665016743;5987.640741555499;5990;5998.8800223995495;6018.578699491038;6043.8186854394435;5404.432534583881;5428.511433970942;5492.066348720727;5493.066178749622;5552.305961754781;5328.786848526054;5335.386430560497;5376.274202982587;5518.641288316247;5519.503244707976;5362.383325917511;5408.621396502246;5460.180972854084;5491.341039075297;5514.80698175564;5481.260029895972;5544.695041772701;5556.749946252428;5560.888782224333;5571.721413929287;5259.105951988171;5424.484673955968;5455.727213639302;5515.558755299607;5540.030494663458;5690.886182276331;5765.596408251424;5794.391588883149;5841.094630332305;5844.240248767633;6414.679266036679;6419.229692436891;6441.323661015573;6455.644939528324;6461.289258181596;6199.163112979735;6200.224971878515;6474.125992990933;6477.481801455872;6495.512836537278;5868.325142608569;5993.310769261547;6005.489533389711;6006.879862402728;6052.878942421127;6443.903341449882;6584.604923704593;6599.47204223661;6600.966995165089;6614.371634694697;6068.696565171724;6206;6241.594296370721;6276.497880169575;6313.621182728959;6431.5819471734185;6451.387118223761;6471.870562588721;6473.449756770728;6491.902621460682;6345.49236061114;6393.552451328363;6397.232332120082;6412.743490260431;6418.807435776934;6056.727447264883;6233;6315.684215789284;6356.078368636522;6383.329750376237;4818.542238487338;4833.564979151823;4833.73414462208;4840.782164802592;4857.101436234238;4274.380214868826;4301.935470967938;4303.935440968388;4308.353746937984;4341.175176716414;5900.20347253124;5939.643621382731;6080.695965201722;6122.428649698624;6132.386761323832;6339.524535659844;6375.362463753588;6400.871982560323;6401.775937842246;6415.711292991827;6150.815475535741;6188.44304012641;6201.782937597252;6210.50315974721;6219.595726277777;5186.92219616706;5250.133727934848;5277.445868183862;5325.334333208349;5329.680219186861;6716.093327400836;6724.361185687352;6748.358905903931;6748.83127921796;6762.459003279726;6461.773837915651;6474.255460622088;6480.12518310041;6494.805155845333;6496.967515162394;6267.843303917439;6583.341665833378;6629.966850165912;6649.335066493312;6700.731970721116;6411.102445657519;6414.294427612866;6420.133282006869;6422.550421470452;6428.389303016206;6131.417515336036;6495.870082598227;6543.1821022372205;6568.8357791055605;6571.080048793268;6176.4441200292185;6184.319724830175;6198;6353.714082866374;6357.14178585885;6311.558190926775;6325.177726895474;6333.145025421509;6342.619442833445;6343.460805831556;5842.532597392284;6013.579049466495;6125.203723515914;6174.289956655042;6191.783287584913;6201.0388389799655;6301.306856245901;6346.904796427965;6365.649889256136;6381;6147.231596050494;6192.969035154795;6194.318624951342;6200.410960958701;6208.068789681584 03:38:47 INFO - PROCESS | 25267 | |1;ext.html;590.8522869282676;641.2337256977911;648.1897627965044;657.4050484311699;659.9208095028596;45199;46790.76604616977;46793.7660311698;46971;49749.25376119361;47946.52053479464;48144.75927620357;48187.759061204735;48297;48601.75699121508;9044.547772611377;9165.129312715282;9192.310576706774;9203.263738900872;9210.953945230265;8987.955060224689;9099.636014559443;9119.954400227989;9125.954370228139;9155.176034156924;9185.081491850828;9195.586198621044;9196.494192819393;9207.907920920772;9209.861852072225;9030.503322317238;9047.909520904805;9050.230730387892;9082.500462474562;9125.041870603558;8967.820643587092;9052.094790520896;9059.229965452878;9061.592228349675;9082.727518174466;44784.10431791346;45018.9741461635;45028.774856125834;45039.774801126114;45100;3871.690264778811;3893.7079719020903;3990.8004599769897;4032.6169013943627;4171.249175148472;33845.49231761526;33867.661323386696;34104.82947585271;34214.6578534214;34480.310393792235;4532.818687252506;4534.161180181677;4629.537046295377;4651.7441540715245;4719.976400117977;243970;244076;245203;245681;245987;36760.26479470396;62382.688086559276;62432.375676243566;62466;62795;38267;40705.59294407018;40833.79583102065;40896.38655420171;40917.590824091974;14941.477048303257;15109.924450377897;15156.090634561962;15221.923890380698;15228;11651.766964660828;11728;11735.706607334885;11739.530418783153;11762.94118529402;9175.08249175077;9218.769530761785;9230.400023998553;9243.075692430837;9275.443473391619;3493.074335301147;3494.5631796025496;3505.544279243682;3578.1233597768714;3579.3915034443685;988.7824678570703;1031.9380837149795;1139.9658010259704;1141.6746227325339;1172.0447835014436;31838;31920.840395797873;31994.520082198786;32383.838080809444;32533.83733081367;1115.544214799678;1121.1255220927526;1176.611718133014;1193.3317342288346;1279.584135156078;16993.150342482826;17178.484645460405;17799.377021804175;17979.280828766703;18188.134634281894;632008;635840;638574;640364;641477;64741.35258647447;65389;65422.67288663622;65616.67191664012;65740.67129664321;1432.3411230833724;1434.426229508205;1444.6171764482422;1446.0600609603632;1456.8543145685346;33129.66870331266;33825.661743383236;34148.487772683926;34230.48654270138;34439.483407748405;54983.72508137434;55936.44063559312;55939.16091258553;55965.44034559602;56248;551277;551748;552037;553871;557210;28790.712092878803;28843.855780721802;28916.85541572363;29181.854090729412;29345.85327073351;50865.491345087554;50914.74542627263;51010;51186;52209.738951305;43340.56659433365;43373.78313108414;43446.78276608597;43638.78180609077;43776.56223437725;40535.59464405436;43622.781886090364;44068.33897491476;44153;44964.1007179848;40001.1999760009;43046.78476607597;44716;44829;46692;38845.6115438842;39009.024774380865;39071;40042.599574003885;40116.79941600273;29807.10578682643;30385.696143038287;30493.54259686062;30712.539311910787;30829.69170308268 03:38:47 INFO - PROCESS | 25267 | |2;jquery.html;426.10943128860686;429.55111908056085;433.4192182475482;433.5036383341077;439.27081045464536;19084.618307633857;20267.49331266719;20802.89598552007;21593.352199434004;21644.2424515142;19616.117274722637;19636.21455141796;19970;20241.59516809663;20242.493937651565;5740.913886291709;5976.223090998186;5999.460048595625;6004.639721616695;6043.516518678517;5921.082232254007;5959.463648271655;5969.194158788551;6005.4895333896675;6016.789412370568;5743.885122297552;5907.793227237047;5909.172715819789;5934.1692163097205;5946.405359464062;5803.796867109673;5844.064949608063;5921.851953701171;5964.701764911781;5968.343482216953;5315.867103322448;5336.893262134774;5385.865353366158;5392.757325920343;5395.973020134914;23719.288421347388;23773.049078036856;23889;24065;24230.2730918071;2632.7762140218106;2639.326971622243;2726.386563023304;2962.9851850740824;3302.53764472974;14513.854861451462;14980.850191498055;15084.924575377163;15111.168885711282;15676;2041.5712700332947;2068.2761033638258;2094.5915546468445;2130.7975742304457;2153.9461513462134;82652;83471;83718;83888;85125;9781.510924453749;10348.22388320879;10496.790064198673;10837.241393102564;11000.779984400428;14303.78544321836;14430.42278308856;14542.563723088113;14553.417863285349;14575.562733118024;7622.504537205064;7704.152543220242;7751.147373788879;7769.494982826098;7869.881951770728;7447.664855081534;7490.5131166474;7503.399728021855;7610.505317154367;7612.961935190288;4389.231884420277;4408.493023302297;4448.088141930896;4461.24158892989;4500.212462818994;2118.3433135727973;2124.383928660702;2127.4362293992103;2147.3772605944414;2181.1602533024584;1004.1916257412706;1025.7589466475372;1039.3296323871211;1057.180684969155;1074.5594306334365;19297.4210773677;19905.402837914884;20222.898885505772;20302.492437689176;20515.692264616042;995.6515219673201;1007.189212683782;1041.5156952017348;1048.2452634103433;1098.4672433869566;11026;11350.545978160946;11433;11456.656300311004;11536;489227;493498;495581;497343;498679;97754.5112274434;97902.51048744853;100155.49922250342;100178.49910750546;100339.49830250801;507.710604955172;532.5952276269985;1016.11090295991;1032.3135115148493;1035.4770840725384;11614.419279036183;11714.76570468603;12188.634340969786;12286.201396909173;12478.625641230778;40928;42291.57708423;42339.5766042348;43582.78208608937;43787.562124378346;54938;55573;57225.42774572201;65006.34993650003;65888.34111659013;9057.18485336323;9061.320400969822;9117.863232051657;9231.261499080192;9417.811643767223;11190.384528850991;12962.351882405654;13487;13527.391267393188;14173.43306267779;11607.76784464323;12067.879321206676;12102.09234307448;12150.08874334446;12493.375331233221;11271.267367621407;11554.364509952033;11637.709057273298;12180.695482613006;12340.938295308466;12078.879211207775;12517.56188533397;12556.434960426985;12608.810867837174;12609.558665446666;9242.445453272825;9395.812083758423;9401.388909720847;9410.43537387759;9511.239100871775;9135.473038811424;12049.939750301193;12184.390780460764;12273.631791046282;12565.371731413576 03:38:47 INFO - PROCESS | 25267 | |3;mootools.html;1596.696627640748;1622.8234529965775;1851.2872544070528;1894.3937939859234;1936.2545420013291;9284.30367722421;9802.509874506282;9993.400395976238;10014.499275036256;10058.849117263248;9869.654562090329;9954.701358959224;9974.551145198466;9976.052275033879;10014.949925250363;2482.3049546127113;2491.539065272921;2492.3519884829893;2496.712878019033;2507.285423654259;2460.8646524441147;2512.6984761828608;2519.60946053362;2529.9374262809665;2540.6697129373156;2443.0960544598524;2474.8886300116537;2494.064725727852;2497.6003839385703;2503.8622875741826;2422.806175505964;2424.745401732819;2431.2706188143575;2478.281298423455;2500.3249122736943;2420.1287536486852;2431.2827715823873;2439.865807380593;2455.9386015349583;2463;9701.078397552292;9797.265205109574;9799.461029643368;9813.362131461432;9840.803183936352;5562.86092847678;5667.433256674341;5668.404817494186;5701.65790052594;5708.457696518824;3284.868605255787;3324.5511855899385;3368.4273673475323;3477.3045390921666;3530.7881527108198;1174.5477990973452;1175.2184797109912;1188.2989036468439;1223.4005337384706;1229.237872519044;14061.226632535207;14099.295035248197;14132;14202.502912398017;14206.57380278583;4778.641601879873;4806.543378379049;4885.5358740920265;4900.877478063006;4918.5819205367225;10841.349519028883;10914.672559823219;10924.2899211551;10964.725881853017;11016.394098324508;5407.648502847303;5493.956148331804;5494.1758736189095;5495.313085864267;5532.170174473861;4514.480834703985;4923.335349727812;5104.872378190501;5125.820596279113;5155.226715992556;4206.20082184384;4226.4928208615165;4281.379200016043;4316.266234740102;4348.869533913988;1254.2349167008117;1256.466001949168;1258.1633213912828;1263.279930439659;1263.91784534005;968.2109081098882;991.1921783746224;1034.7257976636197;1051.0488008352454;1073.3291692692067;6488.253850807123;6569.901451478232;6605.108310378134;6612;6767.695453704497;481.63395819176975;484.5517895946236;488.7898203772412;491.2827272182582;509.0429991615813;4637.1653102441205;4660.39414876064;4662.137504561667;4667;4673.182193116191;12257.26456412618;12549.435275412628;12667.683307917376;12668.49326026967;12721.554745584046;11627.418629068512;12374.566890158982;12460.626181214579;12478.313692746804;12545.686357841127;8839.646414143492;9067.455952642731;9145.268378529701;9196.080391960884;9199;6256.7810126645345;6332.335104813928;6402.935970640234;6428.774992875227;6562.278149403657;10768.300060496043;10861.40262285582;10865.402402867918;10942.23404361687;11041.613543525938;11058;11441;11520.193586448868;11680.123990700562;11732.824007639721;7920.603969801602;8395.95802020986;8454.154584541742;8632.482051076955;8658.91341086581;9165.404248723811;9208.907910920805;9211;9302.95348523253;9309.069093090637;8271.62777674994;8662.350323725872;8669.04640489533;8757.168069033432;8776.210141087333;8259.848760524337;8273.54495502729;8315.792105197177;8317.667293308199;8364.372672049742;7438.6652600632015;7477.4391920605085;7485.513441626277;7488.801791713299;7552.509086909334;5555.666660000413;5623.634463759842;5803.7968671096305;5823.883522329615;5850.646658307601;5695.145728140812;5722.914156287576;5725.484706376446;5752.079667253387;5888.852778680396 03:38:47 INFO - PROCESS | 25267 | |4;prototype.html;338.75609561116005;340.06990879943356;340.79381973905794;340.93010932758784;344.66395264617;5828.883422331556;5836.328822185439;5857.711303513225;5877.794277200299;5903.675297858616;5753.913691294634;5800.332961709394;5803.071508558632;5805.738741756621;5841.824745257649;4414.315781053926;4519.751413672247;4525.932111018337;4529.139463501941;4537.3647689323525;4496.392986946753;4504.4594648642205;4507.459104907416;4513.3455648930885;4538.387317712116;4484.618807401374;4522.932156017662;4528.20756367636;4528.50186479487;4543.454785425737;4271.67962402821;4477.417935668374;4493.393391892118;4508.165989291975;4570.634349252068;3904.4338570907344;3915.9216815663526;3928.410738389236;3951.940720889189;3952.9011774705573;5597.804076857331;5644.8024319148635;5682.772689092431;5688.345840228385;5722.885542289131;4931.334269873557;5103.387593488768;5103.821366252163;5119.411267704225;5172.19830926207;6057.636541807506;6092.634441933498;6121;6127.816165514997;6143.232095988002;4295.570442955711;4316.848910288156;4325.005248792764;4334.1981733379425;4339.804708788112;6116.571839971204;6168.334549671608;6384.872302553923;6391.092053115867;6425.200943735761;4474.865754027384;4506.729596224237;4518.367428560005;4526.343680166357;4540.182767101887;4568.383268258743;4597.793099310472;4627.537246275346;4632.930506042412;4639.30410438437;5009.624278179152;5226.63413561047;5251.868703282372;5253.684778913201;5258.684478931276;6108.908366374508;6113.144159817629;6117.785877494355;6158.152554233712;6187.876242475125;1578.9842101579068;1594.2666373468335;1597.9957679562349;1602.919854007295;1615.3457849570943;999.4003597841237;1022.6173016870822;1024.9077583017565;1028.5577201803146;1054.641421916552;5330.760115794798;5359.544438722674;5368.664630885499;5368.7047212403695;5370.897647235064;5597.692126933058;5627.803026894039;5634.211210430543;5652.830415087554;5688.288963879515;5219.946331396176;5313.388960269618;5338.172583249602;5342.1452567589;5361.705106219196;3003.339265361617;3010.208925689255;3013.3069394039057;3013.517837146046;3020.093971808493;5534.944650553443;5769.461436967721;5844.211031510777;5856.267966504187;5890.3815099414805;5591.496765291062;5675.829725108253;5688.9715551422805;5699.779624512137;5742.598018138774;5720.885582288414;5729.0521222784455;5802.361740208574;5840.1239814027385;5855.3266374367495;5582.944170558242;5623.746931388179;5907.616004959664;6355.872882542416;6360.173177486897;6052.273727152769;6235.3452887446165;6252.343503932022;6280.27776805655;6340.239171299474;6478.833809914261;6565.671716414256;6603.702833372414;6605.702743376463;6621.271660117287;4477.082198149306;4478.843240486567;4492.595666390041;4496.887577810581;4535.659825513166;6244.843878903063;6377.585456945284;6387.904181437375;6393.87212255743;6464.773732919325;6137.386261374006;6138.815835524942;6156.753729850756;6175.722092505758;6211.689415529296;5929.19159656309;6170.9074363885475;6191.349908259748;6202.162708034538;6225.719842607185;5995.520358371407;5995.940040599538;6026.216591843032;6034.370719905689;6111.166650004891;6138.723757431016;6200.627962322275;6201.441870231701;6223.066540019034;6246.375362463899;5926.881462370815;6064.484518815773;6097.512199024156;6099.237595300588;6157.96921015392 03:38:47 INFO - PROCESS | 25267 | |5;yui.html;755.693943952699;774.3224678406394;845.5349557743242;876.8816209811673;884.3190743127788;13766.999999999987;13933.581992540214;14939.477118300862;16025.679486410265;16533.25600347984;16748.078855662934;16998.83001169988;17036.318547258124;17039.57401064974;17080.82919170808;841.7727213652311;862.9352798540103;863.0247819963432;867.6442658509981;872.5855218771096;863.4732812984074;865.2947847504296;865.8008658008662;870.2994089757742;871.7123349294718;909.708893154191;910.0489987962562;911.544227886057;912.3248795891059;913.5432283858071;904.9411788233743;906.2795077913042;906.4244204929851;912.2200518556671;914.8947870994788;664.6975626090117;671.3119052970744;672.3008071605525;672.4250765595394;674.1202730436778;16517.83482165187;16525.504234872973;16565.6686866262;16583.751243731353;16585.25366358505;15593.922030389775;15789.60525986848;16029.599260018476;16109.355625774955;16284.26720797555;13349.199048057148;13367.465301387932;13423.731525369536;13590.728185436335;13647;3944.447777311179;3955.2880481513316;3965.5836137205465;3985.8405663773706;4034.152827906143;80687.59656201681;83396.99999999939;84322;84414.57792710997;84520;11032.944835275934;11206.159538034517;11242.606508772154;11362.772744545064;11526.077913766878;20527.28154514585;20545.897270513553;20550.486237844172;20605.424321959756;20749.066292016894;8658.090900455487;8676.522791246416;8805.295576353876;8913.866292005625;9013.63945442188;4825.420949486084;4943.9258411123865;4958.42978057528;5026.2460630904925;5030.924536131961;3525.5945566259697;3614.6927511161844;3647.215848592565;3666.6333366663653;3674.06311390599;655.6295692933477;662.6189940784069;662.68522451835;665.4510029225908;676.7834293026283;768.1435199752236;806.395203597302;806.8265322955592;809.162516795126;814.2102160903913;9955.701328960144;10007;10143.289969702199;10193.133583645325;10219.489025548693;636.5257882877286;645.2128403347908;645.6190847399963;656.6257233376929;661.9772451562252;4802.831900883522;4834.927476087862;4935.210366341368;5057.848264551996;5087.669301495391;74517;95681.5215923916;96322.51838740901;118492.40753796349;125134;64539;64616.67691661606;78479.60760196163;89464.10535894688;103630;62151;90492.5475372632;91207.54396227976;91364.88858001406;91712.54143729238;9045.33630990928;9199;9201.907980920105;9238.95380523093;9269.953650231706;52442.475575245284;53162.2025669623;53266.4673353277;54173.45826541684;54409.45590544044;47369;76780.23219767731;80191.59904200441;81153;82696.58651706703;12923.612291631267;13250.271235082164;13399.263040532864;13701.794473083111;13750.724985500034;14159;15749.606259843596;15751;16185.352585896433;16750.748738769173;14776.778348324999;15284.15937123469;15404.38382464689;15495.845041549892;15622;14911.627209319853;14957.925210374315;15169.62075948066;15625.843741562894;15690.764638530203;14098.718025639635;14968.326425311105;15409.76885346743;15541;15976.920115399813;10864;11224.872206148992;11377.43112844371;11964.162508624313;11984.880151198377;10321.896781032094;11255.212135150789;11660.475278612652;11726.530938762355;11812.173147879566 03:38:47 INFO - PROCESS | 25267 | __end_tp_report 03:38:47 INFO - PROCESS | 25267 | __start_cc_report 03:38:47 INFO - PROCESS | 25267 | _x_x_mozilla_cycle_collect,349 03:38:47 INFO - PROCESS | 25267 | __end_cc_report 03:38:47 INFO - PROCESS | 25267 | __startTimestamp1467196727044__endTimestamp 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - PROCESS | 25267 | ------- Summary: start ------- 03:38:47 INFO - PROCESS | 25267 | Number of tests: 6 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - PROCESS | 25267 | [#0] dojo.html Cycles:165 Average:5941.83 Median:6191.78 stddev:694.25 (11.2%) stddev-sans-first:668.67 03:38:47 INFO - PROCESS | 25267 | Values: 3466.7 3469.0 3476.1 3486.1 3496.2 5827.2 5866.9 5892.7 5973.2 6006.7 5987.6 5990.0 5998.9 6018.6 6043.8 5404.4 5428.5 5492.1 5493.1 5552.3 5328.8 5335.4 5376.3 5518.6 5519.5 5362.4 5408.6 5460.2 5491.3 5514.8 5481.3 5544.7 5556.7 5560.9 5571.7 5259.1 5424.5 5455.7 5515.6 5540.0 5690.9 5765.6 5794.4 5841.1 5844.2 6414.7 6419.2 6441.3 6455.6 6461.3 6199.2 6200.2 6474.1 6477.5 6495.5 5868.3 5993.3 6005.5 6006.9 6052.9 6443.9 6584.6 6599.5 6601.0 6614.4 6068.7 6206.0 6241.6 6276.5 6313.6 6431.6 6451.4 6471.9 6473.4 6491.9 6345.5 6393.6 6397.2 6412.7 6418.8 6056.7 6233.0 6315.7 6356.1 6383.3 4818.5 4833.6 4833.7 4840.8 4857.1 4274.4 4301.9 4303.9 4308.4 4341.2 5900.2 5939.6 6080.7 6122.4 6132.4 6339.5 6375.4 6400.9 6401.8 6415.7 6150.8 6188.4 6201.8 6210.5 6219.6 5186.9 5250.1 5277.4 5325.3 5329.7 6716.1 6724.4 6748.4 6748.8 6762.5 6461.8 6474.3 6480.1 6494.8 6497.0 6267.8 6583.3 6630.0 6649.3 6700.7 6411.1 6414.3 6420.1 6422.6 6428.4 6131.4 6495.9 6543.2 6568.8 6571.1 6176.4 6184.3 6198.0 6353.7 6357.1 6311.6 6325.2 6333.1 6342.6 6343.5 5842.5 6013.6 6125.2 6174.3 6191.8 6201.0 6301.3 6346.9 6365.6 6381.0 6147.2 6193.0 6194.3 6200.4 6208.1 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - PROCESS | 25267 | [#1] ext.html Cycles:180 Average:63666.81 Median:44434.50 stddev:135984.16 (306.0%) stddev-sans-first:136283.16 03:38:47 INFO - PROCESS | 25267 | Values: 590.9 641.2 648.2 657.4 659.9 45199.0 46790.8 46793.8 46971.0 49749.3 47946.5 48144.8 48187.8 48297.0 48601.8 9044.5 9165.1 9192.3 9203.3 9211.0 8988.0 9099.6 9120.0 9126.0 9155.2 9185.1 9195.6 9196.5 9207.9 9209.9 9030.5 9047.9 9050.2 9082.5 9125.0 8967.8 9052.1 9059.2 9061.6 9082.7 44784.1 45019.0 45028.8 45039.8 45100.0 3871.7 3893.7 3990.8 4032.6 4171.2 33845.5 33867.7 34104.8 34214.7 34480.3 4532.8 4534.2 4629.5 4651.7 4720.0 243970.0 244076.0 245203.0 245681.0 245987.0 36760.3 62382.7 62432.4 62466.0 62795.0 38267.0 40705.6 40833.8 40896.4 40917.6 14941.5 15109.9 15156.1 15221.9 15228.0 11651.8 11728.0 11735.7 11739.5 11762.9 9175.1 9218.8 9230.4 9243.1 9275.4 3493.1 3494.6 3505.5 3578.1 3579.4 988.8 1031.9 1140.0 1141.7 1172.0 31838.0 31920.8 31994.5 32383.8 32533.8 1115.5 1121.1 1176.6 1193.3 1279.6 16993.2 17178.5 17799.4 17979.3 18188.1 632008.0 635840.0 638574.0 640364.0 641477.0 64741.4 65389.0 65422.7 65616.7 65740.7 1432.3 1434.4 1444.6 1446.1 1456.9 33129.7 33825.7 34148.5 34230.5 34439.5 54983.7 55936.4 55939.2 55965.4 56248.0 551277.0 551748.0 552037.0 553871.0 557210.0 28790.7 28843.9 28916.9 29181.9 29345.9 50865.5 50914.7 51010.0 51186.0 52209.7 43340.6 43373.8 43446.8 43638.8 43776.6 40535.6 43622.8 44068.3 44153.0 44964.1 40001.2 43046.8 44716.0 44829.0 46692.0 38845.6 39009.0 39071.0 40042.6 40116.8 29807.1 30385.7 30493.5 30712.5 30829.7 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - PROCESS | 25267 | [#2] jquery.html Cycles:180 Average:29642.87 Median:23977.00 stddev:81778.28 (341.1%) stddev-sans-first:81978.27 03:38:47 INFO - PROCESS | 25267 | Values: 426.1 429.6 433.4 433.5 439.3 19084.6 20267.5 20802.9 21593.4 21644.2 19616.1 19636.2 19970.0 20241.6 20242.5 5740.9 5976.2 5999.5 6004.6 6043.5 5921.1 5959.5 5969.2 6005.5 6016.8 5743.9 5907.8 5909.2 5934.2 5946.4 5803.8 5844.1 5921.9 5964.7 5968.3 5315.9 5336.9 5385.9 5392.8 5396.0 23719.3 23773.0 23889.0 24065.0 24230.3 2632.8 2639.3 2726.4 2963.0 3302.5 14513.9 14980.9 15084.9 15111.2 15676.0 2041.6 2068.3 2094.6 2130.8 2153.9 82652.0 83471.0 83718.0 83888.0 85125.0 9781.5 10348.2 10496.8 10837.2 11000.8 14303.8 14430.4 14542.6 14553.4 14575.6 7622.5 7704.2 7751.1 7769.5 7869.9 7447.7 7490.5 7503.4 7610.5 7613.0 4389.2 4408.5 4448.1 4461.2 4500.2 2118.3 2124.4 2127.4 2147.4 2181.2 1004.2 1025.8 1039.3 1057.2 1074.6 19297.4 19905.4 20222.9 20302.5 20515.7 995.7 1007.2 1041.5 1048.2 1098.5 11026.0 11350.5 11433.0 11456.7 11536.0 489227.0 493498.0 495581.0 497343.0 498679.0 97754.5 97902.5 100155.5 100178.5 100339.5 507.7 532.6 1016.1 1032.3 1035.5 11614.4 11714.8 12188.6 12286.2 12478.6 40928.0 42291.6 42339.6 43582.8 43787.6 54938.0 55573.0 57225.4 65006.3 65888.3 9057.2 9061.3 9117.9 9231.3 9417.8 11190.4 12962.4 13487.0 13527.4 14173.4 11607.8 12067.9 12102.1 12150.1 12493.4 11271.3 11554.4 11637.7 12180.7 12340.9 12078.9 12517.6 12556.4 12608.8 12609.6 9242.4 9395.8 9401.4 9410.4 9511.2 9135.5 12049.9 12184.4 12273.6 12565.4 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - PROCESS | 25267 | [#3] mootools.html Cycles:180 Average:6361.08 Median:4670.09 stddev:3751.66 (80.3%) stddev-sans-first:3745.10 03:38:47 INFO - PROCESS | 25267 | Values: 1596.7 1622.8 1851.3 1894.4 1936.3 9284.3 9802.5 9993.4 10014.5 10058.8 9869.7 9954.7 9974.6 9976.1 10014.9 2482.3 2491.5 2492.4 2496.7 2507.3 2460.9 2512.7 2519.6 2529.9 2540.7 2443.1 2474.9 2494.1 2497.6 2503.9 2422.8 2424.7 2431.3 2478.3 2500.3 2420.1 2431.3 2439.9 2455.9 2463.0 9701.1 9797.3 9799.5 9813.4 9840.8 5562.9 5667.4 5668.4 5701.7 5708.5 3284.9 3324.6 3368.4 3477.3 3530.8 1174.5 1175.2 1188.3 1223.4 1229.2 14061.2 14099.3 14132.0 14202.5 14206.6 4778.6 4806.5 4885.5 4900.9 4918.6 10841.3 10914.7 10924.3 10964.7 11016.4 5407.6 5494.0 5494.2 5495.3 5532.2 4514.5 4923.3 5104.9 5125.8 5155.2 4206.2 4226.5 4281.4 4316.3 4348.9 1254.2 1256.5 1258.2 1263.3 1263.9 968.2 991.2 1034.7 1051.0 1073.3 6488.3 6569.9 6605.1 6612.0 6767.7 481.6 484.6 488.8 491.3 509.0 4637.2 4660.4 4662.1 4667.0 4673.2 12257.3 12549.4 12667.7 12668.5 12721.6 11627.4 12374.6 12460.6 12478.3 12545.7 8839.6 9067.5 9145.3 9196.1 9199.0 6256.8 6332.3 6402.9 6428.8 6562.3 10768.3 10861.4 10865.4 10942.2 11041.6 11058.0 11441.0 11520.2 11680.1 11732.8 7920.6 8396.0 8454.2 8632.5 8658.9 9165.4 9208.9 9211.0 9303.0 9309.1 8271.6 8662.4 8669.0 8757.2 8776.2 8259.8 8273.5 8315.8 8317.7 8364.4 7438.7 7477.4 7485.5 7488.8 7552.5 5555.7 5623.6 5803.8 5823.9 5850.6 5695.1 5722.9 5725.5 5752.1 5888.9 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - PROCESS | 25267 | [#4] prototype.html Cycles:180 Average:5037.12 Median:5631.01 stddev:1476.04 (26.2%) stddev-sans-first:1437.44 03:38:47 INFO - PROCESS | 25267 | Values: 338.8 340.1 340.8 340.9 344.7 5828.9 5836.3 5857.7 5877.8 5903.7 5753.9 5800.3 5803.1 5805.7 5841.8 4414.3 4519.8 4525.9 4529.1 4537.4 4496.4 4504.5 4507.5 4513.3 4538.4 4484.6 4522.9 4528.2 4528.5 4543.5 4271.7 4477.4 4493.4 4508.2 4570.6 3904.4 3915.9 3928.4 3951.9 3952.9 5597.8 5644.8 5682.8 5688.3 5722.9 4931.3 5103.4 5103.8 5119.4 5172.2 6057.6 6092.6 6121.0 6127.8 6143.2 4295.6 4316.8 4325.0 4334.2 4339.8 6116.6 6168.3 6384.9 6391.1 6425.2 4474.9 4506.7 4518.4 4526.3 4540.2 4568.4 4597.8 4627.5 4632.9 4639.3 5009.6 5226.6 5251.9 5253.7 5258.7 6108.9 6113.1 6117.8 6158.2 6187.9 1579.0 1594.3 1598.0 1602.9 1615.3 999.4 1022.6 1024.9 1028.6 1054.6 5330.8 5359.5 5368.7 5368.7 5370.9 5597.7 5627.8 5634.2 5652.8 5688.3 5219.9 5313.4 5338.2 5342.1 5361.7 3003.3 3010.2 3013.3 3013.5 3020.1 5534.9 5769.5 5844.2 5856.3 5890.4 5591.5 5675.8 5689.0 5699.8 5742.6 5720.9 5729.1 5802.4 5840.1 5855.3 5582.9 5623.7 5907.6 6355.9 6360.2 6052.3 6235.3 6252.3 6280.3 6340.2 6478.8 6565.7 6603.7 6605.7 6621.3 4477.1 4478.8 4492.6 4496.9 4535.7 6244.8 6377.6 6387.9 6393.9 6464.8 6137.4 6138.8 6156.8 6175.7 6211.7 5929.2 6170.9 6191.3 6202.2 6225.7 5995.5 5995.9 6026.2 6034.4 6111.2 6138.7 6200.6 6201.4 6223.1 6246.4 5926.9 6064.5 6097.5 6099.2 6158.0 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - PROCESS | 25267 | [#5] yui.html Cycles:180 Average:20515.68 Median:4885.07 stddev:28265.92 (578.6%) stddev-sans-first:28306.27 03:38:47 INFO - PROCESS | 25267 | Values: 755.7 774.3 845.5 876.9 884.3 13767.0 13933.6 14939.5 16025.7 16533.3 16748.1 16998.8 17036.3 17039.6 17080.8 841.8 862.9 863.0 867.6 872.6 863.5 865.3 865.8 870.3 871.7 909.7 910.0 911.5 912.3 913.5 904.9 906.3 906.4 912.2 914.9 664.7 671.3 672.3 672.4 674.1 16517.8 16525.5 16565.7 16583.8 16585.3 15593.9 15789.6 16029.6 16109.4 16284.3 13349.2 13367.5 13423.7 13590.7 13647.0 3944.4 3955.3 3965.6 3985.8 4034.2 80687.6 83397.0 84322.0 84414.6 84520.0 11032.9 11206.2 11242.6 11362.8 11526.1 20527.3 20545.9 20550.5 20605.4 20749.1 8658.1 8676.5 8805.3 8913.9 9013.6 4825.4 4943.9 4958.4 5026.2 5030.9 3525.6 3614.7 3647.2 3666.6 3674.1 655.6 662.6 662.7 665.5 676.8 768.1 806.4 806.8 809.2 814.2 9955.7 10007.0 10143.3 10193.1 10219.5 636.5 645.2 645.6 656.6 662.0 4802.8 4834.9 4935.2 5057.8 5087.7 74517.0 95681.5 96322.5 118492.4 125134.0 64539.0 64616.7 78479.6 89464.1 103630.0 62151.0 90492.5 91207.5 91364.9 91712.5 9045.3 9199.0 9201.9 9239.0 9270.0 52442.5 53162.2 53266.5 54173.5 54409.5 47369.0 76780.2 80191.6 81153.0 82696.6 12923.6 13250.3 13399.3 13701.8 13750.7 14159.0 15749.6 15751.0 16185.4 16750.7 14776.8 15284.2 15404.4 15495.8 15622.0 14911.6 14957.9 15169.6 15625.8 15690.8 14098.7 14968.3 15409.8 15541.0 15976.9 10864.0 11224.9 11377.4 11964.2 11984.9 10321.9 11255.2 11660.5 11726.5 11812.2 03:38:47 INFO - PROCESS | 25267 | -------- Summary: end -------- 03:38:47 INFO - PROCESS | 25267 | 03:38:47 INFO - TEST-INFO | 25267: exit 0 03:38:47 INFO - TEST-OK | dromaeo_css | took 1110385ms 03:38:47 INFO - TEST-START | kraken 03:38:47 INFO - operating with platform_type : linux_ 03:38:47 INFO - Initialising browser for kraken test... 03:38:47 INFO - TEST-INFO | started process 25506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCifoA1/profile http://localhost:51822/getInfo.html) 03:38:51 INFO - PROCESS | 25506 | __metrics Screen width/height:1600/1200 03:38:51 INFO - PROCESS | 25506 | colorDepth:24 03:38:51 INFO - PROCESS | 25506 | Browser inner width/height: 1024/697 03:38:51 INFO - PROCESS | 25506 | __metrics 03:38:52 ERROR - PROCESS | 25506 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:38:53 INFO - TEST-INFO | 25506: exit 0 03:38:53 INFO - Browser initialized. 03:38:53 INFO - Running cycle 1/1 for kraken test... 03:38:53 INFO - TEST-INFO | started process 25639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCifoA1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:05 INFO - PROCESS | 25639 | RSS: Main: 156278784 03:39:05 INFO - PROCESS | 25639 | 03:39:07 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51822/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:08 INFO - PROCESS | 25639 | RSS: Main: 161906688 03:39:08 INFO - PROCESS | 25639 | 03:39:11 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51822/tests/kraken/driver.html?testName=audio-dft) 03:39:11 INFO - PROCESS | 25639 | RSS: Main: 160571392 03:39:11 INFO - PROCESS | 25639 | 03:39:14 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51822/tests/kraken/driver.html?testName=audio-fft) 03:39:15 INFO - PROCESS | 25639 | RSS: Main: 161488896 03:39:15 INFO - PROCESS | 25639 | 03:39:17 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51822/tests/kraken/driver.html?testName=audio-oscillator) 03:39:18 INFO - PROCESS | 25639 | RSS: Main: 161050624 03:39:18 INFO - PROCESS | 25639 | 03:39:20 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:39:20 INFO - PROCESS | 25639 | RSS: Main: 161325056 03:39:20 INFO - PROCESS | 25639 | 03:39:23 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51822/tests/kraken/driver.html?testName=imaging-darkroom) 03:39:24 INFO - PROCESS | 25639 | RSS: Main: 160935936 03:39:24 INFO - PROCESS | 25639 | 03:39:27 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51822/tests/kraken/driver.html?testName=imaging-desaturate) 03:39:28 INFO - PROCESS | 25639 | RSS: Main: 161632256 03:39:28 INFO - PROCESS | 25639 | 03:39:31 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51822/tests/kraken/driver.html?testName=json-parse-financial) 03:39:32 INFO - PROCESS | 25639 | RSS: Main: 161263616 03:39:32 INFO - PROCESS | 25639 | 03:39:33 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:39:34 INFO - PROCESS | 25639 | RSS: Main: 160948224 03:39:34 INFO - PROCESS | 25639 | 03:39:35 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51822/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:39:36 INFO - PROCESS | 25639 | RSS: Main: 161062912 03:39:36 INFO - PROCESS | 25639 | 03:39:38 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:39:39 INFO - PROCESS | 25639 | RSS: Main: 161988608 03:39:39 INFO - PROCESS | 25639 | 03:39:41 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:39:42 INFO - PROCESS | 25639 | RSS: Main: 162267136 03:39:42 INFO - PROCESS | 25639 | 03:39:45 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:39:45 INFO - PROCESS | 25639 | RSS: Main: 161673216 03:39:45 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | Cycle 1(1): loaded http://localhost:51822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51822/tests/kraken/driver.html?testName=ai-astar) 03:39:47 INFO - PROCESS | 25639 | RSS: Main: 161972224 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | __start_tp_report 03:39:47 INFO - PROCESS | 25639 | _x_x_mozilla_page_load 03:39:47 INFO - PROCESS | 25639 | _x_x_mozilla_page_load_details 03:39:47 INFO - PROCESS | 25639 | |i|pagename|runs| 03:39:47 INFO - PROCESS | 25639 | |0;ai-astar;112;106;110;111;122;112;111;111;113;109 03:39:47 INFO - PROCESS | 25639 | |1;audio-beat-detection;157;131;150;176;127;158;158;135;182;127 03:39:47 INFO - PROCESS | 25639 | |2;audio-dft;161;161;163;161;162;162;162;161;164;163 03:39:47 INFO - PROCESS | 25639 | |3;audio-fft;74;76;78;170;75;76;76;76;159;76 03:39:47 INFO - PROCESS | 25639 | |4;audio-oscillator;85;83;152;85;84;85;133;85;85;155 03:39:47 INFO - PROCESS | 25639 | |5;imaging-gaussian-blur;118;119;118;117;117;118;118;116;118;118 03:39:47 INFO - PROCESS | 25639 | |6;imaging-darkroom;147;148;147;147;148;146;148;147;146;147 03:39:47 INFO - PROCESS | 25639 | |7;imaging-desaturate;95;95;97;96;95;100;98;95;95;95 03:39:47 INFO - PROCESS | 25639 | |8;json-parse-financial;59;55;54;54;56;57;56;54;53;56 03:39:47 INFO - PROCESS | 25639 | |9;json-stringify-tinderbox;60;60;60;59;61;60;59;59;59;60 03:39:47 INFO - PROCESS | 25639 | |10;stanford-crypto-aes;77;76;77;82;77;82;85;81;113;77 03:39:47 INFO - PROCESS | 25639 | |11;stanford-crypto-ccm;129;125;125;128;118;127;119;118;137;123 03:39:47 INFO - PROCESS | 25639 | |12;stanford-crypto-pbkdf2;160;153;156;156;152;156;157;158;155;161 03:39:47 INFO - PROCESS | 25639 | |13;stanford-crypto-sha256-iterative;61;63;61;66;62;60;63;62;65;62 03:39:47 INFO - PROCESS | 25639 | __end_tp_report 03:39:47 INFO - PROCESS | 25639 | __start_cc_report 03:39:47 INFO - PROCESS | 25639 | _x_x_mozilla_cycle_collect,890 03:39:47 INFO - PROCESS | 25639 | __end_cc_report 03:39:47 INFO - PROCESS | 25639 | __startTimestamp1467196787679__endTimestamp 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | ------- Summary: start ------- 03:39:47 INFO - PROCESS | 25639 | Number of tests: 14 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.11 (3.7%) stddev-sans-first:4.36 03:39:47 INFO - PROCESS | 25639 | Values: 112.0 106.0 110.0 111.0 122.0 112.0 111.0 111.0 113.0 109.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.50 stddev:19.78 (12.6%) stddev-sans-first:20.82 03:39:47 INFO - PROCESS | 25639 | Values: 157.0 131.0 150.0 176.0 127.0 158.0 158.0 135.0 182.0 127.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 03:39:47 INFO - PROCESS | 25639 | Values: 161.0 161.0 163.0 161.0 162.0 162.0 162.0 161.0 164.0 163.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.47 (49.3%) stddev-sans-first:39.07 03:39:47 INFO - PROCESS | 25639 | Values: 74.0 76.0 78.0 170.0 75.0 76.0 76.0 76.0 159.0 76.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:30.52 (35.9%) stddev-sans-first:31.66 03:39:47 INFO - PROCESS | 25639 | Values: 85.0 83.0 152.0 85.0 84.0 85.0 133.0 85.0 85.0 155.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 03:39:47 INFO - PROCESS | 25639 | Values: 118.0 119.0 118.0 117.0 117.0 118.0 118.0 116.0 118.0 118.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:39:47 INFO - PROCESS | 25639 | Values: 147.0 148.0 147.0 147.0 148.0 146.0 148.0 147.0 146.0 147.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:1.73 (1.8%) stddev-sans-first:1.79 03:39:47 INFO - PROCESS | 25639 | Values: 95.0 95.0 97.0 96.0 95.0 100.0 98.0 95.0 95.0 95.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.78 (3.2%) stddev-sans-first:1.32 03:39:47 INFO - PROCESS | 25639 | Values: 59.0 55.0 54.0 54.0 56.0 57.0 56.0 54.0 53.0 56.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 03:39:47 INFO - PROCESS | 25639 | Values: 60.0 60.0 60.0 59.0 61.0 60.0 59.0 59.0 59.0 60.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:79.00 stddev:11.07 (14.0%) stddev-sans-first:11.54 03:39:47 INFO - PROCESS | 25639 | Values: 77.0 76.0 77.0 82.0 77.0 82.0 85.0 81.0 113.0 77.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:5.88 (4.7%) stddev-sans-first:6.04 03:39:47 INFO - PROCESS | 25639 | Values: 129.0 125.0 125.0 128.0 118.0 127.0 119.0 118.0 137.0 123.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:156.50 stddev:2.80 (1.8%) stddev-sans-first:2.65 03:39:47 INFO - PROCESS | 25639 | Values: 160.0 153.0 156.0 156.0 152.0 156.0 157.0 158.0 155.0 161.0 03:39:47 INFO - PROCESS | 25639 | 03:39:47 INFO - PROCESS | 25639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.84 (2.9%) stddev-sans-first:1.87 03:39:47 INFO - PROCESS | 25639 | Values: 61.0 63.0 61.0 66.0 62.0 60.0 63.0 62.0 65.0 62.0 03:39:47 INFO - PROCESS | 25639 | -------- Summary: end -------- 03:39:47 INFO - PROCESS | 25639 | 03:39:48 INFO - TEST-INFO | 25639: exit 0 03:39:48 INFO - TEST-OK | kraken | took 60901ms 03:39:48 INFO - SUITE-END | took 1171s 03:39:48 INFO - Completed test suite (00:19:31) 03:39:48 INFO - javascript benchmark 03:39:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7623.5968637196365, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3466.7226621870245, 3468.965310346896, 3476.0614634048798, 3486.1284678830293, 3496.1958749487617, 5827.155062515938, 5866.911996320058, 5892.734826932793, 5973.223480947481, 6006.699665016743, 5987.640741555499, 5990.0, 5998.8800223995495, 6018.578699491038, 6043.8186854394435, 5404.432534583881, 5428.511433970942, 5492.066348720727, 5493.066178749622, 5552.305961754781, 5328.786848526054, 5335.386430560497, 5376.274202982587, 5518.641288316247, 5519.503244707976, 5362.383325917511, 5408.621396502246, 5460.180972854084, 5491.341039075297, 5514.80698175564, 5481.260029895972, 5544.695041772701, 5556.749946252428, 5560.888782224333, 5571.721413929287, 5259.105951988171, 5424.484673955968, 5455.727213639302, 5515.558755299607, 5540.030494663458, 5690.886182276331, 5765.596408251424, 5794.391588883149, 5841.094630332305, 5844.240248767633, 6414.679266036679, 6419.229692436891, 6441.323661015573, 6455.644939528324, 6461.289258181596, 6199.163112979735, 6200.224971878515, 6474.125992990933, 6477.481801455872, 6495.512836537278, 5868.325142608569, 5993.310769261547, 6005.489533389711, 6006.879862402728, 6052.878942421127, 6443.903341449882, 6584.604923704593, 6599.47204223661, 6600.966995165089, 6614.371634694697, 6068.696565171724, 6206.0, 6241.594296370721, 6276.497880169575, 6313.621182728959, 6431.5819471734185, 6451.387118223761, 6471.870562588721, 6473.449756770728, 6491.902621460682, 6345.49236061114, 6393.552451328363, 6397.232332120082, 6412.743490260431, 6418.807435776934, 6056.727447264883, 6233.0, 6315.684215789284, 6356.078368636522, 6383.329750376237, 4818.542238487338, 4833.564979151823, 4833.73414462208, 4840.782164802592, 4857.101436234238, 4274.380214868826, 4301.935470967938, 4303.935440968388, 4308.353746937984, 4341.175176716414, 5900.20347253124, 5939.643621382731, 6080.695965201722, 6122.428649698624, 6132.386761323832, 6339.524535659844, 6375.362463753588, 6400.871982560323, 6401.775937842246, 6415.711292991827, 6150.815475535741, 6188.44304012641, 6201.782937597252, 6210.50315974721, 6219.595726277777, 5186.92219616706, 5250.133727934848, 5277.445868183862, 5325.334333208349, 5329.680219186861, 6716.093327400836, 6724.361185687352, 6748.358905903931, 6748.83127921796, 6762.459003279726, 6461.773837915651, 6474.255460622088, 6480.12518310041, 6494.805155845333, 6496.967515162394, 6267.843303917439, 6583.341665833378, 6629.966850165912, 6649.335066493312, 6700.731970721116, 6411.102445657519, 6414.294427612866, 6420.133282006869, 6422.550421470452, 6428.389303016206, 6131.417515336036, 6495.870082598227, 6543.1821022372205, 6568.8357791055605, 6571.080048793268, 6176.4441200292185, 6184.319724830175, 6198.0, 6353.714082866374, 6357.14178585885, 6311.558190926775, 6325.177726895474, 6333.145025421509, 6342.619442833445, 6343.460805831556, 5842.532597392284, 6013.579049466495, 6125.203723515914, 6174.289956655042, 6191.783287584913, 6201.0388389799655, 6301.306856245901, 6346.904796427965, 6365.649889256136, 6381.0, 6147.231596050494, 6192.969035154795, 6194.318624951342, 6200.410960958701, 6208.068789681584], "value": 5894.160974378261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.8522869282676, 641.2337256977911, 648.1897627965044, 657.4050484311699, 659.9208095028596, 45199.0, 46790.76604616977, 46793.7660311698, 46971.0, 49749.25376119361, 47946.52053479464, 48144.75927620357, 48187.759061204735, 48297.0, 48601.75699121508, 9044.547772611377, 9165.129312715282, 9192.310576706774, 9203.263738900872, 9210.953945230265, 8987.955060224689, 9099.636014559443, 9119.954400227989, 9125.954370228139, 9155.176034156924, 9185.081491850828, 9195.586198621044, 9196.494192819393, 9207.907920920772, 9209.861852072225, 9030.503322317238, 9047.909520904805, 9050.230730387892, 9082.500462474562, 9125.041870603558, 8967.820643587092, 9052.094790520896, 9059.229965452878, 9061.592228349675, 9082.727518174466, 44784.10431791346, 45018.9741461635, 45028.774856125834, 45039.774801126114, 45100.0, 3871.690264778811, 3893.7079719020903, 3990.8004599769897, 4032.6169013943627, 4171.249175148472, 33845.49231761526, 33867.661323386696, 34104.82947585271, 34214.6578534214, 34480.310393792235, 4532.818687252506, 4534.161180181677, 4629.537046295377, 4651.7441540715245, 4719.976400117977, 243970.0, 244076.0, 245203.0, 245681.0, 245987.0, 36760.26479470396, 62382.688086559276, 62432.375676243566, 62466.0, 62795.0, 38267.0, 40705.59294407018, 40833.79583102065, 40896.38655420171, 40917.590824091974, 14941.477048303257, 15109.924450377897, 15156.090634561962, 15221.923890380698, 15228.0, 11651.766964660828, 11728.0, 11735.706607334885, 11739.530418783153, 11762.94118529402, 9175.08249175077, 9218.769530761785, 9230.400023998553, 9243.075692430837, 9275.443473391619, 3493.074335301147, 3494.5631796025496, 3505.544279243682, 3578.1233597768714, 3579.3915034443685, 988.7824678570703, 1031.9380837149795, 1139.9658010259704, 1141.6746227325339, 1172.0447835014436, 31838.0, 31920.840395797873, 31994.520082198786, 32383.838080809444, 32533.83733081367, 1115.544214799678, 1121.1255220927526, 1176.611718133014, 1193.3317342288346, 1279.584135156078, 16993.150342482826, 17178.484645460405, 17799.377021804175, 17979.280828766703, 18188.134634281894, 632008.0, 635840.0, 638574.0, 640364.0, 641477.0, 64741.35258647447, 65389.0, 65422.67288663622, 65616.67191664012, 65740.67129664321, 1432.3411230833724, 1434.426229508205, 1444.6171764482422, 1446.0600609603632, 1456.8543145685346, 33129.66870331266, 33825.661743383236, 34148.487772683926, 34230.48654270138, 34439.483407748405, 54983.72508137434, 55936.44063559312, 55939.16091258553, 55965.44034559602, 56248.0, 551277.0, 551748.0, 552037.0, 553871.0, 557210.0, 28790.712092878803, 28843.855780721802, 28916.85541572363, 29181.854090729412, 29345.85327073351, 50865.491345087554, 50914.74542627263, 51010.0, 51186.0, 52209.738951305, 43340.56659433365, 43373.78313108414, 43446.78276608597, 43638.78180609077, 43776.56223437725, 40535.59464405436, 43622.781886090364, 44068.33897491476, 44153.0, 44964.1007179848, 40001.1999760009, 43046.78476607597, 44716.0, 44829.0, 46692.0, 38845.6115438842, 39009.024774380865, 39071.0, 40042.599574003885, 40116.79941600273, 29807.10578682643, 30385.696143038287, 30493.54259686062, 30712.539311910787, 30829.69170308268], "value": 19904.9508250568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.10943128860686, 429.55111908056085, 433.4192182475482, 433.5036383341077, 439.27081045464536, 19084.618307633857, 20267.49331266719, 20802.89598552007, 21593.352199434004, 21644.2424515142, 19616.117274722637, 19636.21455141796, 19970.0, 20241.59516809663, 20242.493937651565, 5740.913886291709, 5976.223090998186, 5999.460048595625, 6004.639721616695, 6043.516518678517, 5921.082232254007, 5959.463648271655, 5969.194158788551, 6005.4895333896675, 6016.789412370568, 5743.885122297552, 5907.793227237047, 5909.172715819789, 5934.1692163097205, 5946.405359464062, 5803.796867109673, 5844.064949608063, 5921.851953701171, 5964.701764911781, 5968.343482216953, 5315.867103322448, 5336.893262134774, 5385.865353366158, 5392.757325920343, 5395.973020134914, 23719.288421347388, 23773.049078036856, 23889.0, 24065.0, 24230.2730918071, 2632.7762140218106, 2639.326971622243, 2726.386563023304, 2962.9851850740824, 3302.53764472974, 14513.854861451462, 14980.850191498055, 15084.924575377163, 15111.168885711282, 15676.0, 2041.5712700332947, 2068.2761033638258, 2094.5915546468445, 2130.7975742304457, 2153.9461513462134, 82652.0, 83471.0, 83718.0, 83888.0, 85125.0, 9781.510924453749, 10348.22388320879, 10496.790064198673, 10837.241393102564, 11000.779984400428, 14303.78544321836, 14430.42278308856, 14542.563723088113, 14553.417863285349, 14575.562733118024, 7622.504537205064, 7704.152543220242, 7751.147373788879, 7769.494982826098, 7869.881951770728, 7447.664855081534, 7490.5131166474, 7503.399728021855, 7610.505317154367, 7612.961935190288, 4389.231884420277, 4408.493023302297, 4448.088141930896, 4461.24158892989, 4500.212462818994, 2118.3433135727973, 2124.383928660702, 2127.4362293992103, 2147.3772605944414, 2181.1602533024584, 1004.1916257412706, 1025.7589466475372, 1039.3296323871211, 1057.180684969155, 1074.5594306334365, 19297.4210773677, 19905.402837914884, 20222.898885505772, 20302.492437689176, 20515.692264616042, 995.6515219673201, 1007.189212683782, 1041.5156952017348, 1048.2452634103433, 1098.4672433869566, 11026.0, 11350.545978160946, 11433.0, 11456.656300311004, 11536.0, 489227.0, 493498.0, 495581.0, 497343.0, 498679.0, 97754.5112274434, 97902.51048744853, 100155.49922250342, 100178.49910750546, 100339.49830250801, 507.710604955172, 532.5952276269985, 1016.11090295991, 1032.3135115148493, 1035.4770840725384, 11614.419279036183, 11714.76570468603, 12188.634340969786, 12286.201396909173, 12478.625641230778, 40928.0, 42291.57708423, 42339.5766042348, 43582.78208608937, 43787.562124378346, 54938.0, 55573.0, 57225.42774572201, 65006.34993650003, 65888.34111659013, 9057.18485336323, 9061.320400969822, 9117.863232051657, 9231.261499080192, 9417.811643767223, 11190.384528850991, 12962.351882405654, 13487.0, 13527.391267393188, 14173.43306267779, 11607.76784464323, 12067.879321206676, 12102.09234307448, 12150.08874334446, 12493.375331233221, 11271.267367621407, 11554.364509952033, 11637.709057273298, 12180.695482613006, 12340.938295308466, 12078.879211207775, 12517.56188533397, 12556.434960426985, 12608.810867837174, 12609.558665446666, 9242.445453272825, 9395.812083758423, 9401.388909720847, 9410.43537387759, 9511.239100871775, 9135.473038811424, 12049.939750301193, 12184.390780460764, 12273.631791046282, 12565.371731413576], "value": 9447.15915798313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1596.696627640748, 1622.8234529965775, 1851.2872544070528, 1894.3937939859234, 1936.2545420013291, 9284.30367722421, 9802.509874506282, 9993.400395976238, 10014.499275036256, 10058.849117263248, 9869.654562090329, 9954.701358959224, 9974.551145198466, 9976.052275033879, 10014.949925250363, 2482.3049546127113, 2491.539065272921, 2492.3519884829893, 2496.712878019033, 2507.285423654259, 2460.8646524441147, 2512.6984761828608, 2519.60946053362, 2529.9374262809665, 2540.6697129373156, 2443.0960544598524, 2474.8886300116537, 2494.064725727852, 2497.6003839385703, 2503.8622875741826, 2422.806175505964, 2424.745401732819, 2431.2706188143575, 2478.281298423455, 2500.3249122736943, 2420.1287536486852, 2431.2827715823873, 2439.865807380593, 2455.9386015349583, 2463.0, 9701.078397552292, 9797.265205109574, 9799.461029643368, 9813.362131461432, 9840.803183936352, 5562.86092847678, 5667.433256674341, 5668.404817494186, 5701.65790052594, 5708.457696518824, 3284.868605255787, 3324.5511855899385, 3368.4273673475323, 3477.3045390921666, 3530.7881527108198, 1174.5477990973452, 1175.2184797109912, 1188.2989036468439, 1223.4005337384706, 1229.237872519044, 14061.226632535207, 14099.295035248197, 14132.0, 14202.502912398017, 14206.57380278583, 4778.641601879873, 4806.543378379049, 4885.5358740920265, 4900.877478063006, 4918.5819205367225, 10841.349519028883, 10914.672559823219, 10924.2899211551, 10964.725881853017, 11016.394098324508, 5407.648502847303, 5493.956148331804, 5494.1758736189095, 5495.313085864267, 5532.170174473861, 4514.480834703985, 4923.335349727812, 5104.872378190501, 5125.820596279113, 5155.226715992556, 4206.20082184384, 4226.4928208615165, 4281.379200016043, 4316.266234740102, 4348.869533913988, 1254.2349167008117, 1256.466001949168, 1258.1633213912828, 1263.279930439659, 1263.91784534005, 968.2109081098882, 991.1921783746224, 1034.7257976636197, 1051.0488008352454, 1073.3291692692067, 6488.253850807123, 6569.901451478232, 6605.108310378134, 6612.0, 6767.695453704497, 481.63395819176975, 484.5517895946236, 488.7898203772412, 491.2827272182582, 509.0429991615813, 4637.1653102441205, 4660.39414876064, 4662.137504561667, 4667.0, 4673.182193116191, 12257.26456412618, 12549.435275412628, 12667.683307917376, 12668.49326026967, 12721.554745584046, 11627.418629068512, 12374.566890158982, 12460.626181214579, 12478.313692746804, 12545.686357841127, 8839.646414143492, 9067.455952642731, 9145.268378529701, 9196.080391960884, 9199.0, 6256.7810126645345, 6332.335104813928, 6402.935970640234, 6428.774992875227, 6562.278149403657, 10768.300060496043, 10861.40262285582, 10865.402402867918, 10942.23404361687, 11041.613543525938, 11058.0, 11441.0, 11520.193586448868, 11680.123990700562, 11732.824007639721, 7920.603969801602, 8395.95802020986, 8454.154584541742, 8632.482051076955, 8658.91341086581, 9165.404248723811, 9208.907910920805, 9211.0, 9302.95348523253, 9309.069093090637, 8271.62777674994, 8662.350323725872, 8669.04640489533, 8757.168069033432, 8776.210141087333, 8259.848760524337, 8273.54495502729, 8315.792105197177, 8317.667293308199, 8364.372672049742, 7438.6652600632015, 7477.4391920605085, 7485.513441626277, 7488.801791713299, 7552.509086909334, 5555.666660000413, 5623.634463759842, 5803.7968671096305, 5823.883522329615, 5850.646658307601, 5695.145728140812, 5722.914156287576, 5725.484706376446, 5752.079667253387, 5888.852778680396], "value": 4944.00514252209, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.75609561116005, 340.06990879943356, 340.79381973905794, 340.93010932758784, 344.66395264617, 5828.883422331556, 5836.328822185439, 5857.711303513225, 5877.794277200299, 5903.675297858616, 5753.913691294634, 5800.332961709394, 5803.071508558632, 5805.738741756621, 5841.824745257649, 4414.315781053926, 4519.751413672247, 4525.932111018337, 4529.139463501941, 4537.3647689323525, 4496.392986946753, 4504.4594648642205, 4507.459104907416, 4513.3455648930885, 4538.387317712116, 4484.618807401374, 4522.932156017662, 4528.20756367636, 4528.50186479487, 4543.454785425737, 4271.67962402821, 4477.417935668374, 4493.393391892118, 4508.165989291975, 4570.634349252068, 3904.4338570907344, 3915.9216815663526, 3928.410738389236, 3951.940720889189, 3952.9011774705573, 5597.804076857331, 5644.8024319148635, 5682.772689092431, 5688.345840228385, 5722.885542289131, 4931.334269873557, 5103.387593488768, 5103.821366252163, 5119.411267704225, 5172.19830926207, 6057.636541807506, 6092.634441933498, 6121.0, 6127.816165514997, 6143.232095988002, 4295.570442955711, 4316.848910288156, 4325.005248792764, 4334.1981733379425, 4339.804708788112, 6116.571839971204, 6168.334549671608, 6384.872302553923, 6391.092053115867, 6425.200943735761, 4474.865754027384, 4506.729596224237, 4518.367428560005, 4526.343680166357, 4540.182767101887, 4568.383268258743, 4597.793099310472, 4627.537246275346, 4632.930506042412, 4639.30410438437, 5009.624278179152, 5226.63413561047, 5251.868703282372, 5253.684778913201, 5258.684478931276, 6108.908366374508, 6113.144159817629, 6117.785877494355, 6158.152554233712, 6187.876242475125, 1578.9842101579068, 1594.2666373468335, 1597.9957679562349, 1602.919854007295, 1615.3457849570943, 999.4003597841237, 1022.6173016870822, 1024.9077583017565, 1028.5577201803146, 1054.641421916552, 5330.760115794798, 5359.544438722674, 5368.664630885499, 5368.7047212403695, 5370.897647235064, 5597.692126933058, 5627.803026894039, 5634.211210430543, 5652.830415087554, 5688.288963879515, 5219.946331396176, 5313.388960269618, 5338.172583249602, 5342.1452567589, 5361.705106219196, 3003.339265361617, 3010.208925689255, 3013.3069394039057, 3013.517837146046, 3020.093971808493, 5534.944650553443, 5769.461436967721, 5844.211031510777, 5856.267966504187, 5890.3815099414805, 5591.496765291062, 5675.829725108253, 5688.9715551422805, 5699.779624512137, 5742.598018138774, 5720.885582288414, 5729.0521222784455, 5802.361740208574, 5840.1239814027385, 5855.3266374367495, 5582.944170558242, 5623.746931388179, 5907.616004959664, 6355.872882542416, 6360.173177486897, 6052.273727152769, 6235.3452887446165, 6252.343503932022, 6280.27776805655, 6340.239171299474, 6478.833809914261, 6565.671716414256, 6603.702833372414, 6605.702743376463, 6621.271660117287, 4477.082198149306, 4478.843240486567, 4492.595666390041, 4496.887577810581, 4535.659825513166, 6244.843878903063, 6377.585456945284, 6387.904181437375, 6393.87212255743, 6464.773732919325, 6137.386261374006, 6138.815835524942, 6156.753729850756, 6175.722092505758, 6211.689415529296, 5929.19159656309, 6170.9074363885475, 6191.349908259748, 6202.162708034538, 6225.719842607185, 5995.520358371407, 5995.940040599538, 6026.216591843032, 6034.370719905689, 6111.166650004891, 6138.723757431016, 6200.627962322275, 6201.441870231701, 6223.066540019034, 6246.375362463899, 5926.881462370815, 6064.484518815773, 6097.512199024156, 6099.237595300588, 6157.96921015392], "value": 4563.424653219113, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.693943952699, 774.3224678406394, 845.5349557743242, 876.8816209811673, 884.3190743127788, 13766.999999999987, 13933.581992540214, 14939.477118300862, 16025.679486410265, 16533.25600347984, 16748.078855662934, 16998.83001169988, 17036.318547258124, 17039.57401064974, 17080.82919170808, 841.7727213652311, 862.9352798540103, 863.0247819963432, 867.6442658509981, 872.5855218771096, 863.4732812984074, 865.2947847504296, 865.8008658008662, 870.2994089757742, 871.7123349294718, 909.708893154191, 910.0489987962562, 911.544227886057, 912.3248795891059, 913.5432283858071, 904.9411788233743, 906.2795077913042, 906.4244204929851, 912.2200518556671, 914.8947870994788, 664.6975626090117, 671.3119052970744, 672.3008071605525, 672.4250765595394, 674.1202730436778, 16517.83482165187, 16525.504234872973, 16565.6686866262, 16583.751243731353, 16585.25366358505, 15593.922030389775, 15789.60525986848, 16029.599260018476, 16109.355625774955, 16284.26720797555, 13349.199048057148, 13367.465301387932, 13423.731525369536, 13590.728185436335, 13647.0, 3944.447777311179, 3955.2880481513316, 3965.5836137205465, 3985.8405663773706, 4034.152827906143, 80687.59656201681, 83396.99999999939, 84322.0, 84414.57792710997, 84520.0, 11032.944835275934, 11206.159538034517, 11242.606508772154, 11362.772744545064, 11526.077913766878, 20527.28154514585, 20545.897270513553, 20550.486237844172, 20605.424321959756, 20749.066292016894, 8658.090900455487, 8676.522791246416, 8805.295576353876, 8913.866292005625, 9013.63945442188, 4825.420949486084, 4943.9258411123865, 4958.42978057528, 5026.2460630904925, 5030.924536131961, 3525.5945566259697, 3614.6927511161844, 3647.215848592565, 3666.6333366663653, 3674.06311390599, 655.6295692933477, 662.6189940784069, 662.68522451835, 665.4510029225908, 676.7834293026283, 768.1435199752236, 806.395203597302, 806.8265322955592, 809.162516795126, 814.2102160903913, 9955.701328960144, 10007.0, 10143.289969702199, 10193.133583645325, 10219.489025548693, 636.5257882877286, 645.2128403347908, 645.6190847399963, 656.6257233376929, 661.9772451562252, 4802.831900883522, 4834.927476087862, 4935.210366341368, 5057.848264551996, 5087.669301495391, 74517.0, 95681.5215923916, 96322.51838740901, 118492.40753796349, 125134.0, 64539.0, 64616.67691661606, 78479.60760196163, 89464.10535894688, 103630.0, 62151.0, 90492.5475372632, 91207.54396227976, 91364.88858001406, 91712.54143729238, 9045.33630990928, 9199.0, 9201.907980920105, 9238.95380523093, 9269.953650231706, 52442.475575245284, 53162.2025669623, 53266.4673353277, 54173.45826541684, 54409.45590544044, 47369.0, 76780.23219767731, 80191.59904200441, 81153.0, 82696.58651706703, 12923.612291631267, 13250.271235082164, 13399.263040532864, 13701.794473083111, 13750.724985500034, 14159.0, 15749.606259843596, 15751.0, 16185.352585896433, 16750.748738769173, 14776.778348324999, 15284.15937123469, 15404.38382464689, 15495.845041549892, 15622.0, 14911.627209319853, 14957.925210374315, 15169.62075948066, 15625.843741562894, 15690.764638530203, 14098.718025639635, 14968.326425311105, 15409.76885346743, 15541.0, 15976.920115399813, 10864.0, 11224.872206148992, 11377.43112844371, 11964.162508624313, 11984.880151198377, 10321.896781032094, 11255.212135150789, 11660.475278612652, 11726.530938762355, 11812.173147879566], "value": 7849.959388003677, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 111.0, 122.0, 112.0, 111.0, 111.0, 113.0, 109.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 150.0, 176.0, 127.0, 158.0, 158.0, 135.0, 182.0, 127.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 162.0, 162.0, 162.0, 161.0, 164.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 78.0, 170.0, 75.0, 76.0, 76.0, 76.0, 159.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 152.0, 85.0, 84.0, 85.0, 133.0, 85.0, 85.0, 155.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0, 116.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 100.0, 98.0, 95.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 54.0, 54.0, 56.0, 57.0, 56.0, 54.0, 53.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 61.0, 60.0, 59.0, 59.0, 59.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 82.0, 77.0, 82.0, 85.0, 81.0, 113.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 125.0, 125.0, 128.0, 118.0, 127.0, 119.0, 118.0, 137.0, 123.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 153.0, 156.0, 156.0, 152.0, 156.0, 157.0, 158.0, 155.0, 161.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 66.0, 62.0, 60.0, 63.0, 62.0, 65.0, 62.0], "value": 62.5, "unit": "score"}]}]} 03:39:48 INFO - Return code: 0 03:39:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:39:48 ERROR - # TBPL SUCCESS # 03:39:48 INFO - Running post-action listener: _resource_record_post_action 03:39:48 INFO - ##### 03:39:48 INFO - ##### Finished run-tests step (success) 03:39:48 INFO - ##### 03:39:48 INFO - Running post-run listener: _resource_record_post_run 03:39:49 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 506560512; Read time: 188; Write time: 386388 03:39:49 INFO - TinderboxPrint: CPU usage
13.4% 03:39:49 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 188 03:39:49 INFO - TinderboxPrint: I/O write bytes / time
506,560,512 / 386,388 03:39:49 INFO - TinderboxPrint: CPU idle
8,213.2 (86.6%) 03:39:49 INFO - TinderboxPrint: CPU user
1,216.6 (12.8%) 03:39:49 INFO - TinderboxPrint: Swap in / out
0 / 0 03:39:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240619520; Read time: 0; Write time: 227900 03:39:49 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 254255104; Read time: 188; Write time: 156892 03:39:49 INFO - Running post-run listener: _upload_blobber_files 03:39:49 INFO - Blob upload gear active. 03:39:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:49 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 03:39:49 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'] 03:39:49 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 03:39:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:50 INFO - (blobuploader) - INFO - Done attempting. 03:39:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:39:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:39:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:54 INFO - (blobuploader) - INFO - Done attempting. 03:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:55 INFO - (blobuploader) - INFO - Done attempting. 03:39:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:55 INFO - Return code: 0 03:39:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/502123ec1220561acc4f476fd4fc0d9a4eccc409b12b63a46f9f39a1b7b41acb8031c52bc288872cb6758bf7b2fe00f18e0fa3ba39b306392e6f592ca1813aba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0cf1d7ee5a68f4cfa52ef6f2422dea168db8cd079451ced957c1d0ac1f506a1ccef5831a277029e0563693454620133096c0615b11a8be45047e89f0fb126e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bff76b517263a07bee55b140108e5c88a15c1b1a4ba0176f5f8673ffa65d9f80e079a91866629d3d378be0874d0ccc04137728659570abf7ceb42641b21324e0"} 03:39:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:55 INFO - Contents: 03:39:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/502123ec1220561acc4f476fd4fc0d9a4eccc409b12b63a46f9f39a1b7b41acb8031c52bc288872cb6758bf7b2fe00f18e0fa3ba39b306392e6f592ca1813aba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0cf1d7ee5a68f4cfa52ef6f2422dea168db8cd079451ced957c1d0ac1f506a1ccef5831a277029e0563693454620133096c0615b11a8be45047e89f0fb126e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bff76b517263a07bee55b140108e5c88a15c1b1a4ba0176f5f8673ffa65d9f80e079a91866629d3d378be0874d0ccc04137728659570abf7ceb42641b21324e0"} 03:39:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:55 INFO - Copying logs to upload dir... 03:39:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.752023 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-29 03:39:55.643644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 03:39:55.646702) ========= 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=6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683 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/502123ec1220561acc4f476fd4fc0d9a4eccc409b12b63a46f9f39a1b7b41acb8031c52bc288872cb6758bf7b2fe00f18e0fa3ba39b306392e6f592ca1813aba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0cf1d7ee5a68f4cfa52ef6f2422dea168db8cd079451ced957c1d0ac1f506a1ccef5831a277029e0563693454620133096c0615b11a8be45047e89f0fb126e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bff76b517263a07bee55b140108e5c88a15c1b1a4ba0176f5f8673ffa65d9f80e079a91866629d3d378be0874d0ccc04137728659570abf7ceb42641b21324e0"} build_url:https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/CbT8zo6aTEaf4HFrerIMYw/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/502123ec1220561acc4f476fd4fc0d9a4eccc409b12b63a46f9f39a1b7b41acb8031c52bc288872cb6758bf7b2fe00f18e0fa3ba39b306392e6f592ca1813aba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0cf1d7ee5a68f4cfa52ef6f2422dea168db8cd079451ced957c1d0ac1f506a1ccef5831a277029e0563693454620133096c0615b11a8be45047e89f0fb126e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bff76b517263a07bee55b140108e5c88a15c1b1a4ba0176f5f8673ffa65d9f80e079a91866629d3d378be0874d0ccc04137728659570abf7ceb42641b21324e0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 03:39:55.672098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:39:55.672451) ========= 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=6dbc10da6d83fee962c624be000001a8-1467195457.102881-1093554683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:39:55.756188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 03:39:55.756517) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 03:39:55.756815) ========= ========= Total master_lag: 0.41 =========